builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1453546692.48 results: success (0) buildid: 20160123004004 builduid: 9e69f8a660d84524b3f293fe393f9841 revision: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.477128) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.477521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.477807) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004946 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.547260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.547532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.659799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.660048) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.727290) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.727548) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.727883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.728152) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 02:58:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1018K=0.01s 2016-01-23 02:58:12 (1018 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.957737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:12.958017) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015477 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.011648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.011952) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 02:58:13,080 truncating revision to first 12 chars 2016-01-23 02:58:13,081 Setting DEBUG logging. 2016-01-23 02:58:13,081 attempt 1/10 2016-01-23 02:58:13,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d4a2eea9d7c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 02:58:13,316 unpacking tar archive at: mozilla-aurora-d4a2eea9d7c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.536626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.536950) ========= echo d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd4a2eea9d7c3d7cef58f62aa560077837e30c0c4'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 program finished with exit code 0 elapsedTime=0.003817 script_repo_revision: 'd4a2eea9d7c3d7cef58f62aa560077837e30c0c4' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.585709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.585983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 02:58:13.605488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 02:58:13.605779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:13 INFO - MultiFileLogger online at 20160123 02:58:13 in /builds/slave/test-pgo 02:58:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:58:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:58:13 INFO - {'append_to_log': False, 02:58:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:58:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:58:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:58:13 INFO - 'branch': 'Mozilla-Aurora', 02:58:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:13 INFO - 'config_files': ('talos/linux_config.py',), 02:58:13 INFO - 'default_actions': ('clobber', 02:58:13 INFO - 'read-buildbot-config', 02:58:13 INFO - 'download-and-extract', 02:58:13 INFO - 'populate-webroot', 02:58:13 INFO - 'create-virtualenv', 02:58:13 INFO - 'install', 02:58:13 INFO - 'run-tests'), 02:58:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:13 INFO - 'download_minidump_stackwalk': True, 02:58:13 INFO - 'download_symbols': 'ondemand', 02:58:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:13 INFO - 'installer_path': 'installer.exe', 02:58:13 INFO - 'log_level': 'info', 02:58:13 INFO - 'log_name': 'talos', 02:58:13 INFO - 'log_to_console': True, 02:58:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:13 INFO - 'opt_config_files': (), 02:58:13 INFO - 'pip_index': False, 02:58:13 INFO - 'sps_profile': False, 02:58:13 INFO - 'sps_profile_interval': 0, 02:58:13 INFO - 'suite': 'dromaeojs', 02:58:13 INFO - 'system_bits': '32', 02:58:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:13 INFO - 'title': 'talos-linux64-ix-033', 02:58:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:13 INFO - 'use_talos_json': True, 02:58:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:58:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:13 INFO - 'work_dir': 'build'} 02:58:13 INFO - ##### 02:58:13 INFO - ##### Running clobber step. 02:58:13 INFO - ##### 02:58:13 INFO - Running pre-action listener: _resource_record_pre_action 02:58:13 INFO - Running main action method: clobber 02:58:13 INFO - rmtree: /builds/slave/test-pgo/build 02:58:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:58:14 INFO - Running post-action listener: _resource_record_post_action 02:58:14 INFO - ##### 02:58:14 INFO - ##### Running read-buildbot-config step. 02:58:14 INFO - ##### 02:58:14 INFO - Running pre-action listener: _resource_record_pre_action 02:58:14 INFO - Running main action method: read_buildbot_config 02:58:14 INFO - Using buildbot properties: 02:58:14 INFO - { 02:58:14 INFO - "properties": { 02:58:14 INFO - "buildnumber": 108, 02:58:14 INFO - "product": "firefox", 02:58:14 INFO - "script_repo_revision": "production", 02:58:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:58:14 INFO - "repository": "", 02:58:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:58:14 INFO - "buildid": "20160123004004", 02:58:14 INFO - "slavename": "talos-linux64-ix-033", 02:58:14 INFO - "stage_platform": "linux64-pgo", 02:58:14 INFO - "basedir": "/builds/slave/test-pgo", 02:58:14 INFO - "nightly_build": "True", 02:58:14 INFO - "project": "", 02:58:14 INFO - "platform": "ubuntu64_hw", 02:58:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:58:14 INFO - "slavebuilddir": "test", 02:58:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:58:14 INFO - "branch": "mozilla-aurora", 02:58:14 INFO - "repo_path": "releases/mozilla-aurora", 02:58:14 INFO - "pgo_build": "True", 02:58:14 INFO - "builduid": "9e69f8a660d84524b3f293fe393f9841", 02:58:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 02:58:14 INFO - }, 02:58:14 INFO - "sourcestamp": { 02:58:14 INFO - "repository": "", 02:58:14 INFO - "hasPatch": false, 02:58:14 INFO - "project": "", 02:58:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:58:14 INFO - "changes": [ 02:58:14 INFO - { 02:58:14 INFO - "category": null, 02:58:14 INFO - "files": [ 02:58:14 INFO - { 02:58:14 INFO - "url": null, 02:58:14 INFO - "name": "https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 02:58:14 INFO - } 02:58:14 INFO - ], 02:58:14 INFO - "repository": "", 02:58:14 INFO - "rev": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4", 02:58:14 INFO - "who": "sendchange", 02:58:14 INFO - "when": 1453546623, 02:58:14 INFO - "number": 7504949, 02:58:14 INFO - "comments": "", 02:58:14 INFO - "project": "", 02:58:14 INFO - "at": "Sat 23 Jan 2016 02:57:03", 02:58:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:58:14 INFO - "revlink": "", 02:58:14 INFO - "properties": [ 02:58:14 INFO - [ 02:58:14 INFO - "buildid", 02:58:14 INFO - "20160123004004", 02:58:14 INFO - "Change" 02:58:14 INFO - ], 02:58:14 INFO - [ 02:58:14 INFO - "builduid", 02:58:14 INFO - "9e69f8a660d84524b3f293fe393f9841", 02:58:14 INFO - "Change" 02:58:14 INFO - ], 02:58:14 INFO - [ 02:58:14 INFO - "nightly_build", 02:58:14 INFO - "True", 02:58:14 INFO - "Change" 02:58:14 INFO - ], 02:58:14 INFO - [ 02:58:14 INFO - "pgo_build", 02:58:14 INFO - "True", 02:58:14 INFO - "Change" 02:58:14 INFO - ] 02:58:14 INFO - ], 02:58:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 02:58:14 INFO - } 02:58:14 INFO - ], 02:58:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 02:58:14 INFO - } 02:58:14 INFO - } 02:58:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 02:58:14 INFO - Running post-action listener: _resource_record_post_action 02:58:14 INFO - ##### 02:58:14 INFO - ##### Running download-and-extract step. 02:58:14 INFO - ##### 02:58:14 INFO - Running pre-action listener: _resource_record_pre_action 02:58:14 INFO - Running main action method: download_and_extract 02:58:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:14 INFO - https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/test_packages.json 02:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/test_packages.json 02:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:58:19 INFO - Downloaded 1302 bytes. 02:58:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:58:19 INFO - Using the following test package requirements: 02:58:19 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:58:19 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:58:19 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'jsshell-linux-x86_64.zip'], 02:58:19 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:58:19 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:58:19 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:58:19 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:58:19 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:58:19 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:58:19 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:58:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:58:19 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:19 INFO - https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:58:23 INFO - Downloaded 23159833 bytes. 02:58:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 02:58:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:58:25 INFO - Return code: 0 02:58:25 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:25 INFO - https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:58:29 INFO - Downloaded 23159833 bytes. 02:58:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 02:58:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:58:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:58:31 INFO - Return code: 0 02:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:31 INFO - https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:58:33 INFO - Downloaded 11132038 bytes. 02:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 02:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:58:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:58:33 INFO - Return code: 0 02:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:33 INFO - https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:58:34 INFO - Downloaded 58013919 bytes. 02:58:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:58:35 INFO - mkdir: /builds/slave/test-pgo/properties 02:58:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:58:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:58:35 INFO - Contents: 02:58:35 INFO - build_url:https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - Running post-action listener: set_extra_try_arguments 02:58:35 INFO - ##### 02:58:35 INFO - ##### Running populate-webroot step. 02:58:35 INFO - ##### 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: populate_webroot 02:58:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:58:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:58:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:58:35 INFO - '--tppagecycles', 02:58:35 INFO - '7'], 02:58:35 INFO - 'tests': ['tsvgm']}}, 02:58:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:58:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:58:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:58:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:58:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'tests': ['damp', 'tps']}, 02:58:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['damp', 'tps']}, 02:58:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:58:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:58:35 INFO - 'other': {'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'other_l64': {'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'other_nol64': {'tests': ['a11yr', 02:58:35 INFO - 'ts_paint', 02:58:35 INFO - 'tpaint', 02:58:35 INFO - 'sessionrestore', 02:58:35 INFO - 'sessionrestore_no_auto_restore']}, 02:58:35 INFO - 'svgr': {'tests': ['tsvgx', 02:58:35 INFO - 'tsvgr_opacity', 02:58:35 INFO - 'tart', 02:58:35 INFO - 'tscrollx', 02:58:35 INFO - 'cart']}, 02:58:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['tsvgx', 02:58:35 INFO - 'tsvgr_opacity', 02:58:35 INFO - 'tart', 02:58:35 INFO - 'tscrollx', 02:58:35 INFO - 'cart']}, 02:58:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'tests': ['tp5o']}, 02:58:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'talos_options': ['--e10s'], 02:58:35 INFO - 'tests': ['tp5o']}, 02:58:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'talos_options': ['--xperf_path', 02:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:35 INFO - 'tests': ['tp5n']}, 02:58:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:35 INFO - 'talos_options': ['--e10s', 02:58:35 INFO - '--xperf_path', 02:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:35 INFO - 'tests': ['tp5n']}}, 02:58:35 INFO - 'talos.zip': {'path': '', 02:58:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - ##### 02:58:35 INFO - ##### Running create-virtualenv step. 02:58:35 INFO - ##### 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: create_virtualenv 02:58:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:58:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 02:58:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:58:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:58:36 INFO - Using real prefix '/usr' 02:58:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:58:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:58:39 INFO - Installing pip.................done. 02:58:39 INFO - Return code: 0 02:58:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:58:39 INFO - Using env: {'DISPLAY': ':0', 02:58:39 INFO - 'HOME': '/home/cltbld', 02:58:39 INFO - 'LANG': 'en_US.UTF-8', 02:58:39 INFO - 'LANGUAGE': 'en_US:en', 02:58:39 INFO - 'LOGNAME': 'cltbld', 02:58:39 INFO - 'MAIL': '/var/mail/cltbld', 02:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:39 INFO - 'MOZ_NO_REMOTE': '1', 02:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:39 INFO - 'NO_EM_RESTART': '1', 02:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:39 INFO - 'SHELL': '/bin/bash', 02:58:39 INFO - 'SHLVL': '1', 02:58:39 INFO - 'TERM': 'linux', 02:58:39 INFO - 'TMOUT': '86400', 02:58:39 INFO - 'USER': 'cltbld', 02:58:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:39 INFO - '_': '/tools/buildbot/bin/python'} 02:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:58:41 INFO - Cleaning up... 02:58:41 INFO - Return code: 0 02:58:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:58:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:58:41 INFO - Using env: {'DISPLAY': ':0', 02:58:41 INFO - 'HOME': '/home/cltbld', 02:58:41 INFO - 'LANG': 'en_US.UTF-8', 02:58:41 INFO - 'LANGUAGE': 'en_US:en', 02:58:41 INFO - 'LOGNAME': 'cltbld', 02:58:41 INFO - 'MAIL': '/var/mail/cltbld', 02:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:41 INFO - 'MOZ_NO_REMOTE': '1', 02:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:41 INFO - 'NO_EM_RESTART': '1', 02:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:41 INFO - 'SHELL': '/bin/bash', 02:58:41 INFO - 'SHLVL': '1', 02:58:41 INFO - 'TERM': 'linux', 02:58:41 INFO - 'TMOUT': '86400', 02:58:41 INFO - 'USER': 'cltbld', 02:58:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:41 INFO - '_': '/tools/buildbot/bin/python'} 02:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:41 INFO - Downloading/unpacking psutil>=0.7.1 02:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:43 INFO - Installing collected packages: psutil 02:58:43 INFO - Running setup.py install for psutil 02:58:43 INFO - building 'psutil._psutil_linux' extension 02:58:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:58:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:58:44 INFO - building 'psutil._psutil_posix' extension 02:58:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:58:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:58:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:44 INFO - Successfully installed psutil 02:58:44 INFO - Cleaning up... 02:58:44 INFO - Return code: 0 02:58:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 02:58:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:58:44 INFO - Using env: {'DISPLAY': ':0', 02:58:44 INFO - 'HOME': '/home/cltbld', 02:58:44 INFO - 'LANG': 'en_US.UTF-8', 02:58:44 INFO - 'LANGUAGE': 'en_US:en', 02:58:44 INFO - 'LOGNAME': 'cltbld', 02:58:44 INFO - 'MAIL': '/var/mail/cltbld', 02:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:44 INFO - 'MOZ_NO_REMOTE': '1', 02:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:44 INFO - 'NO_EM_RESTART': '1', 02:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:44 INFO - 'SHELL': '/bin/bash', 02:58:44 INFO - 'SHLVL': '1', 02:58:44 INFO - 'TERM': 'linux', 02:58:44 INFO - 'TMOUT': '86400', 02:58:44 INFO - 'USER': 'cltbld', 02:58:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:44 INFO - '_': '/tools/buildbot/bin/python'} 02:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:58:46 INFO - Installing collected packages: mozsystemmonitor 02:58:46 INFO - Running setup.py install for mozsystemmonitor 02:58:47 INFO - Successfully installed mozsystemmonitor 02:58:47 INFO - Cleaning up... 02:58:47 INFO - Return code: 0 02:58:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 02:58:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:47 INFO - Using env: {'DISPLAY': ':0', 02:58:47 INFO - 'HOME': '/home/cltbld', 02:58:47 INFO - 'LANG': 'en_US.UTF-8', 02:58:47 INFO - 'LANGUAGE': 'en_US:en', 02:58:47 INFO - 'LOGNAME': 'cltbld', 02:58:47 INFO - 'MAIL': '/var/mail/cltbld', 02:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:47 INFO - 'MOZ_NO_REMOTE': '1', 02:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:47 INFO - 'NO_EM_RESTART': '1', 02:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:47 INFO - 'SHELL': '/bin/bash', 02:58:47 INFO - 'SHLVL': '1', 02:58:47 INFO - 'TERM': 'linux', 02:58:47 INFO - 'TMOUT': '86400', 02:58:47 INFO - 'USER': 'cltbld', 02:58:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:47 INFO - '_': '/tools/buildbot/bin/python'} 02:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:58:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:49 INFO - Downloading docopt-0.6.1.tar.gz 02:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:49 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:49 INFO - Running setup.py install for blobuploader 02:58:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:58:49 INFO - Running setup.py install for requests 02:58:50 INFO - Running setup.py install for docopt 02:58:50 INFO - Successfully installed blobuploader requests docopt 02:58:50 INFO - Cleaning up... 02:58:50 INFO - Return code: 0 02:58:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 02:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:58:50 INFO - Using env: {'DISPLAY': ':0', 02:58:50 INFO - 'HOME': '/home/cltbld', 02:58:50 INFO - 'LANG': 'en_US.UTF-8', 02:58:50 INFO - 'LANGUAGE': 'en_US:en', 02:58:50 INFO - 'LOGNAME': 'cltbld', 02:58:50 INFO - 'MAIL': '/var/mail/cltbld', 02:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:50 INFO - 'MOZ_NO_REMOTE': '1', 02:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:50 INFO - 'NO_EM_RESTART': '1', 02:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:50 INFO - 'SHELL': '/bin/bash', 02:58:50 INFO - 'SHLVL': '1', 02:58:50 INFO - 'TERM': 'linux', 02:58:50 INFO - 'TMOUT': '86400', 02:58:50 INFO - 'USER': 'cltbld', 02:58:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:50 INFO - '_': '/tools/buildbot/bin/python'} 02:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:58:50 INFO - Running setup.py (path:/tmp/pip-SZ1C7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:58:50 INFO - Running setup.py (path:/tmp/pip-14CfWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:58:50 INFO - Running setup.py (path:/tmp/pip-Cv7TER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:58:50 INFO - Running setup.py (path:/tmp/pip-f5UlYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:58:50 INFO - Running setup.py (path:/tmp/pip-361bel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:58:50 INFO - Running setup.py (path:/tmp/pip-FeEkeo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:58:51 INFO - Running setup.py (path:/tmp/pip-btqg_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:58:51 INFO - Running setup.py (path:/tmp/pip-arW_LW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:58:51 INFO - Running setup.py (path:/tmp/pip-BEOsPt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:58:51 INFO - Running setup.py (path:/tmp/pip-omVPgF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:58:51 INFO - Running setup.py (path:/tmp/pip-bUn8l0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:58:51 INFO - Running setup.py (path:/tmp/pip-l0mXgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:58:51 INFO - Running setup.py (path:/tmp/pip-XMHrxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:58:51 INFO - Running setup.py (path:/tmp/pip-5jS74_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:58:51 INFO - Running setup.py (path:/tmp/pip-nz87vk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:58:51 INFO - Running setup.py (path:/tmp/pip-1EkmrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:58:51 INFO - Running setup.py (path:/tmp/pip-4fTiZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:58:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:51 INFO - Running setup.py install for manifestparser 02:58:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:58:51 INFO - Running setup.py install for mozcrash 02:58:51 INFO - Running setup.py install for mozdebug 02:58:52 INFO - Running setup.py install for mozdevice 02:58:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for mozfile 02:58:52 INFO - Running setup.py install for mozhttpd 02:58:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for mozinfo 02:58:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for mozInstall 02:58:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for mozleak 02:58:52 INFO - Running setup.py install for mozlog 02:58:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for moznetwork 02:58:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:58:52 INFO - Running setup.py install for mozprocess 02:58:53 INFO - Running setup.py install for mozprofile 02:58:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:58:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:58:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:58:53 INFO - Running setup.py install for mozrunner 02:58:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:58:53 INFO - Running setup.py install for mozscreenshot 02:58:53 INFO - Running setup.py install for moztest 02:58:53 INFO - Running setup.py install for mozversion 02:58:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:58:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:53 INFO - Cleaning up... 02:58:53 INFO - Return code: 0 02:58:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 02:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:58:53 INFO - Using env: {'DISPLAY': ':0', 02:58:53 INFO - 'HOME': '/home/cltbld', 02:58:53 INFO - 'LANG': 'en_US.UTF-8', 02:58:53 INFO - 'LANGUAGE': 'en_US:en', 02:58:53 INFO - 'LOGNAME': 'cltbld', 02:58:53 INFO - 'MAIL': '/var/mail/cltbld', 02:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:53 INFO - 'MOZ_NO_REMOTE': '1', 02:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:53 INFO - 'NO_EM_RESTART': '1', 02:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:53 INFO - 'SHELL': '/bin/bash', 02:58:53 INFO - 'SHLVL': '1', 02:58:53 INFO - 'TERM': 'linux', 02:58:53 INFO - 'TMOUT': '86400', 02:58:53 INFO - 'USER': 'cltbld', 02:58:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:53 INFO - '_': '/tools/buildbot/bin/python'} 02:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:58:53 INFO - Running setup.py (path:/tmp/pip-qfIJ4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 02:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:58:53 INFO - Running setup.py (path:/tmp/pip-QHdBnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:58:53 INFO - Running setup.py (path:/tmp/pip-rgkXXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:58:54 INFO - Running setup.py (path:/tmp/pip-R6lHoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:58:54 INFO - Running setup.py (path:/tmp/pip-lvyL1C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:58:54 INFO - Running setup.py (path:/tmp/pip-MJKqL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:58:54 INFO - Running setup.py (path:/tmp/pip-4CmI9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:58:54 INFO - Running setup.py (path:/tmp/pip-gQk1Im-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:58:54 INFO - Running setup.py (path:/tmp/pip-x_MRcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:58:54 INFO - Running setup.py (path:/tmp/pip-Z1nTxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:58:54 INFO - Running setup.py (path:/tmp/pip-CdJJs4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:58:54 INFO - Running setup.py (path:/tmp/pip-fIdz6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:58:54 INFO - Running setup.py (path:/tmp/pip-hRfCix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:58:54 INFO - Running setup.py (path:/tmp/pip-5194Ce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:58:54 INFO - Running setup.py (path:/tmp/pip-6hXfff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:58:54 INFO - Running setup.py (path:/tmp/pip-rm_Px4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 02:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:58:54 INFO - Running setup.py (path:/tmp/pip-KwH4Pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:58:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:56 INFO - Downloading blessings-1.6.tar.gz 02:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:56 INFO - Installing collected packages: blessings 02:58:56 INFO - Running setup.py install for blessings 02:58:57 INFO - Successfully installed blessings 02:58:57 INFO - Cleaning up... 02:58:57 INFO - Return code: 0 02:58:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:58:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:58:57 INFO - Reading from file tmpfile_stdout 02:58:57 INFO - Current package versions: 02:58:57 INFO - argparse == 1.2.1 02:58:57 INFO - blessings == 1.6 02:58:57 INFO - blobuploader == 1.2.4 02:58:57 INFO - docopt == 0.6.1 02:58:57 INFO - manifestparser == 1.1 02:58:57 INFO - mozInstall == 1.12 02:58:57 INFO - mozcrash == 0.16 02:58:57 INFO - mozdebug == 0.1 02:58:57 INFO - mozdevice == 0.47 02:58:57 INFO - mozfile == 1.2 02:58:57 INFO - mozhttpd == 0.7 02:58:57 INFO - mozinfo == 0.9 02:58:57 INFO - mozleak == 0.1 02:58:57 INFO - mozlog == 3.1 02:58:57 INFO - moznetwork == 0.27 02:58:57 INFO - mozprocess == 0.22 02:58:57 INFO - mozprofile == 0.27 02:58:57 INFO - mozrunner == 6.11 02:58:57 INFO - mozscreenshot == 0.1 02:58:57 INFO - mozsystemmonitor == 0.0 02:58:57 INFO - moztest == 0.7 02:58:57 INFO - mozversion == 1.4 02:58:57 INFO - psutil == 3.1.1 02:58:57 INFO - requests == 1.2.3 02:58:57 INFO - wsgiref == 0.1.2 02:58:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 02:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:58:57 INFO - Using env: {'DISPLAY': ':0', 02:58:57 INFO - 'HOME': '/home/cltbld', 02:58:57 INFO - 'LANG': 'en_US.UTF-8', 02:58:57 INFO - 'LANGUAGE': 'en_US:en', 02:58:57 INFO - 'LOGNAME': 'cltbld', 02:58:57 INFO - 'MAIL': '/var/mail/cltbld', 02:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:57 INFO - 'MOZ_NO_REMOTE': '1', 02:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:57 INFO - 'NO_EM_RESTART': '1', 02:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:57 INFO - 'SHELL': '/bin/bash', 02:58:57 INFO - 'SHLVL': '1', 02:58:57 INFO - 'TERM': 'linux', 02:58:57 INFO - 'TMOUT': '86400', 02:58:57 INFO - 'USER': 'cltbld', 02:58:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:57 INFO - '_': '/tools/buildbot/bin/python'} 02:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 02:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:58:57 INFO - Cleaning up... 02:58:57 INFO - Return code: 0 02:58:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 02:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:58:57 INFO - Using env: {'DISPLAY': ':0', 02:58:57 INFO - 'HOME': '/home/cltbld', 02:58:57 INFO - 'LANG': 'en_US.UTF-8', 02:58:57 INFO - 'LANGUAGE': 'en_US:en', 02:58:57 INFO - 'LOGNAME': 'cltbld', 02:58:57 INFO - 'MAIL': '/var/mail/cltbld', 02:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:57 INFO - 'MOZ_NO_REMOTE': '1', 02:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:57 INFO - 'NO_EM_RESTART': '1', 02:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:57 INFO - 'SHELL': '/bin/bash', 02:58:57 INFO - 'SHLVL': '1', 02:58:57 INFO - 'TERM': 'linux', 02:58:57 INFO - 'TMOUT': '86400', 02:58:57 INFO - 'USER': 'cltbld', 02:58:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:57 INFO - '_': '/tools/buildbot/bin/python'} 02:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:57 INFO - Downloading/unpacking jsonschema 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:59 INFO - Downloading/unpacking functools32 (from jsonschema) 02:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:59 INFO - warning: no files found matching '*.txt' 02:58:59 INFO - no previously-included directories found matching 'build' 02:58:59 INFO - no previously-included directories found matching 'dist' 02:58:59 INFO - no previously-included directories found matching '.git*' 02:58:59 INFO - Installing collected packages: jsonschema, functools32 02:58:59 INFO - Running setup.py install for functools32 02:58:59 INFO - warning: no files found matching '*.txt' 02:58:59 INFO - no previously-included directories found matching 'build' 02:58:59 INFO - no previously-included directories found matching 'dist' 02:58:59 INFO - no previously-included directories found matching '.git*' 02:58:59 INFO - Successfully installed jsonschema functools32 02:58:59 INFO - Cleaning up... 02:58:59 INFO - Return code: 0 02:58:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc47356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:58:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:58:59 INFO - Using env: {'DISPLAY': ':0', 02:58:59 INFO - 'HOME': '/home/cltbld', 02:58:59 INFO - 'LANG': 'en_US.UTF-8', 02:58:59 INFO - 'LANGUAGE': 'en_US:en', 02:58:59 INFO - 'LOGNAME': 'cltbld', 02:58:59 INFO - 'MAIL': '/var/mail/cltbld', 02:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:59 INFO - 'MOZ_NO_REMOTE': '1', 02:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:59 INFO - 'NO_EM_RESTART': '1', 02:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 02:58:59 INFO - 'SHELL': '/bin/bash', 02:58:59 INFO - 'SHLVL': '1', 02:58:59 INFO - 'TERM': 'linux', 02:58:59 INFO - 'TMOUT': '86400', 02:58:59 INFO - 'USER': 'cltbld', 02:58:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:59 INFO - '_': '/tools/buildbot/bin/python'} 02:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:00 INFO - Downloading/unpacking flake8 02:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:59:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:59:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:59:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:02 INFO - no previously-included directories found matching 'docs/_build' 02:59:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:59:02 INFO - Running setup.py install for pep8 02:59:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:02 INFO - no previously-included directories found matching 'docs/_build' 02:59:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:59:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:59:02 INFO - Cleaning up... 02:59:02 INFO - Return code: 0 02:59:02 INFO - Running post-action listener: _resource_record_post_action 02:59:02 INFO - Running post-action listener: _start_resource_monitoring 02:59:02 INFO - Starting resource monitoring. 02:59:02 INFO - ##### 02:59:02 INFO - ##### Running install step. 02:59:02 INFO - ##### 02:59:02 INFO - Running pre-action listener: _resource_record_pre_action 02:59:02 INFO - Running main action method: install 02:59:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:59:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:59:03 INFO - Reading from file tmpfile_stdout 02:59:03 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:59:03 INFO - Reading from file tmpfile_stdout 02:59:03 INFO - Output received: 02:59:03 INFO - Usage: mozinstall [options] installer 02:59:03 INFO - Options: 02:59:03 INFO - -h, --help show this help message and exit 02:59:03 INFO - -d DEST, --destination=DEST 02:59:03 INFO - Directory to install application into. [default: 02:59:03 INFO - "/builds/slave/test-pgo"] 02:59:03 INFO - --app=APP Application being installed. [default: firefox] 02:59:03 INFO - mkdir: /builds/slave/test-pgo/build/application 02:59:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:59:17 INFO - Reading from file tmpfile_stdout 02:59:17 INFO - Output received: 02:59:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:59:17 INFO - Running post-action listener: _resource_record_post_action 02:59:17 INFO - ##### 02:59:17 INFO - ##### Running run-tests step. 02:59:17 INFO - ##### 02:59:17 INFO - Running pre-action listener: _resource_record_pre_action 02:59:17 INFO - Running main action method: run_tests 02:59:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:59:17 INFO - Python 2.7.3 02:59:17 INFO - Return code: 0 02:59:17 INFO - grabbing minidump binary from tooltool 02:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2350>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be36e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:59:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 02:59:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:59:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:17 INFO - Return code: 0 02:59:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:59:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:59:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:59:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:59:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:59:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:59:18 INFO - Return code: 0 02:59:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:59:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 02:59:18 INFO - Using env: {'DISPLAY': ':0', 02:59:18 INFO - 'HOME': '/home/cltbld', 02:59:18 INFO - 'LANG': 'en_US.UTF-8', 02:59:18 INFO - 'LANGUAGE': 'en_US:en', 02:59:18 INFO - 'LOGNAME': 'cltbld', 02:59:18 INFO - 'MAIL': '/var/mail/cltbld', 02:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:18 INFO - 'MOZ_NO_REMOTE': '1', 02:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:18 INFO - 'NO_EM_RESTART': '1', 02:59:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:59:18 INFO - 'SHELL': '/bin/bash', 02:59:18 INFO - 'SHLVL': '1', 02:59:18 INFO - 'TERM': 'linux', 02:59:18 INFO - 'TMOUT': '86400', 02:59:18 INFO - 'USER': 'cltbld', 02:59:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712', 02:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:18 INFO - '_': '/tools/buildbot/bin/python'} 02:59:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 02:59:19 INFO - mozversion INFO | application_buildid: 20160123004004 02:59:19 INFO - mozversion INFO | application_changeset: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 02:59:19 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:59:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:19 INFO - mozversion INFO | application_name: Firefox 02:59:19 INFO - mozversion INFO | application_remotingname: firefox-dev 02:59:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:59:19 INFO - mozversion INFO | application_vendor: Mozilla 02:59:19 INFO - mozversion INFO | application_version: 45.0a2 02:59:19 INFO - mozversion INFO | platform_buildid: 20160123004004 02:59:19 INFO - mozversion INFO | platform_changeset: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 02:59:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:59:19 INFO - mozversion INFO | platform_version: 45.0a2 02:59:19 INFO - 2016-01-23 02:59:19,307 DEBUG : using testdate: 1453546759 02:59:19 INFO - 2016-01-23 02:59:19,307 DEBUG : actual date: 1453546759 02:59:19 INFO - 2016-01-23 02:59:19,315 INFO : starting webserver on 'localhost:56232' 02:59:19 INFO - 2016-01-23 02:59:19,315 INFO : Starting test suite talos-linux64-ix-033 02:59:19 INFO - 2016-01-23 02:59:19,315 INFO : Starting test dromaeo_css 02:59:19 INFO - 2016-01-23 02:59:19,315 DEBUG : operating with platform_type : linux_ 02:59:19 INFO - 2016-01-23 02:59:19,316 INFO : Initialising browser for dromaeo_css test... 02:59:19 INFO - 2016-01-23 02:59:19,332 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ0NUA8/profile http://localhost:56232/getInfo.html 02:59:25 INFO - 2016-01-23 02:59:25,282 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:59:25 INFO - 2016-01-23 02:59:25,282 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:59:25 INFO - 2016-01-23 02:59:25,282 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:59:25 INFO - 2016-01-23 02:59:25,282 DEBUG : BROWSER_OUTPUT: __metrics 02:59:25 INFO - 2016-01-23 02:59:25,531 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:27 INFO - 2016-01-23 02:59:27,452 INFO : Browser initialized. 02:59:27 INFO - 2016-01-23 02:59:27,452 INFO : Running cycle 1/1 for dromaeo_css test... 02:59:27 INFO - 2016-01-23 02:59:27,453 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ0NUA8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:59:40 INFO - 2016-01-23 02:59:40,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 137859072 02:59:40 INFO - 2016-01-23 02:59:40,156 DEBUG : BROWSER_OUTPUT: 03:00:30 INFO - 2016-01-23 03:00:30,155 DEBUG : BROWSER_OUTPUT: 1453546830154 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:02:40 INFO - 2016-01-23 03:02:40,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56232/tests/dromaeo/cssquery-ext.html) 03:02:41 INFO - 2016-01-23 03:02:41,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 242819072 03:02:41 INFO - 2016-01-23 03:02:41,058 DEBUG : BROWSER_OUTPUT: 03:05:43 INFO - 2016-01-23 03:05:43,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-ext.html (next: http://localhost:56232/tests/dromaeo/cssquery-jquery.html) 03:05:43 INFO - 2016-01-23 03:05:43,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 230531072 03:05:43 INFO - 2016-01-23 03:05:43,856 DEBUG : BROWSER_OUTPUT: 03:08:45 INFO - 2016-01-23 03:08:45,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56232/tests/dromaeo/cssquery-mootools.html) 03:08:46 INFO - 2016-01-23 03:08:46,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 221351936 03:08:46 INFO - 2016-01-23 03:08:46,300 DEBUG : BROWSER_OUTPUT: 03:11:48 INFO - 2016-01-23 03:11:48,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56232/tests/dromaeo/cssquery-prototype.html) 03:11:48 INFO - 2016-01-23 03:11:48,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 205283328 03:11:48 INFO - 2016-01-23 03:11:48,655 DEBUG : BROWSER_OUTPUT: 03:14:51 INFO - 2016-01-23 03:14:51,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56232/tests/dromaeo/cssquery-yui.html) 03:14:51 INFO - 2016-01-23 03:14:51,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 208281600 03:14:51 INFO - 2016-01-23 03:14:51,611 DEBUG : BROWSER_OUTPUT: 03:17:53 INFO - 2016-01-23 03:17:53,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/dromaeo/cssquery-yui.html (next: http://localhost:56232/tests/dromaeo/cssquery-dojo.html) 03:17:54 INFO - 2016-01-23 03:17:54,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 250650624 03:17:54 INFO - 2016-01-23 03:17:54,053 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,053 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:17:54 INFO - 2016-01-23 03:17:54,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:17:54 INFO - 2016-01-23 03:17:54,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:17:54 INFO - 2016-01-23 03:17:54,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:17:54 INFO - 2016-01-23 03:17:54,055 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3282.2614911644873;3368.6294507604175;3387.7628566000376;3392.5250464934898;3424.092615456904;5493.533049690776;5540.307461567304;5550.361708403535;5560.332760068787;5581.49766521013;5547.11246200608;5588.441155884409;5589.552835773138;5598.832035038945;5616.52259557937;4971.577415919651;5067.163917953533;5111.361079865017;5137.845864624067;5141.76862041209;4919.188333924898;5030.647854650176;5051.191809310511;5097.7960881564695;5107.693538387709;5064.037832811754;5070.163423035195;5084.262781896623;5138.152204886189;5146.099432599299;5140.100482415581;5176.663516871391;5185.637005409623;5190.792368305282;5226.947730522684;4881.95118048822;4910.926336104962;5084.516970887797;5087.694738315713;5158.303629010074;5019.924701129486;5291.1798671206025;5367.892642147174;5477.698726570037;5499.945000549983;5855.473007429309;5902.852428689274;5907.645541267495;5909.290885093773;5918.704064796786;5871.1193321001765;5954.404559544054;5960.105984102376;5961.791337303217;5962.165296858443;5432.619716619838;5451.809186678487;5526.723663816833;5531.751071201806;5535.667859928417;5879.676617785977;6120.938790612126;6175.104609831549;6182;6191.876162476725;5931;5977.073553599199;6000.849978750566;6003.369646187175;6004.639721616717;5726.742296596663;5733.655980641091;5789.88420231593;5822.1266809978;5856.502197313276;5805.796797112081;5850.882982340329;5854.941450585525;5861.589688721834;5863.560232982543;5632.436756324417;5848.3274423441;5855.151003104526;5866.354700982888;5869.325027621793;4492.146492166478;4546.340780586796;4573.291139873325;4582.633389328846;4607.424071991001;4113.4858142732155;4146.937795933063;4149.605787450188;4164.229617520768;4172.520160181557;5401.5948803839865;5524.613277070647;5681.829545113653;5694.174344720075;5704.543636509069;5877.52979761618;5951.345352011275;5958.433948774859;5992.43071908168;6026.397360263939;5612.074007788669;5619.971900140473;5626.690532020778;5692.060809966392;5699.800506982236;5047.899042019139;5088.796448142107;5220.216967454836;5235.0576896159055;5246.527812496894;6121.96939015311;6123.387661233841;6126.326104128542;6136.969315153396;6200.844978875474;5932.080527518242;5935.465808077293;5936.554758393224;5942.346341902474;5996.610220335664;5927.673977931255;6033.758649653964;6056.121862329849;6117.999999999822;6140.5701600887505;5757;5946.464818166386;5952.642841429355;5961.880762384815;5971.402859713994;5965.880682386415;6033.879322413615;6037.547183961308;6043.54673399488;6044.57687961856;5644.209810626434;5656.208130861601;5730.5129064030025;5735.770569177186;5762.2221000164445;5724.255846739898;5871.295444546511;5917.289925209003;5917.556183286185;5918.615290006136;5555.2222688822785;5766.4233576642;5792;5794.82615521535;5796.9420305798085;5633.605647604629;5704.657720536781;5718.142278658234;5746.138079287973;5840.883182336244;5724.942750572608;5785.190073389645;5810.82567522975;5812.476877081083;5814.30228372598 03:17:54 INFO - 2016-01-23 03:17:54,055 DEBUG : BROWSER_OUTPUT: |1;ext.html;629.134939458245;629.9637096975479;636.0459311033447;639.1180171363518;645.8062581225632;32591;43021.56978430215;43482;43558.34662480065;43627.90930226742;46949.53050469494;47403.0519389612;47411.28883066757;47472;47492.28761568579;7980.4812687175145;8045.798855028613;9101.63593456261;9279.582418791171;9288.58201380936;10750.78498430031;10978.780424391507;10994;11003.449827508593;11061.778764424707;10702.785944281148;10840.295380800262;10840.837387439195;10878.782424351508;10882.347059176474;8402.495850248943;8566.3146948244;10718.839217411745;10797.946010269978;10960.945195274053;10625.628103016435;10772.299800512941;10774;10777.515011824487;10792.136629069733;43278;43663.345049824275;43773.562264377266;43776.56223437789;43796.3430548542;3756.981215093934;3774.622537746231;3842.289176502356;3859.1702783901596;3944.960550394488;32927.341453171044;32998;33822.83088584566;33908.83045584781;34189.31621367583;3512.3326567952263;3549;3591.7665351752053;3596.7662101963288;3667.2665466906724;289113;295511.5224423886;297038;297410.0776976694;298220;64346.35653643497;66241.66879165573;73279.63360183165;74217.25782742212;81431;77315.22684773081;77370;77933.61033194797;78020;78048;18766.718499222523;19003.42989710311;19004.524886877938;19006.334778282693;19043.714344284846;14354.138751674724;14496.492622758153;14540.927295363455;14553.19957402353;14565.85434145645;23823.166189183296;23983.28050158498;24006;24120.276391708278;24153.15463958753;9033.277337812959;9268.490233037113;9358.298127640453;9444.197243234265;9447.433154010781;1040.2094408249634;1105.6461932181785;1134.9773004539863;1140.823172408278;1245.6698974771693;30602.23494412613;31013.8449307752;31439.685603144135;35241.118972025906;35525.82237088798;1138.408027825526;1160.6866146140494;1163.6450882480924;1202.290648517379;1229.6679896428093;14815.92592037033;15748.842511574967;18086.5478363042;18590.349337773383;18746.718799218022;422566;426938;428100;428201;429140;62231;62763.372366275755;62768;62777.68611156915;62873;1521.0645453046297;1526.9083854968737;1537.262114185175;1542.0516382424728;1542.4524293875513;31857.203569910936;35912.64087359093;36014;36102.8194859024;36205.45691814572;53716.19425708539;54855.451445485036;54897.45102548923;54900;54910.17634735562;307708;308612;310782;311569;311649;46385.76807115943;47181;47513.52486475091;47518.5248147528;48010.27984580304;51691.22463163131;51787.48212517826;51832.740836295576;51987.74006129945;52014.95970080502;41316;42387;42889;43777.34333984929;44185.779071104436;40836.59163408328;44038.119237614424;44053;44264;44909.10181796411;39832.80083599564;40030;40395;40698.1860362797;41314;35501.644983549835;37496.6250337504;37679.81160094182;40473.39289910595;40537.1892562153;27545;28033.859830700716;28048;28183.43633127367;28183.43633127367 03:17:54 INFO - 2016-01-23 03:17:54,057 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.5943313772005;368.16059384603113;368.8708951866847;370.30752492838394;370.4128955605365;10636.095931845783;10892.183086268522;12288.938555307222;12548.937255313733;18017.54956126096;17852.10739463025;18914;19025.33411330604;19462.1242044108;19465.61068778627;4702.506236845134;6308.369163083701;6429.517786166033;6452.064450654652;6453.580517266362;4750.358701575277;6917.100776898996;7061.4703897207655;7103.396211322044;7104.964475177617;6881.8967715484305;7000.369966702996;7012.193597736275;7026.648667566601;7031.50779445439;6867.07294515239;6971.79084627462;7030.226675065739;7052.858942821166;7056.964715176417;6820.215675197316;6837.726490940357;6840.794776156723;6845.418139458152;6847.828804279933;24610.753892461205;25150.80094275557;25251.494970100677;25344.239672809847;25609.35976600581;2369.4194922243987;2471.9011239550396;2505.235903049569;2572.511222867649;2585.0693750249893;14971.101733896001;15180.240987950669;15365.308561114776;15570.14364209968;15619.609509762233;2104.7474303083577;2115.7989990950837;2134.359692092366;2161.2867753641417;2187.1688758271753;63313.68343158255;65218.3478165217;65539.67230163867;71700.28299716988;71849;16466.42367517131;16608.169591520375;16659;16677;16692;26372.60441093385;26376.47247055048;26642.86678566595;26700.332491687863;26744.19767406981;10015.098641122187;10150.695479135638;10175.389476631277;10220.386776793417;10236.744081397876;8772.824543509221;8815.735527934172;8847.42491738035;8853.247473964657;8865.734027979172;7120.734044406538;7933;8055.315298199719;8279.751607451786;8283.37874659403;3120.859561319701;3127.3119913618966;3215.42122417967;3249.78876373035;3336.099253201622;415.3582714705787;432.19827220506136;796.1998191817187;907.1065000974036;923.3029063057348;10259.17926565873;10445.738856528496;10511.1591072714;10791.6222932197;10880.401577913291;419.2014212924384;443.4656239231718;448.6590191454518;449.3955629678078;455.9840405585855;6320.62076275425;6396.0725694774;10116.949415253024;10347.120494757879;10845.728856778644;446670;448843;449476;456012;696400;85183;88235.55882220676;90194;90685;91120.54439727758;1187.8158885372782;1204.9277043377426;1209.1294268126935;1213.8239955206445;1217.5190799634095;15647.452339168074;16092.436764713178;16313.59216019609;16430.507084787474;16536.173191340145;35011.82494087513;35022.29955400929;35225.64774352326;35823.28353432865;36194;47112.29331560098;48030.519694804;49172.508274918226;49242.50757492523;49606.25590616072;10535.894641053797;10585;10674.839877402;10784.299020563638;10911.563537458413;18044.90977545104;18305.725414119064;19016.429507114808;19257.22971081141;19462.61074778525;15062.397504100152;15482.767758483857;15879.12664803447;15971.121588312755;16442.34230630809;10698.897319777177;14874.181919994504;15056.623584410478;15117.319720612379;15708.293126809092;16429.753553696944;16674;16774.32902683879;16949.74575381395;17091.48725538236;10341;10437.112845408225;10465.529051192867;10506.369617822955;10562.31344962575;13407.731845363232;14904.478343257933;15702.528924132293;15719;16161.191940403169 03:17:54 INFO - 2016-01-23 03:17:54,058 DEBUG : BROWSER_OUTPUT: |3;mootools.html;908.7909780750423;1548.3574316658587;1596.201899050475;1799.752583901991;1903.9143238554273;7079.6814143363545;7668.61656917154;7979.680812767482;8002.879956800638;8003.479773814698;7830.41271904608;7846.136924938252;7850.842983140334;7914.169012253717;7920.801979950504;2049.0881557706825;2066.0392917293457;2083.5520363121927;2086.3636590839787;2093.5289559849066;2308.9191878284178;2372.489914668346;2375.133076427109;2375.4536456614987;2376.2039716694926;2277.077783497686;2301.551197516485;2324.662923876037;2326.081197926818;2327.5228578141523;2307.1463558483383;2345.3784747042046;2385.0698227691214;2389.4504264019197;2397.7482364351754;2368.7631236876346;2369.6919400478;2410.8071354291615;2412.19191570824;2412.421018955438;7978.561179135145;8064.435489515737;8078.0306363236205;8078.667019941761;8084.191580841927;4735.668503204777;4865.635077369176;4866.31871537985;4869.220924652039;4874.366332376769;3108.145260053481;3110.3934732727125;3112.7354174894936;3159.41550813098;3170.096522491102;1009.4498498318434;1020.4387586827215;1026.9948650256777;1055.024102704995;1081.8972197641212;11013.889861101366;11075.058620017307;11084.279521831055;11104.222704410695;11135.276207046598;4338.002259480337;4357.150355680676;4376.037271800199;4409.845655402046;4417.138657961731;9498.382605130644;9499.050094990445;9535.189508891683;9537.666181683608;9539.904600953902;4790.592799612003;4817.710937343701;4852.733099679481;4861.27080937855;4861.562459378673;4393;4412.646988240933;4441.244988351988;4464.53122422141;4481.977590112028;3505.106197919514;3548.8225588720975;3552.946705799415;3610.2779444111284;3882.7087968402484;1184.9289042657467;1209.5524655877382;1227.9562371983743;1237.8178839208533;1266.9104570069733;1158.3183593459883;1174.6065068202247;1219.3415555599877;1436.4756863744658;1454.0621299261916;7565.583892885834;7568.962155189299;7610.771676849703;7612.885806712904;7695.115061767857;1169.05306701572;1169.7952858249773;1191.106669997502;1213.071999920062;1230.7046308885804;6016.127661489059;6073.39266073398;6075.149479072933;6075.2405949256345;6079.08813677943;9258.67594634198;9613.615455381707;9729.902700973042;9745.269104817167;9747.171490423394;9617.134457898823;9656.034396560288;9663.420194788336;9669.661561845302;9669.951650241705;7463.440241981873;7651.311381975537;7652.846943061108;7659.655315510815;7748.922510774933;7373.5575865448245;7448.9627551861895;7476.738314158978;7481.7755467336065;7486.925130748623;8576.099509551657;8660.610272537877;8713.956430217808;8816.426932249384;8822.161894620258;8741.431806932529;8767.912320876709;8803.075677053817;8998.910010900068;9076.09239076087;7204.351608355273;7269.200387957215;7274.8908766369605;7288.708451661874;7289.817754556178;6813.4549236061985;7155.964220178866;7287.380572651384;7397.667104980181;7398.96300518494;7130.964345178241;7247.094113235846;7357.668904899186;7433.665485053078;7469.925300746923;7276.381507571916;7319.194888562361;7333.633318333956;7431.925680743123;7434.405247580289;7137.429005679637;7343.596102214429;7390.889136663062;7397.075365579302;7416.147143078615;6767.458603311822;6817.181938167451;6825.146856642919;6840.213375461885;6841.110655614738;6796.554613931152;6835.829104272433;6873.243943166348;6885.621290829053;6910.792676219721 03:17:54 INFO - 2016-01-23 03:17:54,059 DEBUG : BROWSER_OUTPUT: |4;prototype.html;343.1712414518937;343.48134317181047;351.1134385676166;352.27079944514855;355.7758612074393;6066.514678825689;6071.423214794599;6072.089186622004;6075;6111.388861113886;6040.244969378828;6053.485453736426;6054.60645058072;6056.969715151429;6059.151718759377;4641.744704041276;4694.108119457309;4723.48041715411;4728.598069164125;4732.810687572493;4707.505711900252;4710.152172608929;4714.952850471485;4717.033008233304;4722.386089808338;4646.395968524087;4653.953460465385;4655.068986202756;4669;4678.625709943196;4460.955390446103;4544.431946006749;4553.408056952591;4650.232711602582;4677.228257337535;4085.55058943516;4108.1783643271465;4110.835566577333;4111.280525907954;4123.793810309473;5586.469285417878;5684.54523638108;5695.86082783445;5707.971460142714;5714.257146570961;5304.336957880265;5316.867078323035;5426.484483974016;5427.348718153847;5444.6188766785945;6322.74709011639;6342.87314253717;6385.968070159666;6400.167978162855;6402.743890244385;4543.0459603483305;4543.681942264043;4544.909101817978;4548.5906268435665;4556.5215652356355;6513.446357059655;6660.633665148415;6670.799876003728;6687.063811066455;6698.129243198353;4546.136234115507;4572.977135114304;4573;4573.49691533931;4574.290984897346;4623.976880115578;4630.050839577879;4630.166570017429;4632.606228470618;4633.652476064309;5270.552003079782;5365.490278423544;5366.382865970385;5370.570354371641;5370.785168593291;6477.125588045554;6481.4166724994975;6482.222133343935;6482.967585162044;6489.383508566679;1611.2185589988846;1634.2890842483557;1635.5093471958603;1636.1164970915572;1638.0990455249564;1077.951492182838;1078.6548304542628;1088.5319312695458;1089.2484185911696;1102.8180350242121;6237.438630523184;6242.313345531988;6246.656433896179;6248.50011999039;6263.6241825490615;6683.6658167091455;6694.799156025327;6703.396694297537;6703.497237707192;6736.360045795642;6095.299040610298;6252.74989000444;6263.217097862767;6264.713379616407;6265.122882796412;3608.116011577128;3624.075860655516;3625.329314076904;3628.600853906068;3630.0380399194237;6809.931900681029;6830;6832.248452670202;6833.58998460094;6842.281560436182;6725.63009034498;6762.492813039042;6820.624865632438;6834.2140653825445;6887.862242755117;6943.062686537252;6971.442284617117;6973.291543571858;6994.755183568551;6994.790156295319;6698.39714425704;6704.296048914794;6708.060871478095;6715.630640314829;6747.6626168692355;6551.6069035858;6611.371919667624;6674.766383176566;6682.131322927989;6682.23154337238;6997.685104170427;7001.124859392576;7004.3696067354185;7011;7013.123359580052;4557.863264102082;4579.084183163447;4582.770861456847;4583.587477127075;4590.104929538707;6646.83382915431;6750.493712971645;6757.526973111835;6759.729610815512;6764.93235067643;6541.443977261795;6555.3772391622715;6559.376859198369;6568.376004279586;6572.8356791078695;6447.9355206447335;6536.967315163393;6552.737890484518;6558.049082883051;6559.409653131241;6430.678466076584;6433.742650294123;6435.420812126931;6436.195475565554;6436.549441539048;6585.979173228157;6591.439727623206;6593.044008618819;6593.406593406617;6600.900986485302;6332;6414.294427613052;6430.935690643034;6431.678416079084;6444.355564443518 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: |5;yui.html;858.0861382627501;863.4301361101666;937.5921474158741;937.6671281694996;966.260810479983;14419.92790036051;14543.200123993176;14815.259237038159;14841.332140053697;14869.033512821672;13878.583642490716;13887.444502219925;14049;14056.437742490314;14289.428422863099;932.2215949682023;935.5462600638718;936.8266870628921;937.8265020971143;937.8593211018334;924.4083786376724;924.5469719837265;925.3707478914336;925.6204955968054;926.2821313482071;979.5102448775613;982.017982017982;984.0454758883907;984.4929861121528;985.2955137076989;985.4087547471531;985.438300168904;985.5515740338165;986.3588667366162;986.39336807863;724.1780579042771;724.5906063074399;726.2301959922446;726.371688489458;726.46604745512;15204.16377099259;15289.464868729652;15306.387744490206;15338.846611533854;15340.616484587863;13003.544875929392;13387.999999999902;13632.182069075887;13749.037567370287;14215.360308786027;11023.118150547936;11096;11416.372099534523;12002;12066.69833254167;3886.6502014818802;3942.822572984194;3966.4050392441077;3967.484227050465;3983.6813054955533;44911;46292.074158516974;47698;51018.74490627523;51159.97680046415;10791.244612877023;11307.94346028281;11454.999999999833;11679.766404671858;11706.824397634042;19344.41966741;19568.412947611596;19572.21711131539;19596.314129005415;19606.70589941152;8561.14388561139;8654.6538138475;8763.425153377277;8834.823303534022;8878.28973682104;4907.435644900882;4929.975350123298;4937.11131996237;5004.299398084271;5006.924896126561;3508.824558772051;3556.2531868307947;3572.7320450965763;3575.964240357563;3576.0523461282783;621.7046902721171;622.5082185073832;627.244170774216;628.7516431009725;635.6027482823235;598.1028457314029;685.4105469296401;692.2869444472202;719.6329871765437;723.605634928965;8875.866861997076;8994.685186018458;9194.978762815805;9518.90481095194;9790.804183916423;622.966568781354;682.1950098883365;757.9729466572825;761.3262262897375;764.6100488750777;4079.73481723687;4166.812493437803;4318.589733975267;4490.057088011554;4493.168763778712;59727.40272597305;60246.39753602495;60449.39550604526;61339.38660613426;61391;43994;47265;48129.278060829114;48280;48711;49493.010139797;49519.75240123776;49580.50419495831;49723.50276497189;50511.74744126256;9186.265098791948;9207.539623018956;9313.161815436642;9414;9585.616575336908;37521.24957500889;37865;37977.81011094927;38496.230075397776;38665;45940.77029614831;47587;47781.76109119432;47893;48452.03095938132;11246.381449020382;11911.463984120563;11980;12026.218295810744;12559.811602825783;12869.2921889297;12986.740265194832;13196.20822750638;13494.93252533731;14534.05528640635;12544.74910501803;12597.370131493572;12668.493260269486;12685.682857928625;13137.934310328386;11776.52893884235;12278.570250041206;12469.251844888973;12543.686407839878;12610.180338277982;11291.956305858987;11304.604338848101;11393;11901.226420282654;11952.76094478123;10586.947065264932;10734.248602597743;10875.673729788119;10943.179261555257;11489;10245.129164021142;10684.412357320422;10693.144548436261;10746.301490403099;10801.567937282422 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,674 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1453547874052__endTimestamp 03:17:54 INFO - 2016-01-23 03:17:54,063 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5520.09 Median:5724.26 stddev:595.80 (10.4%) stddev-sans-first:571.18 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: Values: 3282.3 3368.6 3387.8 3392.5 3424.1 5493.5 5540.3 5550.4 5560.3 5581.5 5547.1 5588.4 5589.6 5598.8 5616.5 4971.6 5067.2 5111.4 5137.8 5141.8 4919.2 5030.6 5051.2 5097.8 5107.7 5064.0 5070.2 5084.3 5138.2 5146.1 5140.1 5176.7 5185.6 5190.8 5226.9 4882.0 4910.9 5084.5 5087.7 5158.3 5019.9 5291.2 5367.9 5477.7 5499.9 5855.5 5902.9 5907.6 5909.3 5918.7 5871.1 5954.4 5960.1 5961.8 5962.2 5432.6 5451.8 5526.7 5531.8 5535.7 5879.7 6120.9 6175.1 6182.0 6191.9 5931.0 5977.1 6000.8 6003.4 6004.6 5726.7 5733.7 5789.9 5822.1 5856.5 5805.8 5850.9 5854.9 5861.6 5863.6 5632.4 5848.3 5855.2 5866.4 5869.3 4492.1 4546.3 4573.3 4582.6 4607.4 4113.5 4146.9 4149.6 4164.2 4172.5 5401.6 5524.6 5681.8 5694.2 5704.5 5877.5 5951.3 5958.4 5992.4 6026.4 5612.1 5620.0 5626.7 5692.1 5699.8 5047.9 5088.8 5220.2 5235.1 5246.5 6122.0 6123.4 6126.3 6137.0 6200.8 5932.1 5935.5 5936.6 5942.3 5996.6 5927.7 6033.8 6056.1 6118.0 6140.6 5757.0 5946.5 5952.6 5961.9 5971.4 5965.9 6033.9 6037.5 6043.5 6044.6 5644.2 5656.2 5730.5 5735.8 5762.2 5724.3 5871.3 5917.3 5917.6 5918.6 5555.2 5766.4 5792.0 5794.8 5796.9 5633.6 5704.7 5718.1 5746.1 5840.9 5724.9 5785.2 5810.8 5812.5 5814.3 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,064 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54801.83 Median:20626.80 stddev:91512.14 (443.7%) stddev-sans-first:91678.46 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: Values: 629.1 630.0 636.0 639.1 645.8 32591.0 43021.6 43482.0 43558.3 43627.9 46949.5 47403.1 47411.3 47472.0 47492.3 7980.5 8045.8 9101.6 9279.6 9288.6 10750.8 10978.8 10994.0 11003.4 11061.8 10702.8 10840.3 10840.8 10878.8 10882.3 8402.5 8566.3 10718.8 10797.9 10960.9 10625.6 10772.3 10774.0 10777.5 10792.1 43278.0 43663.3 43773.6 43776.6 43796.3 3757.0 3774.6 3842.3 3859.2 3945.0 32927.3 32998.0 33822.8 33908.8 34189.3 3512.3 3549.0 3591.8 3596.8 3667.3 289113.0 295511.5 297038.0 297410.1 298220.0 64346.4 66241.7 73279.6 74217.3 81431.0 77315.2 77370.0 77933.6 78020.0 78048.0 18766.7 19003.4 19004.5 19006.3 19043.7 14354.1 14496.5 14540.9 14553.2 14565.9 23823.2 23983.3 24006.0 24120.3 24153.2 9033.3 9268.5 9358.3 9444.2 9447.4 1040.2 1105.6 1135.0 1140.8 1245.7 30602.2 31013.8 31439.7 35241.1 35525.8 1138.4 1160.7 1163.6 1202.3 1229.7 14815.9 15748.8 18086.5 18590.3 18746.7 422566.0 426938.0 428100.0 428201.0 429140.0 62231.0 62763.4 62768.0 62777.7 62873.0 1521.1 1526.9 1537.3 1542.1 1542.5 31857.2 35912.6 36014.0 36102.8 36205.5 53716.2 54855.5 54897.5 54900.0 54910.2 307708.0 308612.0 310782.0 311569.0 311649.0 46385.8 47181.0 47513.5 47518.5 48010.3 51691.2 51787.5 51832.7 51987.7 52015.0 41316.0 42387.0 42889.0 43777.3 44185.8 40836.6 44038.1 44053.0 44264.0 44909.1 39832.8 40030.0 40395.0 40698.2 41314.0 35501.6 37496.6 37679.8 40473.4 40537.2 27545.0 28033.9 28048.0 28183.4 28183.4 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29563.23 Median:14090.94 stddev:83354.88 (591.5%) stddev-sans-first:83559.87 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: Values: 360.6 368.2 368.9 370.3 370.4 10636.1 10892.2 12288.9 12548.9 18017.5 17852.1 18914.0 19025.3 19462.1 19465.6 4702.5 6308.4 6429.5 6452.1 6453.6 4750.4 6917.1 7061.5 7103.4 7105.0 6881.9 7000.4 7012.2 7026.6 7031.5 6867.1 6971.8 7030.2 7052.9 7057.0 6820.2 6837.7 6840.8 6845.4 6847.8 24610.8 25150.8 25251.5 25344.2 25609.4 2369.4 2471.9 2505.2 2572.5 2585.1 14971.1 15180.2 15365.3 15570.1 15619.6 2104.7 2115.8 2134.4 2161.3 2187.2 63313.7 65218.3 65539.7 71700.3 71849.0 16466.4 16608.2 16659.0 16677.0 16692.0 26372.6 26376.5 26642.9 26700.3 26744.2 10015.1 10150.7 10175.4 10220.4 10236.7 8772.8 8815.7 8847.4 8853.2 8865.7 7120.7 7933.0 8055.3 8279.8 8283.4 3120.9 3127.3 3215.4 3249.8 3336.1 415.4 432.2 796.2 907.1 923.3 10259.2 10445.7 10511.2 10791.6 10880.4 419.2 443.5 448.7 449.4 456.0 6320.6 6396.1 10116.9 10347.1 10845.7 446670.0 448843.0 449476.0 456012.0 696400.0 85183.0 88235.6 90194.0 90685.0 91120.5 1187.8 1204.9 1209.1 1213.8 1217.5 15647.5 16092.4 16313.6 16430.5 16536.2 35011.8 35022.3 35225.6 35823.3 36194.0 47112.3 48030.5 49172.5 49242.5 49606.3 10535.9 10585.0 10674.8 10784.3 10911.6 18044.9 18305.7 19016.4 19257.2 19462.6 15062.4 15482.8 15879.1 15971.1 16442.3 10698.9 14874.2 15056.6 15117.3 15708.3 16429.8 16674.0 16774.3 16949.7 17091.5 10341.0 10437.1 10465.5 10506.4 10562.3 13407.7 14904.5 15702.5 15719.0 16161.2 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5643.03 Median:6805.00 stddev:2927.74 (43.0%) stddev-sans-first:2914.31 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: Values: 908.8 1548.4 1596.2 1799.8 1903.9 7079.7 7668.6 7979.7 8002.9 8003.5 7830.4 7846.1 7850.8 7914.2 7920.8 2049.1 2066.0 2083.6 2086.4 2093.5 2308.9 2372.5 2375.1 2375.5 2376.2 2277.1 2301.6 2324.7 2326.1 2327.5 2307.1 2345.4 2385.1 2389.5 2397.7 2368.8 2369.7 2410.8 2412.2 2412.4 7978.6 8064.4 8078.0 8078.7 8084.2 4735.7 4865.6 4866.3 4869.2 4874.4 3108.1 3110.4 3112.7 3159.4 3170.1 1009.4 1020.4 1027.0 1055.0 1081.9 11013.9 11075.1 11084.3 11104.2 11135.3 4338.0 4357.2 4376.0 4409.8 4417.1 9498.4 9499.1 9535.2 9537.7 9539.9 4790.6 4817.7 4852.7 4861.3 4861.6 4393.0 4412.6 4441.2 4464.5 4482.0 3505.1 3548.8 3552.9 3610.3 3882.7 1184.9 1209.6 1228.0 1237.8 1266.9 1158.3 1174.6 1219.3 1436.5 1454.1 7565.6 7569.0 7610.8 7612.9 7695.1 1169.1 1169.8 1191.1 1213.1 1230.7 6016.1 6073.4 6075.1 6075.2 6079.1 9258.7 9613.6 9729.9 9745.3 9747.2 9617.1 9656.0 9663.4 9669.7 9670.0 7463.4 7651.3 7652.8 7659.7 7748.9 7373.6 7449.0 7476.7 7481.8 7486.9 8576.1 8660.6 8714.0 8816.4 8822.2 8741.4 8767.9 8803.1 8998.9 9076.1 7204.4 7269.2 7274.9 7288.7 7289.8 6813.5 7156.0 7287.4 7397.7 7399.0 7131.0 7247.1 7357.7 7433.7 7469.9 7276.4 7319.2 7333.6 7431.9 7434.4 7137.4 7343.6 7390.9 7397.1 7416.1 6767.5 6817.2 6825.1 6840.2 6841.1 6796.6 6835.8 6873.2 6885.6 6910.8 03:17:54 INFO - 2016-01-23 03:17:54,065 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,066 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5423.29 Median:6174.41 stddev:1637.85 (26.5%) stddev-sans-first:1597.45 03:17:54 INFO - 2016-01-23 03:17:54,066 DEBUG : BROWSER_OUTPUT: Values: 343.2 343.5 351.1 352.3 355.8 6066.5 6071.4 6072.1 6075.0 6111.4 6040.2 6053.5 6054.6 6057.0 6059.2 4641.7 4694.1 4723.5 4728.6 4732.8 4707.5 4710.2 4715.0 4717.0 4722.4 4646.4 4654.0 4655.1 4669.0 4678.6 4461.0 4544.4 4553.4 4650.2 4677.2 4085.6 4108.2 4110.8 4111.3 4123.8 5586.5 5684.5 5695.9 5708.0 5714.3 5304.3 5316.9 5426.5 5427.3 5444.6 6322.7 6342.9 6386.0 6400.2 6402.7 4543.0 4543.7 4544.9 4548.6 4556.5 6513.4 6660.6 6670.8 6687.1 6698.1 4546.1 4573.0 4573.0 4573.5 4574.3 4624.0 4630.1 4630.2 4632.6 4633.7 5270.6 5365.5 5366.4 5370.6 5370.8 6477.1 6481.4 6482.2 6483.0 6489.4 1611.2 1634.3 1635.5 1636.1 1638.1 1078.0 1078.7 1088.5 1089.2 1102.8 6237.4 6242.3 6246.7 6248.5 6263.6 6683.7 6694.8 6703.4 6703.5 6736.4 6095.3 6252.7 6263.2 6264.7 6265.1 3608.1 3624.1 3625.3 3628.6 3630.0 6809.9 6830.0 6832.2 6833.6 6842.3 6725.6 6762.5 6820.6 6834.2 6887.9 6943.1 6971.4 6973.3 6994.8 6994.8 6698.4 6704.3 6708.1 6715.6 6747.7 6551.6 6611.4 6674.8 6682.1 6682.2 6997.7 7001.1 7004.4 7011.0 7013.1 4557.9 4579.1 4582.8 4583.6 4590.1 6646.8 6750.5 6757.5 6759.7 6764.9 6541.4 6555.4 6559.4 6568.4 6572.8 6447.9 6537.0 6552.7 6558.0 6559.4 6430.7 6433.7 6435.4 6436.2 6436.5 6586.0 6591.4 6593.0 6593.4 6600.9 6332.0 6414.3 6430.9 6431.7 6444.4 03:17:54 INFO - 2016-01-23 03:17:54,066 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,066 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14632.57 Median:24702.08 stddev:16319.42 (66.1%) stddev-sans-first:16332.42 03:17:54 INFO - 2016-01-23 03:17:54,067 DEBUG : BROWSER_OUTPUT: Values: 858.1 863.4 937.6 937.7 966.3 14419.9 14543.2 14815.3 14841.3 14869.0 13878.6 13887.4 14049.0 14056.4 14289.4 932.2 935.5 936.8 937.8 937.9 924.4 924.5 925.4 925.6 926.3 979.5 982.0 984.0 984.5 985.3 985.4 985.4 985.6 986.4 986.4 724.2 724.6 726.2 726.4 726.5 15204.2 15289.5 15306.4 15338.8 15340.6 13003.5 13388.0 13632.2 13749.0 14215.4 11023.1 11096.0 11416.4 12002.0 12066.7 3886.7 3942.8 3966.4 3967.5 3983.7 44911.0 46292.1 47698.0 51018.7 51160.0 10791.2 11307.9 11455.0 11679.8 11706.8 19344.4 19568.4 19572.2 19596.3 19606.7 8561.1 8654.7 8763.4 8834.8 8878.3 4907.4 4930.0 4937.1 5004.3 5006.9 3508.8 3556.3 3572.7 3576.0 3576.1 621.7 622.5 627.2 628.8 635.6 598.1 685.4 692.3 719.6 723.6 8875.9 8994.7 9195.0 9518.9 9790.8 623.0 682.2 758.0 761.3 764.6 4079.7 4166.8 4318.6 4490.1 4493.2 59727.4 60246.4 60449.4 61339.4 61391.0 43994.0 47265.0 48129.3 48280.0 48711.0 49493.0 49519.8 49580.5 49723.5 50511.7 9186.3 9207.5 9313.2 9414.0 9585.6 37521.2 37865.0 37977.8 38496.2 38665.0 45940.8 47587.0 47781.8 47893.0 48452.0 11246.4 11911.5 11980.0 12026.2 12559.8 12869.3 12986.7 13196.2 13494.9 14534.1 12544.7 12597.4 12668.5 12685.7 13137.9 11776.5 12278.6 12469.3 12543.7 12610.2 11292.0 11304.6 11393.0 11901.2 11952.8 10586.9 10734.2 10875.7 10943.2 11489.0 10245.1 10684.4 10693.1 10746.3 10801.6 03:17:54 INFO - 2016-01-23 03:17:54,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:17:54 INFO - 2016-01-23 03:17:54,067 DEBUG : BROWSER_OUTPUT: 03:17:54 INFO - 2016-01-23 03:17:54,754 INFO : Browser exited with error code: 0 03:17:54 INFO - 2016-01-23 03:17:54,775 INFO : Completed test dromaeo_css (00:18:35) 03:17:54 INFO - 2016-01-23 03:17:54,775 INFO : Starting test kraken 03:17:54 INFO - 2016-01-23 03:17:54,775 DEBUG : operating with platform_type : linux_ 03:17:54 INFO - 2016-01-23 03:17:54,775 INFO : Initialising browser for kraken test... 03:17:54 INFO - 2016-01-23 03:17:54,781 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE_vkD5/profile http://localhost:56232/getInfo.html 03:17:59 INFO - 2016-01-23 03:17:59,668 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:17:59 INFO - 2016-01-23 03:17:59,669 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:17:59 INFO - 2016-01-23 03:17:59,669 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:17:59 INFO - 2016-01-23 03:17:59,669 DEBUG : BROWSER_OUTPUT: __metrics 03:17:59 INFO - 2016-01-23 03:17:59,897 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:18:01 INFO - 2016-01-23 03:18:01,302 INFO : Browser initialized. 03:18:01 INFO - 2016-01-23 03:18:01,302 INFO : Running cycle 1/1 for kraken test... 03:18:01 INFO - 2016-01-23 03:18:01,302 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE_vkD5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:18:13 INFO - 2016-01-23 03:18:13,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 137293824 03:18:13 INFO - 2016-01-23 03:18:13,042 DEBUG : BROWSER_OUTPUT: 03:18:15 INFO - 2016-01-23 03:18:15,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56232/tests/kraken/driver.html?testName=audio-beat-detection) 03:18:16 INFO - 2016-01-23 03:18:16,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 167120896 03:18:16 INFO - 2016-01-23 03:18:16,063 DEBUG : BROWSER_OUTPUT: 03:18:18 INFO - 2016-01-23 03:18:18,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56232/tests/kraken/driver.html?testName=audio-dft) 03:18:19 INFO - 2016-01-23 03:18:19,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 164855808 03:18:19 INFO - 2016-01-23 03:18:19,205 DEBUG : BROWSER_OUTPUT: 03:18:21 INFO - 2016-01-23 03:18:21,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56232/tests/kraken/driver.html?testName=audio-fft) 03:18:22 INFO - 2016-01-23 03:18:22,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 164368384 03:18:22 INFO - 2016-01-23 03:18:22,541 DEBUG : BROWSER_OUTPUT: 03:18:24 INFO - 2016-01-23 03:18:24,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56232/tests/kraken/driver.html?testName=audio-oscillator) 03:18:25 INFO - 2016-01-23 03:18:25,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 162832384 03:18:25 INFO - 2016-01-23 03:18:25,092 DEBUG : BROWSER_OUTPUT: 03:18:27 INFO - 2016-01-23 03:18:27,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56232/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:27 INFO - 2016-01-23 03:18:27,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 162652160 03:18:27 INFO - 2016-01-23 03:18:27,833 DEBUG : BROWSER_OUTPUT: 03:18:30 INFO - 2016-01-23 03:18:30,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56232/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:31 INFO - 2016-01-23 03:18:31,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 162893824 03:18:31 INFO - 2016-01-23 03:18:31,246 DEBUG : BROWSER_OUTPUT: 03:18:34 INFO - 2016-01-23 03:18:34,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56232/tests/kraken/driver.html?testName=imaging-desaturate) 03:18:35 INFO - 2016-01-23 03:18:35,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 163729408 03:18:35 INFO - 2016-01-23 03:18:35,158 DEBUG : BROWSER_OUTPUT: 03:18:37 INFO - 2016-01-23 03:18:37,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56232/tests/kraken/driver.html?testName=json-parse-financial) 03:18:38 INFO - 2016-01-23 03:18:38,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 162746368 03:18:38 INFO - 2016-01-23 03:18:38,404 DEBUG : BROWSER_OUTPUT: 03:18:39 INFO - 2016-01-23 03:18:39,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56232/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:40 INFO - 2016-01-23 03:18:40,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 168902656 03:18:40 INFO - 2016-01-23 03:18:40,500 DEBUG : BROWSER_OUTPUT: 03:18:42 INFO - 2016-01-23 03:18:42,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:42 INFO - 2016-01-23 03:18:42,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 168972288 03:18:42 INFO - 2016-01-23 03:18:42,849 DEBUG : BROWSER_OUTPUT: 03:18:44 INFO - 2016-01-23 03:18:44,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:45 INFO - 2016-01-23 03:18:45,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 177840128 03:18:45 INFO - 2016-01-23 03:18:45,420 DEBUG : BROWSER_OUTPUT: 03:18:49 INFO - 2016-01-23 03:18:49,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:50 INFO - 2016-01-23 03:18:50,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 172384256 03:18:50 INFO - 2016-01-23 03:18:50,363 DEBUG : BROWSER_OUTPUT: 03:18:52 INFO - 2016-01-23 03:18:52,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:53 INFO - 2016-01-23 03:18:53,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 174796800 03:18:53 INFO - 2016-01-23 03:18:53,445 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56232/tests/kraken/driver.html?testName=ai-astar) 03:18:55 INFO - 2016-01-23 03:18:55,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 232443904 03:18:55 INFO - 2016-01-23 03:18:55,340 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,343 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:18:55 INFO - 2016-01-23 03:18:55,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;109;110;109;99;108;108;98 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;123;147;157;123;145;155;129;165;120 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;159;160;160;161;159;159;158;159 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;71;147;72;70;72;72;149;71 03:18:55 INFO - 2016-01-23 03:18:55,344 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;129;92;92;93;135;93;93;133 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;109 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;147;145;145;145;147;147;145 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;96;95;95;95;95 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;56;57;57;56;57;59;55;55 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;64;64;65;64;64;64;64;64 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;80;80;80;81;80;80;79;80;81 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;116;127;109;114;109;116;126;124;128 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;145;145;144;137;148;145;146;144;134 03:18:55 INFO - 2016-01-23 03:18:55,345 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;65;64;64;66;66;64;66;65 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: __startTimestamp1453547935341__endTimestamp 03:18:55 INFO - 2016-01-23 03:18:55,346 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.20 Median:109.00 stddev:4.37 (4.0%) stddev-sans-first:4.58 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 109.0 110.0 109.0 99.0 108.0 108.0 98.0 03:18:55 INFO - 2016-01-23 03:18:55,349 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:151.00 stddev:16.96 (11.2%) stddev-sans-first:16.99 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: Values: 158.0 123.0 147.0 157.0 123.0 145.0 155.0 129.0 165.0 120.0 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.40 Median:159.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 159.0 160.0 160.0 161.0 159.0 159.0 158.0 159.0 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:72.00 stddev:32.17 (44.7%) stddev-sans-first:33.66 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 71.0 147.0 72.0 70.0 72.0 72.0 149.0 71.0 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,350 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:93.00 stddev:19.13 (20.6%) stddev-sans-first:19.82 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 129.0 92.0 92.0 93.0 135.0 93.0 93.0 133.0 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:0.95 (0.7%) stddev-sans-first:0.97 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 147.0 145.0 145.0 145.0 147.0 147.0 145.0 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 03:18:55 INFO - 2016-01-23 03:18:55,351 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 56.0 57.0 57.0 56.0 57.0 59.0 55.0 55.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:0.88 (1.1%) stddev-sans-first:0.60 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 80.0 80.0 81.0 80.0 80.0 79.0 80.0 81.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:120.00 stddev:7.39 (6.2%) stddev-sans-first:7.60 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 127.0 109.0 114.0 109.0 116.0 126.0 124.0 128.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:145.00 stddev:5.16 (3.6%) stddev-sans-first:4.54 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: Values: 134.0 145.0 145.0 144.0 137.0 148.0 145.0 146.0 144.0 134.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 64.0 64.0 66.0 66.0 64.0 66.0 65.0 03:18:55 INFO - 2016-01-23 03:18:55,352 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:18:55 INFO - 2016-01-23 03:18:55,353 DEBUG : BROWSER_OUTPUT: 03:18:56 INFO - 2016-01-23 03:18:56,206 INFO : Browser exited with error code: 0 03:18:56 INFO - 2016-01-23 03:18:56,256 INFO : Completed test kraken (00:01:01) 03:18:56 INFO - 2016-01-23 03:18:56,256 INFO : Starting test v8_7 03:18:56 INFO - 2016-01-23 03:18:56,256 DEBUG : operating with platform_type : linux_ 03:18:56 INFO - 2016-01-23 03:18:56,257 INFO : Initialising browser for v8_7 test... 03:18:56 INFO - 2016-01-23 03:18:56,263 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpozegZb/profile http://localhost:56232/getInfo.html 03:19:01 INFO - 2016-01-23 03:19:01,210 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:19:01 INFO - 2016-01-23 03:19:01,211 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:19:01 INFO - 2016-01-23 03:19:01,211 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:19:01 INFO - 2016-01-23 03:19:01,211 DEBUG : BROWSER_OUTPUT: __metrics 03:19:01 INFO - 2016-01-23 03:19:01,454 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:02 INFO - 2016-01-23 03:19:02,432 INFO : Browser initialized. 03:19:02 INFO - 2016-01-23 03:19:02,432 INFO : Running cycle 1/1 for v8_7 test... 03:19:02 INFO - 2016-01-23 03:19:02,433 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpozegZb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:19:14 INFO - 2016-01-23 03:19:14,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 137445376 03:19:14 INFO - 2016-01-23 03:19:14,210 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56232/tests/v8_7/run.html (next: http://localhost:56232/tests/v8_7/run.html) 03:19:35 INFO - 2016-01-23 03:19:35,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 423067648 03:19:35 INFO - 2016-01-23 03:19:35,908 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,909 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:19:35 INFO - 2016-01-23 03:19:35,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:19:35 INFO - 2016-01-23 03:19:35,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:19:35 INFO - 2016-01-23 03:19:35,909 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.71157167530225 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |4;RayTrace;945.179584120983 03:19:35 INFO - 2016-01-23 03:19:35,910 DEBUG : BROWSER_OUTPUT: |5;Earley;554.6311702717693 03:19:35 INFO - 2016-01-23 03:19:35,911 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.130434782608 03:19:35 INFO - 2016-01-23 03:19:35,911 DEBUG : BROWSER_OUTPUT: |7;RegExp;24190.47619047619 03:19:35 INFO - 2016-01-23 03:19:35,911 DEBUG : BROWSER_OUTPUT: |8;Splay;521.1047420531527 03:19:35 INFO - 2016-01-23 03:19:35,911 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 03:19:35 INFO - 2016-01-23 03:19:35,911 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:19:35 INFO - 2016-01-23 03:19:35,912 DEBUG : BROWSER_OUTPUT: __startTimestamp1453547975907__endTimestamp 03:19:35 INFO - 2016-01-23 03:19:35,912 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,912 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:19:35 INFO - 2016-01-23 03:19:35,912 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:19:35 INFO - 2016-01-23 03:19:35,912 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,913 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,913 DEBUG : BROWSER_OUTPUT: Values: 166.2 03:19:35 INFO - 2016-01-23 03:19:35,913 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,913 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.71 Median:172.71 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,913 DEBUG : BROWSER_OUTPUT: Values: 172.7 03:19:35 INFO - 2016-01-23 03:19:35,914 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,914 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,914 DEBUG : BROWSER_OUTPUT: Values: 279.9 03:19:35 INFO - 2016-01-23 03:19:35,914 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,914 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,915 DEBUG : BROWSER_OUTPUT: Values: 5181.3 03:19:35 INFO - 2016-01-23 03:19:35,915 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,915 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:945.18 Median:945.18 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,915 DEBUG : BROWSER_OUTPUT: Values: 945.2 03:19:35 INFO - 2016-01-23 03:19:35,915 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,916 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.63 Median:554.63 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,916 DEBUG : BROWSER_OUTPUT: Values: 554.6 03:19:35 INFO - 2016-01-23 03:19:35,916 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,916 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.13 Median:10989.13 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,916 DEBUG : BROWSER_OUTPUT: Values: 10989.1 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24190.48 Median:24190.48 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: Values: 24190.5 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.10 Median:521.10 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: Values: 521.1 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2016-01-23 03:19:35,917 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:19:35 INFO - 2016-01-23 03:19:35,918 DEBUG : BROWSER_OUTPUT: Values: 4840.6 03:19:35 INFO - 2016-01-23 03:19:35,918 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:19:35 INFO - 2016-01-23 03:19:35,918 DEBUG : BROWSER_OUTPUT: 03:19:36 INFO - 2016-01-23 03:19:36,798 INFO : Browser exited with error code: 0 03:19:36 INFO - 2016-01-23 03:19:36,810 INFO : Completed test v8_7 (00:00:40) 03:19:36 INFO - 2016-01-23 03:19:36,903 INFO : Completed test suite (00:20:17) 03:19:36 INFO - 2016-01-23 03:19:36,903 DEBUG : Working with test: dromaeo_css 03:19:36 INFO - 2016-01-23 03:19:36,903 DEBUG : Generating results file: dromaeo_css 03:19:36 INFO - 2016-01-23 03:19:36,905 DEBUG : Working with test: kraken 03:19:36 INFO - 2016-01-23 03:19:36,905 DEBUG : Generating results file: kraken 03:19:36 INFO - 2016-01-23 03:19:36,905 INFO : javascript benchmark 03:19:36 INFO - 2016-01-23 03:19:36,905 DEBUG : Working with test: v8_7 03:19:36 INFO - 2016-01-23 03:19:36,905 DEBUG : Generating results file: v8_7 03:19:36 INFO - 2016-01-23 03:19:36,906 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:19:37 INFO - 2016-01-23 03:19:37,052 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:19:37 INFO - 2016-01-23 03:19:37,053 DEBUG : process_Request line: dromaeo_css 7549.33 graph.html#tests=[[72,52,35]] 03:19:37 INFO - 2016-01-23 03:19:37,053 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:19:37 INFO - 2016-01-23 03:19:37,195 DEBUG : process_Request line: kraken 1475.80 graph.html#tests=[[232,52,35]] 03:19:37 INFO - 2016-01-23 03:19:37,195 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:19:37 INFO - 2016-01-23 03:19:37,289 DEBUG : process_Request line: v8_7 23061.09 graph.html#tests=[[230,52,35]] 03:19:37 INFO - 2016-01-23 03:19:37,291 INFO : javascript benchmark 03:19:37 INFO - 2016-01-23 03:19:37,294 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3282.2614911644873, 3368.6294507604175, 3387.7628566000376, 3392.5250464934898, 3424.092615456904, 5493.533049690776, 5540.307461567304, 5550.361708403535, 5560.332760068787, 5581.49766521013, 5547.11246200608, 5588.441155884409, 5589.552835773138, 5598.832035038945, 5616.52259557937, 4971.577415919651, 5067.163917953533, 5111.361079865017, 5137.845864624067, 5141.76862041209, 4919.188333924898, 5030.647854650176, 5051.191809310511, 5097.7960881564695, 5107.693538387709, 5064.037832811754, 5070.163423035195, 5084.262781896623, 5138.152204886189, 5146.099432599299, 5140.100482415581, 5176.663516871391, 5185.637005409623, 5190.792368305282, 5226.947730522684, 4881.95118048822, 4910.926336104962, 5084.516970887797, 5087.694738315713, 5158.303629010074, 5019.924701129486, 5291.1798671206025, 5367.892642147174, 5477.698726570037, 5499.945000549983, 5855.473007429309, 5902.852428689274, 5907.645541267495, 5909.290885093773, 5918.704064796786, 5871.1193321001765, 5954.404559544054, 5960.105984102376, 5961.791337303217, 5962.165296858443, 5432.619716619838, 5451.809186678487, 5526.723663816833, 5531.751071201806, 5535.667859928417, 5879.676617785977, 6120.938790612126, 6175.104609831549, 6182.0, 6191.876162476725, 5931.0, 5977.073553599199, 6000.849978750566, 6003.369646187175, 6004.639721616717, 5726.742296596663, 5733.655980641091, 5789.88420231593, 5822.1266809978, 5856.502197313276, 5805.796797112081, 5850.882982340329, 5854.941450585525, 5861.589688721834, 5863.560232982543, 5632.436756324417, 5848.3274423441, 5855.151003104526, 5866.354700982888, 5869.325027621793, 4492.146492166478, 4546.340780586796, 4573.291139873325, 4582.633389328846, 4607.424071991001, 4113.4858142732155, 4146.937795933063, 4149.605787450188, 4164.229617520768, 4172.520160181557, 5401.5948803839865, 5524.613277070647, 5681.829545113653, 5694.174344720075, 5704.543636509069, 5877.52979761618, 5951.345352011275, 5958.433948774859, 5992.43071908168, 6026.397360263939, 5612.074007788669, 5619.971900140473, 5626.690532020778, 5692.060809966392, 5699.800506982236, 5047.899042019139, 5088.796448142107, 5220.216967454836, 5235.0576896159055, 5246.527812496894, 6121.96939015311, 6123.387661233841, 6126.326104128542, 6136.969315153396, 6200.844978875474, 5932.080527518242, 5935.465808077293, 5936.554758393224, 5942.346341902474, 5996.610220335664, 5927.673977931255, 6033.758649653964, 6056.121862329849, 6117.999999999822, 6140.5701600887505, 5757.0, 5946.464818166386, 5952.642841429355, 5961.880762384815, 5971.402859713994, 5965.880682386415, 6033.879322413615, 6037.547183961308, 6043.54673399488, 6044.57687961856, 5644.209810626434, 5656.208130861601, 5730.5129064030025, 5735.770569177186, 5762.2221000164445, 5724.255846739898, 5871.295444546511, 5917.289925209003, 5917.556183286185, 5918.615290006136, 5555.2222688822785, 5766.4233576642, 5792.0, 5794.82615521535, 5796.9420305798085, 5633.605647604629, 5704.657720536781, 5718.142278658234, 5746.138079287973, 5840.883182336244, 5724.942750572608, 5785.190073389645, 5810.82567522975, 5812.476877081083, 5814.30228372598], "unit": "ms", "name": "dojo.html", "value": 5482.846589356609}, {"lowerIsBetter": false, "replicates": [629.134939458245, 629.9637096975479, 636.0459311033447, 639.1180171363518, 645.8062581225632, 32591.0, 43021.56978430215, 43482.0, 43558.34662480065, 43627.90930226742, 46949.53050469494, 47403.0519389612, 47411.28883066757, 47472.0, 47492.28761568579, 7980.4812687175145, 8045.798855028613, 9101.63593456261, 9279.582418791171, 9288.58201380936, 10750.78498430031, 10978.780424391507, 10994.0, 11003.449827508593, 11061.778764424707, 10702.785944281148, 10840.295380800262, 10840.837387439195, 10878.782424351508, 10882.347059176474, 8402.495850248943, 8566.3146948244, 10718.839217411745, 10797.946010269978, 10960.945195274053, 10625.628103016435, 10772.299800512941, 10774.0, 10777.515011824487, 10792.136629069733, 43278.0, 43663.345049824275, 43773.562264377266, 43776.56223437789, 43796.3430548542, 3756.981215093934, 3774.622537746231, 3842.289176502356, 3859.1702783901596, 3944.960550394488, 32927.341453171044, 32998.0, 33822.83088584566, 33908.83045584781, 34189.31621367583, 3512.3326567952263, 3549.0, 3591.7665351752053, 3596.7662101963288, 3667.2665466906724, 289113.0, 295511.5224423886, 297038.0, 297410.0776976694, 298220.0, 64346.35653643497, 66241.66879165573, 73279.63360183165, 74217.25782742212, 81431.0, 77315.22684773081, 77370.0, 77933.61033194797, 78020.0, 78048.0, 18766.718499222523, 19003.42989710311, 19004.524886877938, 19006.334778282693, 19043.714344284846, 14354.138751674724, 14496.492622758153, 14540.927295363455, 14553.19957402353, 14565.85434145645, 23823.166189183296, 23983.28050158498, 24006.0, 24120.276391708278, 24153.15463958753, 9033.277337812959, 9268.490233037113, 9358.298127640453, 9444.197243234265, 9447.433154010781, 1040.2094408249634, 1105.6461932181785, 1134.9773004539863, 1140.823172408278, 1245.6698974771693, 30602.23494412613, 31013.8449307752, 31439.685603144135, 35241.118972025906, 35525.82237088798, 1138.408027825526, 1160.6866146140494, 1163.6450882480924, 1202.290648517379, 1229.6679896428093, 14815.92592037033, 15748.842511574967, 18086.5478363042, 18590.349337773383, 18746.718799218022, 422566.0, 426938.0, 428100.0, 428201.0, 429140.0, 62231.0, 62763.372366275755, 62768.0, 62777.68611156915, 62873.0, 1521.0645453046297, 1526.9083854968737, 1537.262114185175, 1542.0516382424728, 1542.4524293875513, 31857.203569910936, 35912.64087359093, 36014.0, 36102.8194859024, 36205.45691814572, 53716.19425708539, 54855.451445485036, 54897.45102548923, 54900.0, 54910.17634735562, 307708.0, 308612.0, 310782.0, 311569.0, 311649.0, 46385.76807115943, 47181.0, 47513.52486475091, 47518.5248147528, 48010.27984580304, 51691.22463163131, 51787.48212517826, 51832.740836295576, 51987.74006129945, 52014.95970080502, 41316.0, 42387.0, 42889.0, 43777.34333984929, 44185.779071104436, 40836.59163408328, 44038.119237614424, 44053.0, 44264.0, 44909.10181796411, 39832.80083599564, 40030.0, 40395.0, 40698.1860362797, 41314.0, 35501.644983549835, 37496.6250337504, 37679.81160094182, 40473.39289910595, 40537.1892562153, 27545.0, 28033.859830700716, 28048.0, 28183.43633127367, 28183.43633127367], "unit": "ms", "name": "ext.html", "value": 21565.117412804462}, {"lowerIsBetter": false, "replicates": [360.5943313772005, 368.16059384603113, 368.8708951866847, 370.30752492838394, 370.4128955605365, 10636.095931845783, 10892.183086268522, 12288.938555307222, 12548.937255313733, 18017.54956126096, 17852.10739463025, 18914.0, 19025.33411330604, 19462.1242044108, 19465.61068778627, 4702.506236845134, 6308.369163083701, 6429.517786166033, 6452.064450654652, 6453.580517266362, 4750.358701575277, 6917.100776898996, 7061.4703897207655, 7103.396211322044, 7104.964475177617, 6881.8967715484305, 7000.369966702996, 7012.193597736275, 7026.648667566601, 7031.50779445439, 6867.07294515239, 6971.79084627462, 7030.226675065739, 7052.858942821166, 7056.964715176417, 6820.215675197316, 6837.726490940357, 6840.794776156723, 6845.418139458152, 6847.828804279933, 24610.753892461205, 25150.80094275557, 25251.494970100677, 25344.239672809847, 25609.35976600581, 2369.4194922243987, 2471.9011239550396, 2505.235903049569, 2572.511222867649, 2585.0693750249893, 14971.101733896001, 15180.240987950669, 15365.308561114776, 15570.14364209968, 15619.609509762233, 2104.7474303083577, 2115.7989990950837, 2134.359692092366, 2161.2867753641417, 2187.1688758271753, 63313.68343158255, 65218.3478165217, 65539.67230163867, 71700.28299716988, 71849.0, 16466.42367517131, 16608.169591520375, 16659.0, 16677.0, 16692.0, 26372.60441093385, 26376.47247055048, 26642.86678566595, 26700.332491687863, 26744.19767406981, 10015.098641122187, 10150.695479135638, 10175.389476631277, 10220.386776793417, 10236.744081397876, 8772.824543509221, 8815.735527934172, 8847.42491738035, 8853.247473964657, 8865.734027979172, 7120.734044406538, 7933.0, 8055.315298199719, 8279.751607451786, 8283.37874659403, 3120.859561319701, 3127.3119913618966, 3215.42122417967, 3249.78876373035, 3336.099253201622, 415.3582714705787, 432.19827220506136, 796.1998191817187, 907.1065000974036, 923.3029063057348, 10259.17926565873, 10445.738856528496, 10511.1591072714, 10791.6222932197, 10880.401577913291, 419.2014212924384, 443.4656239231718, 448.6590191454518, 449.3955629678078, 455.9840405585855, 6320.62076275425, 6396.0725694774, 10116.949415253024, 10347.120494757879, 10845.728856778644, 446670.0, 448843.0, 449476.0, 456012.0, 696400.0, 85183.0, 88235.55882220676, 90194.0, 90685.0, 91120.54439727758, 1187.8158885372782, 1204.9277043377426, 1209.1294268126935, 1213.8239955206445, 1217.5190799634095, 15647.452339168074, 16092.436764713178, 16313.59216019609, 16430.507084787474, 16536.173191340145, 35011.82494087513, 35022.29955400929, 35225.64774352326, 35823.28353432865, 36194.0, 47112.29331560098, 48030.519694804, 49172.508274918226, 49242.50757492523, 49606.25590616072, 10535.894641053797, 10585.0, 10674.839877402, 10784.299020563638, 10911.563537458413, 18044.90977545104, 18305.725414119064, 19016.429507114808, 19257.22971081141, 19462.61074778525, 15062.397504100152, 15482.767758483857, 15879.12664803447, 15971.121588312755, 16442.34230630809, 10698.897319777177, 14874.181919994504, 15056.623584410478, 15117.319720612379, 15708.293126809092, 16429.753553696944, 16674.0, 16774.32902683879, 16949.74575381395, 17091.48725538236, 10341.0, 10437.112845408225, 10465.529051192867, 10506.369617822955, 10562.31344962575, 13407.731845363232, 14904.478343257933, 15702.528924132293, 15719.0, 16161.191940403169], "unit": "ms", "name": "jquery.html", "value": 9966.434091603263}, {"lowerIsBetter": false, "replicates": [908.7909780750423, 1548.3574316658587, 1596.201899050475, 1799.752583901991, 1903.9143238554273, 7079.6814143363545, 7668.61656917154, 7979.680812767482, 8002.879956800638, 8003.479773814698, 7830.41271904608, 7846.136924938252, 7850.842983140334, 7914.169012253717, 7920.801979950504, 2049.0881557706825, 2066.0392917293457, 2083.5520363121927, 2086.3636590839787, 2093.5289559849066, 2308.9191878284178, 2372.489914668346, 2375.133076427109, 2375.4536456614987, 2376.2039716694926, 2277.077783497686, 2301.551197516485, 2324.662923876037, 2326.081197926818, 2327.5228578141523, 2307.1463558483383, 2345.3784747042046, 2385.0698227691214, 2389.4504264019197, 2397.7482364351754, 2368.7631236876346, 2369.6919400478, 2410.8071354291615, 2412.19191570824, 2412.421018955438, 7978.561179135145, 8064.435489515737, 8078.0306363236205, 8078.667019941761, 8084.191580841927, 4735.668503204777, 4865.635077369176, 4866.31871537985, 4869.220924652039, 4874.366332376769, 3108.145260053481, 3110.3934732727125, 3112.7354174894936, 3159.41550813098, 3170.096522491102, 1009.4498498318434, 1020.4387586827215, 1026.9948650256777, 1055.024102704995, 1081.8972197641212, 11013.889861101366, 11075.058620017307, 11084.279521831055, 11104.222704410695, 11135.276207046598, 4338.002259480337, 4357.150355680676, 4376.037271800199, 4409.845655402046, 4417.138657961731, 9498.382605130644, 9499.050094990445, 9535.189508891683, 9537.666181683608, 9539.904600953902, 4790.592799612003, 4817.710937343701, 4852.733099679481, 4861.27080937855, 4861.562459378673, 4393.0, 4412.646988240933, 4441.244988351988, 4464.53122422141, 4481.977590112028, 3505.106197919514, 3548.8225588720975, 3552.946705799415, 3610.2779444111284, 3882.7087968402484, 1184.9289042657467, 1209.5524655877382, 1227.9562371983743, 1237.8178839208533, 1266.9104570069733, 1158.3183593459883, 1174.6065068202247, 1219.3415555599877, 1436.4756863744658, 1454.0621299261916, 7565.583892885834, 7568.962155189299, 7610.771676849703, 7612.885806712904, 7695.115061767857, 1169.05306701572, 1169.7952858249773, 1191.106669997502, 1213.071999920062, 1230.7046308885804, 6016.127661489059, 6073.39266073398, 6075.149479072933, 6075.2405949256345, 6079.08813677943, 9258.67594634198, 9613.615455381707, 9729.902700973042, 9745.269104817167, 9747.171490423394, 9617.134457898823, 9656.034396560288, 9663.420194788336, 9669.661561845302, 9669.951650241705, 7463.440241981873, 7651.311381975537, 7652.846943061108, 7659.655315510815, 7748.922510774933, 7373.5575865448245, 7448.9627551861895, 7476.738314158978, 7481.7755467336065, 7486.925130748623, 8576.099509551657, 8660.610272537877, 8713.956430217808, 8816.426932249384, 8822.161894620258, 8741.431806932529, 8767.912320876709, 8803.075677053817, 8998.910010900068, 9076.09239076087, 7204.351608355273, 7269.200387957215, 7274.8908766369605, 7288.708451661874, 7289.817754556178, 6813.4549236061985, 7155.964220178866, 7287.380572651384, 7397.667104980181, 7398.96300518494, 7130.964345178241, 7247.094113235846, 7357.668904899186, 7433.665485053078, 7469.925300746923, 7276.381507571916, 7319.194888562361, 7333.633318333956, 7431.925680743123, 7434.405247580289, 7137.429005679637, 7343.596102214429, 7390.889136663062, 7397.075365579302, 7416.147143078615, 6767.458603311822, 6817.181938167451, 6825.146856642919, 6840.213375461885, 6841.110655614738, 6796.554613931152, 6835.829104272433, 6873.243943166348, 6885.621290829053, 6910.792676219721], "unit": "ms", "name": "mootools.html", "value": 4636.086336074754}, {"lowerIsBetter": false, "replicates": [343.1712414518937, 343.48134317181047, 351.1134385676166, 352.27079944514855, 355.7758612074393, 6066.514678825689, 6071.423214794599, 6072.089186622004, 6075.0, 6111.388861113886, 6040.244969378828, 6053.485453736426, 6054.60645058072, 6056.969715151429, 6059.151718759377, 4641.744704041276, 4694.108119457309, 4723.48041715411, 4728.598069164125, 4732.810687572493, 4707.505711900252, 4710.152172608929, 4714.952850471485, 4717.033008233304, 4722.386089808338, 4646.395968524087, 4653.953460465385, 4655.068986202756, 4669.0, 4678.625709943196, 4460.955390446103, 4544.431946006749, 4553.408056952591, 4650.232711602582, 4677.228257337535, 4085.55058943516, 4108.1783643271465, 4110.835566577333, 4111.280525907954, 4123.793810309473, 5586.469285417878, 5684.54523638108, 5695.86082783445, 5707.971460142714, 5714.257146570961, 5304.336957880265, 5316.867078323035, 5426.484483974016, 5427.348718153847, 5444.6188766785945, 6322.74709011639, 6342.87314253717, 6385.968070159666, 6400.167978162855, 6402.743890244385, 4543.0459603483305, 4543.681942264043, 4544.909101817978, 4548.5906268435665, 4556.5215652356355, 6513.446357059655, 6660.633665148415, 6670.799876003728, 6687.063811066455, 6698.129243198353, 4546.136234115507, 4572.977135114304, 4573.0, 4573.49691533931, 4574.290984897346, 4623.976880115578, 4630.050839577879, 4630.166570017429, 4632.606228470618, 4633.652476064309, 5270.552003079782, 5365.490278423544, 5366.382865970385, 5370.570354371641, 5370.785168593291, 6477.125588045554, 6481.4166724994975, 6482.222133343935, 6482.967585162044, 6489.383508566679, 1611.2185589988846, 1634.2890842483557, 1635.5093471958603, 1636.1164970915572, 1638.0990455249564, 1077.951492182838, 1078.6548304542628, 1088.5319312695458, 1089.2484185911696, 1102.8180350242121, 6237.438630523184, 6242.313345531988, 6246.656433896179, 6248.50011999039, 6263.6241825490615, 6683.6658167091455, 6694.799156025327, 6703.396694297537, 6703.497237707192, 6736.360045795642, 6095.299040610298, 6252.74989000444, 6263.217097862767, 6264.713379616407, 6265.122882796412, 3608.116011577128, 3624.075860655516, 3625.329314076904, 3628.600853906068, 3630.0380399194237, 6809.931900681029, 6830.0, 6832.248452670202, 6833.58998460094, 6842.281560436182, 6725.63009034498, 6762.492813039042, 6820.624865632438, 6834.2140653825445, 6887.862242755117, 6943.062686537252, 6971.442284617117, 6973.291543571858, 6994.755183568551, 6994.790156295319, 6698.39714425704, 6704.296048914794, 6708.060871478095, 6715.630640314829, 6747.6626168692355, 6551.6069035858, 6611.371919667624, 6674.766383176566, 6682.131322927989, 6682.23154337238, 6997.685104170427, 7001.124859392576, 7004.3696067354185, 7011.0, 7013.123359580052, 4557.863264102082, 4579.084183163447, 4582.770861456847, 4583.587477127075, 4590.104929538707, 6646.83382915431, 6750.493712971645, 6757.526973111835, 6759.729610815512, 6764.93235067643, 6541.443977261795, 6555.3772391622715, 6559.376859198369, 6568.376004279586, 6572.8356791078695, 6447.9355206447335, 6536.967315163393, 6552.737890484518, 6558.049082883051, 6559.409653131241, 6430.678466076584, 6433.742650294123, 6435.420812126931, 6436.195475565554, 6436.549441539048, 6585.979173228157, 6591.439727623206, 6593.044008618819, 6593.406593406617, 6600.900986485302, 6332.0, 6414.294427613052, 6430.935690643034, 6431.678416079084, 6444.355564443518], "unit": "ms", "name": "prototype.html", "value": 4891.284899864814}, {"lowerIsBetter": false, "replicates": [858.0861382627501, 863.4301361101666, 937.5921474158741, 937.6671281694996, 966.260810479983, 14419.92790036051, 14543.200123993176, 14815.259237038159, 14841.332140053697, 14869.033512821672, 13878.583642490716, 13887.444502219925, 14049.0, 14056.437742490314, 14289.428422863099, 932.2215949682023, 935.5462600638718, 936.8266870628921, 937.8265020971143, 937.8593211018334, 924.4083786376724, 924.5469719837265, 925.3707478914336, 925.6204955968054, 926.2821313482071, 979.5102448775613, 982.017982017982, 984.0454758883907, 984.4929861121528, 985.2955137076989, 985.4087547471531, 985.438300168904, 985.5515740338165, 986.3588667366162, 986.39336807863, 724.1780579042771, 724.5906063074399, 726.2301959922446, 726.371688489458, 726.46604745512, 15204.16377099259, 15289.464868729652, 15306.387744490206, 15338.846611533854, 15340.616484587863, 13003.544875929392, 13387.999999999902, 13632.182069075887, 13749.037567370287, 14215.360308786027, 11023.118150547936, 11096.0, 11416.372099534523, 12002.0, 12066.69833254167, 3886.6502014818802, 3942.822572984194, 3966.4050392441077, 3967.484227050465, 3983.6813054955533, 44911.0, 46292.074158516974, 47698.0, 51018.74490627523, 51159.97680046415, 10791.244612877023, 11307.94346028281, 11454.999999999833, 11679.766404671858, 11706.824397634042, 19344.41966741, 19568.412947611596, 19572.21711131539, 19596.314129005415, 19606.70589941152, 8561.14388561139, 8654.6538138475, 8763.425153377277, 8834.823303534022, 8878.28973682104, 4907.435644900882, 4929.975350123298, 4937.11131996237, 5004.299398084271, 5006.924896126561, 3508.824558772051, 3556.2531868307947, 3572.7320450965763, 3575.964240357563, 3576.0523461282783, 621.7046902721171, 622.5082185073832, 627.244170774216, 628.7516431009725, 635.6027482823235, 598.1028457314029, 685.4105469296401, 692.2869444472202, 719.6329871765437, 723.605634928965, 8875.866861997076, 8994.685186018458, 9194.978762815805, 9518.90481095194, 9790.804183916423, 622.966568781354, 682.1950098883365, 757.9729466572825, 761.3262262897375, 764.6100488750777, 4079.73481723687, 4166.812493437803, 4318.589733975267, 4490.057088011554, 4493.168763778712, 59727.40272597305, 60246.39753602495, 60449.39550604526, 61339.38660613426, 61391.0, 43994.0, 47265.0, 48129.278060829114, 48280.0, 48711.0, 49493.010139797, 49519.75240123776, 49580.50419495831, 49723.50276497189, 50511.74744126256, 9186.265098791948, 9207.539623018956, 9313.161815436642, 9414.0, 9585.616575336908, 37521.24957500889, 37865.0, 37977.81011094927, 38496.230075397776, 38665.0, 45940.77029614831, 47587.0, 47781.76109119432, 47893.0, 48452.03095938132, 11246.381449020382, 11911.463984120563, 11980.0, 12026.218295810744, 12559.811602825783, 12869.2921889297, 12986.740265194832, 13196.20822750638, 13494.93252533731, 14534.05528640635, 12544.74910501803, 12597.370131493572, 12668.493260269486, 12685.682857928625, 13137.934310328386, 11776.52893884235, 12278.570250041206, 12469.251844888973, 12543.686407839878, 12610.180338277982, 11291.956305858987, 11304.604338848101, 11393.0, 11901.226420282654, 11952.76094478123, 10586.947065264932, 10734.248602597743, 10875.673729788119, 10943.179261555257, 11489.0, 10245.129164021142, 10684.412357320422, 10693.144548436261, 10746.301490403099, 10801.567937282422], "unit": "ms", "name": "yui.html", "value": 6926.822292728469}], "name": "dromaeo_css", "value": 7549.326215877201}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 110.0, 109.0, 99.0, 108.0, 108.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 106.2}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 147.0, 157.0, 123.0, 145.0, 155.0, 129.0, 165.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 159.0, 160.0, 160.0, 161.0, 159.0, 159.0, 158.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 71.0, 147.0, 72.0, 70.0, 72.0, 72.0, 149.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 129.0, 92.0, 92.0, 93.0, 135.0, 93.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 147.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 57.0, 57.0, 56.0, 57.0, 59.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 80.0, 80.0, 81.0, 80.0, 80.0, 79.0, 80.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [113.0, 116.0, 127.0, 109.0, 114.0, 109.0, 116.0, 126.0, 124.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [134.0, 145.0, 145.0, 144.0, 137.0, 148.0, 145.0, 146.0, 144.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 64.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1475.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [172.71157167530225], "unit": "score", "name": "DeltaBlue", "value": 382.8232200000001}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [945.179584120983], "unit": "score", "name": "RayTrace", "value": 782.908362}, {"lowerIsBetter": false, "replicates": [554.6311702717693], "unit": "score", "name": "Earley", "value": 1201.6327890000002}, {"lowerIsBetter": false, "replicates": [10989.130434782608], "unit": "score", "name": "Boyer", "value": 60.64747378832837}, {"lowerIsBetter": false, "replicates": [24190.47619047619], "unit": "score", "name": "RegExp", "value": 37.65882874015749}, {"lowerIsBetter": false, "replicates": [521.1047420531527], "unit": "score", "name": "Splay", "value": 156.38122899999993}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23061.089168812076}]} 03:19:37 INFO - RETURN: dromaeo_css: 7549.33 03:19:37 INFO - RETURN: kraken: 1475.80 03:19:37 INFO - RETURN: v8_7: 23061.09 03:19:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23061.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1475.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7549.33"}}} 03:19:37 INFO - Return code: 0 03:19:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:19:37 INFO - # TBPL SUCCESS # 03:19:37 INFO - Running post-action listener: _resource_record_post_action 03:19:37 INFO - Running post-run listener: _resource_record_post_run 03:19:38 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8089600; Write bytes: 479129600; Read time: 4112; Write time: 1368724 03:19:38 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 16384; Write bytes: 82526208; Read time: 524; Write time: 274796 03:19:38 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 6336512; Write bytes: 396603392; Read time: 3544; Write time: 1093928 03:19:38 INFO - Running post-run listener: _upload_blobber_files 03:19:38 INFO - Blob upload gear active. 03:19:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:19:38 INFO - Copying logs to upload dir... 03:19:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.887775 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 03:19:38.517320) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 03:19:38.520697) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010121 build_url: 'https://queue.taskcluster.net/v1/task/zAATMLZ6Rz-Q9Jb8jgkopw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 03:19:38.572848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 03:19:38.573239) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453543524.720997-1700490712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 03:19:38.623739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 03:19:38.624098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 03:19:38.624494) ========= ========= Total master_lag: 0.36 =========