builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1453561093.3 results: success (0) buildid: 20160123043428 builduid: 8e8aa56e42ab45a4af8dbc53de481fcc revision: a046dae8d8e4367d834da27005766a93e36c536e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.297750) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.298248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.298561) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004529 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.337505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.337806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.381129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.381442) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.432935) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.433206) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.433563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.433842) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 06:58:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.1M=0s 2016-01-23 06:58:13 (85.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.455102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.903806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.904231) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064340 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.989627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.989931) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a046dae8d8e4367d834da27005766a93e36c536e --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 a046dae8d8e4367d834da27005766a93e36c536e --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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 06:58:14,072 truncating revision to first 12 chars 2016-01-23 06:58:14,072 Setting DEBUG logging. 2016-01-23 06:58:14,072 attempt 1/10 2016-01-23 06:58:14,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a046dae8d8e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 06:58:14,295 unpacking tar archive at: mozilla-aurora-a046dae8d8e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.502119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.504434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.504749) ========= echo a046dae8d8e4367d834da27005766a93e36c536e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a046dae8d8e4367d834da27005766a93e36c536e'] 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a046dae8d8e4367d834da27005766a93e36c536e program finished with exit code 0 elapsedTime=0.004616 script_repo_revision: 'a046dae8d8e4367d834da27005766a93e36c536e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.555575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.555872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.567118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-23 06:58:14.567411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:58:14 INFO - MultiFileLogger online at 20160123 06:58:14 in /builds/slave/test-pgo 06:58:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:58:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:58:14 INFO - {'append_to_log': False, 06:58:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:58:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:58:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:58:14 INFO - 'branch': 'Mozilla-Aurora', 06:58:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:58:14 INFO - 'config_files': ('talos/linux_config.py',), 06:58:14 INFO - 'default_actions': ('clobber', 06:58:14 INFO - 'read-buildbot-config', 06:58:14 INFO - 'download-and-extract', 06:58:14 INFO - 'populate-webroot', 06:58:14 INFO - 'create-virtualenv', 06:58:14 INFO - 'install', 06:58:14 INFO - 'run-tests'), 06:58:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:58:14 INFO - 'download_minidump_stackwalk': True, 06:58:14 INFO - 'download_symbols': 'ondemand', 06:58:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:58:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:58:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:58:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:58:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:58:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:58:14 INFO - 'installer_path': 'installer.exe', 06:58:14 INFO - 'log_level': 'info', 06:58:14 INFO - 'log_name': 'talos', 06:58:14 INFO - 'log_to_console': True, 06:58:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:58:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:58:14 INFO - 'opt_config_files': (), 06:58:14 INFO - 'pip_index': False, 06:58:14 INFO - 'sps_profile': False, 06:58:14 INFO - 'sps_profile_interval': 0, 06:58:14 INFO - 'suite': 'dromaeojs-e10s', 06:58:14 INFO - 'system_bits': '32', 06:58:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:58:14 INFO - 'title': 'talos-linux64-ix-062', 06:58:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:58:14 INFO - 'use_talos_json': True, 06:58:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:58:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:58:14 INFO - 'work_dir': 'build'} 06:58:14 INFO - ##### 06:58:14 INFO - ##### Running clobber step. 06:58:14 INFO - ##### 06:58:14 INFO - Running pre-action listener: _resource_record_pre_action 06:58:14 INFO - Running main action method: clobber 06:58:14 INFO - rmtree: /builds/slave/test-pgo/build 06:58:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:58:19 INFO - Running post-action listener: _resource_record_post_action 06:58:19 INFO - ##### 06:58:19 INFO - ##### Running read-buildbot-config step. 06:58:19 INFO - ##### 06:58:19 INFO - Running pre-action listener: _resource_record_pre_action 06:58:19 INFO - Running main action method: read_buildbot_config 06:58:19 INFO - Using buildbot properties: 06:58:19 INFO - { 06:58:19 INFO - "properties": { 06:58:19 INFO - "buildnumber": 77, 06:58:19 INFO - "product": "firefox", 06:58:19 INFO - "script_repo_revision": "production", 06:58:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:58:19 INFO - "repository": "", 06:58:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:58:19 INFO - "buildid": "20160123043428", 06:58:19 INFO - "slavename": "talos-linux64-ix-062", 06:58:19 INFO - "pgo_build": "True", 06:58:19 INFO - "basedir": "/builds/slave/test-pgo", 06:58:19 INFO - "project": "", 06:58:19 INFO - "platform": "ubuntu64_hw", 06:58:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:58:19 INFO - "slavebuilddir": "test", 06:58:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:58:19 INFO - "branch": "mozilla-aurora", 06:58:19 INFO - "repo_path": "releases/mozilla-aurora", 06:58:19 INFO - "stage_platform": "linux64-pgo", 06:58:19 INFO - "builduid": "8e8aa56e42ab45a4af8dbc53de481fcc", 06:58:19 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:19 INFO - }, 06:58:19 INFO - "sourcestamp": { 06:58:19 INFO - "repository": "", 06:58:19 INFO - "hasPatch": false, 06:58:19 INFO - "project": "", 06:58:19 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 06:58:19 INFO - "changes": [ 06:58:19 INFO - { 06:58:19 INFO - "category": null, 06:58:19 INFO - "files": [ 06:58:19 INFO - { 06:58:19 INFO - "url": null, 06:58:19 INFO - "name": "https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 06:58:19 INFO - } 06:58:19 INFO - ], 06:58:19 INFO - "repository": "", 06:58:19 INFO - "rev": "a046dae8d8e4367d834da27005766a93e36c536e", 06:58:19 INFO - "who": "ffxbld", 06:58:19 INFO - "when": 1453561070, 06:58:19 INFO - "number": 7505280, 06:58:19 INFO - "comments": "No bug, Automated blocklist update from host bld-linux64-spot-432 - a=blocklist-update", 06:58:19 INFO - "project": "", 06:58:19 INFO - "at": "Sat 23 Jan 2016 06:57:50", 06:58:19 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 06:58:19 INFO - "revlink": "", 06:58:19 INFO - "properties": [ 06:58:19 INFO - [ 06:58:19 INFO - "buildid", 06:58:19 INFO - "20160123043428", 06:58:19 INFO - "Change" 06:58:19 INFO - ], 06:58:19 INFO - [ 06:58:19 INFO - "builduid", 06:58:19 INFO - "8e8aa56e42ab45a4af8dbc53de481fcc", 06:58:19 INFO - "Change" 06:58:19 INFO - ], 06:58:19 INFO - [ 06:58:19 INFO - "pgo_build", 06:58:19 INFO - "True", 06:58:19 INFO - "Change" 06:58:19 INFO - ] 06:58:19 INFO - ], 06:58:19 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:19 INFO - } 06:58:19 INFO - ], 06:58:19 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:19 INFO - } 06:58:19 INFO - } 06:58:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 06:58:19 INFO - Running post-action listener: _resource_record_post_action 06:58:19 INFO - ##### 06:58:19 INFO - ##### Running download-and-extract step. 06:58:19 INFO - ##### 06:58:19 INFO - Running pre-action listener: _resource_record_pre_action 06:58:19 INFO - Running main action method: download_and_extract 06:58:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 06: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')]} 06:58:19 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json 06:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json 06:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:58:20 INFO - Downloaded 1302 bytes. 06:58:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:58:20 INFO - Using the following test package requirements: 06:58:20 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:20 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:58:20 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'jsshell-linux-x86_64.zip'], 06:58:20 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:58:20 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:20 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:58:20 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:58:20 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:58:20 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:20 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:58:20 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:58:20 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')]} 06:58:20 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:26 INFO - Downloaded 23159733 bytes. 06:58:26 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 06:58:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:26 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 06:58:27 INFO - Return code: 0 06:58:27 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 06:58:27 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')]} 06:58:27 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:36 INFO - Downloaded 23159733 bytes. 06:58:36 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 06:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:36 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 06:58:37 INFO - Return code: 0 06:58:37 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')]} 06:58:37 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:39 INFO - Downloaded 11132038 bytes. 06:58:39 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 06:58:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:39 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 06:58:39 INFO - Return code: 0 06: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')]} 06:58:39 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 06:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 06:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/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 06:58:42 INFO - Downloaded 58024306 bytes. 06:58:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 06:58:42 INFO - mkdir: /builds/slave/test-pgo/properties 06:58:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:58:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:58:42 INFO - Contents: 06:58:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 06:58:42 INFO - Running post-action listener: _resource_record_post_action 06:58:42 INFO - Running post-action listener: set_extra_try_arguments 06:58:42 INFO - ##### 06:58:42 INFO - ##### Running populate-webroot step. 06:58:42 INFO - ##### 06:58:42 INFO - Running pre-action listener: _resource_record_pre_action 06:58:42 INFO - Running main action method: populate_webroot 06:58:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:42 INFO - '--tppagecycles', 06:58:42 INFO - '7'], 06:58:42 INFO - 'tests': ['tsvgm']}}, 06:58:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:58:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'tests': ['damp', 'tps']}, 06:58:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['damp', 'tps']}, 06:58:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:58:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:42 INFO - 'other': {'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'other_l64': {'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'other_nol64': {'tests': ['a11yr', 06:58:42 INFO - 'ts_paint', 06:58:42 INFO - 'tpaint', 06:58:42 INFO - 'sessionrestore', 06:58:42 INFO - 'sessionrestore_no_auto_restore']}, 06:58:42 INFO - 'svgr': {'tests': ['tsvgx', 06:58:42 INFO - 'tsvgr_opacity', 06:58:42 INFO - 'tart', 06:58:42 INFO - 'tscrollx', 06:58:42 INFO - 'cart']}, 06:58:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['tsvgx', 06:58:42 INFO - 'tsvgr_opacity', 06:58:42 INFO - 'tart', 06:58:42 INFO - 'tscrollx', 06:58:42 INFO - 'cart']}, 06:58:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'tests': ['tp5o']}, 06:58:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'talos_options': ['--e10s'], 06:58:42 INFO - 'tests': ['tp5o']}, 06:58:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'talos_options': ['--xperf_path', 06:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:42 INFO - 'tests': ['tp5n']}, 06:58:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:42 INFO - 'talos_options': ['--e10s', 06:58:42 INFO - '--xperf_path', 06:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:42 INFO - 'tests': ['tp5n']}}, 06:58:42 INFO - 'talos.zip': {'path': '', 06:58:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:42 INFO - Running post-action listener: _resource_record_post_action 06:58:42 INFO - ##### 06:58:42 INFO - ##### Running create-virtualenv step. 06:58:42 INFO - ##### 06:58:42 INFO - Running pre-action listener: _resource_record_pre_action 06:58:42 INFO - Running main action method: create_virtualenv 06:58:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:58:42 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 06:58:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:58:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:42 INFO - Using real prefix '/usr' 06:58:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:58:42 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:44 INFO - Installing pip.................done. 06:58:44 INFO - Return code: 0 06:58:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 06: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 pip>=1.5 06:58:44 INFO - Using env: {'DISPLAY': ':0', 06:58:44 INFO - 'HOME': '/home/cltbld', 06:58:44 INFO - 'LANG': 'en_US.UTF-8', 06:58:44 INFO - 'LANGUAGE': 'en_US:en', 06:58:44 INFO - 'LOGNAME': 'cltbld', 06:58:44 INFO - 'MAIL': '/var/mail/cltbld', 06:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:44 INFO - 'MOZ_NO_REMOTE': '1', 06:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:44 INFO - 'NO_EM_RESTART': '1', 06:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:44 INFO - 'SHELL': '/bin/bash', 06:58:44 INFO - 'SHLVL': '1', 06:58:44 INFO - 'TERM': 'linux', 06:58:44 INFO - 'TMOUT': '86400', 06:58:44 INFO - 'USER': 'cltbld', 06:58:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:44 INFO - '_': '/tools/buildbot/bin/python'} 06:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:45 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 06:58:45 INFO - Cleaning up... 06:58:45 INFO - Return code: 0 06:58:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:58:45 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')]} 06:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:45 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')]} 06:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:45 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:58:45 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 06:58:45 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 06:58:45 INFO - Using env: {'DISPLAY': ':0', 06:58:45 INFO - 'HOME': '/home/cltbld', 06:58:45 INFO - 'LANG': 'en_US.UTF-8', 06:58:45 INFO - 'LANGUAGE': 'en_US:en', 06:58:45 INFO - 'LOGNAME': 'cltbld', 06:58:45 INFO - 'MAIL': '/var/mail/cltbld', 06:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:45 INFO - 'MOZ_NO_REMOTE': '1', 06:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:45 INFO - 'NO_EM_RESTART': '1', 06:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:45 INFO - 'SHELL': '/bin/bash', 06:58:45 INFO - 'SHLVL': '1', 06:58:45 INFO - 'TERM': 'linux', 06:58:45 INFO - 'TMOUT': '86400', 06:58:45 INFO - 'USER': 'cltbld', 06:58:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:45 INFO - '_': '/tools/buildbot/bin/python'} 06:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:45 INFO - Downloading/unpacking psutil>=0.7.1 06: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 06: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 06: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 06: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 06: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 06: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 06:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:47 INFO - Installing collected packages: psutil 06:58:47 INFO - Running setup.py install for psutil 06:58:47 INFO - building 'psutil._psutil_linux' extension 06:58:47 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 06:58:48 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 06:58:48 INFO - building 'psutil._psutil_posix' extension 06:58:48 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 06:58:49 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 06:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:49 INFO - Successfully installed psutil 06:58:49 INFO - Cleaning up... 06:58:49 INFO - Return code: 0 06:58:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:58:49 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')]} 06:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:49 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')]} 06:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:49 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:58:49 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 06:58:49 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 06:58:49 INFO - Using env: {'DISPLAY': ':0', 06:58:49 INFO - 'HOME': '/home/cltbld', 06:58:49 INFO - 'LANG': 'en_US.UTF-8', 06:58:49 INFO - 'LANGUAGE': 'en_US:en', 06:58:49 INFO - 'LOGNAME': 'cltbld', 06:58:49 INFO - 'MAIL': '/var/mail/cltbld', 06:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:49 INFO - 'MOZ_NO_REMOTE': '1', 06:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:49 INFO - 'NO_EM_RESTART': '1', 06:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:49 INFO - 'SHELL': '/bin/bash', 06:58:49 INFO - 'SHLVL': '1', 06:58:49 INFO - 'TERM': 'linux', 06:58:49 INFO - 'TMOUT': '86400', 06:58:49 INFO - 'USER': 'cltbld', 06:58:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:49 INFO - '_': '/tools/buildbot/bin/python'} 06:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06: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 06: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 06: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 06: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 06: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 06: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 06:58:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:51 INFO - Installing collected packages: mozsystemmonitor 06:58:51 INFO - Running setup.py install for mozsystemmonitor 06:58:51 INFO - Successfully installed mozsystemmonitor 06:58:51 INFO - Cleaning up... 06:58:51 INFO - Return code: 0 06:58:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:58:51 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')]} 06:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:51 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')]} 06:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:51 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:58:51 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 06:58:51 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 06:58:51 INFO - Using env: {'DISPLAY': ':0', 06:58:51 INFO - 'HOME': '/home/cltbld', 06:58:51 INFO - 'LANG': 'en_US.UTF-8', 06:58:51 INFO - 'LANGUAGE': 'en_US:en', 06:58:51 INFO - 'LOGNAME': 'cltbld', 06:58:51 INFO - 'MAIL': '/var/mail/cltbld', 06:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:51 INFO - 'MOZ_NO_REMOTE': '1', 06:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:51 INFO - 'NO_EM_RESTART': '1', 06:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:51 INFO - 'SHELL': '/bin/bash', 06:58:51 INFO - 'SHLVL': '1', 06:58:51 INFO - 'TERM': 'linux', 06:58:51 INFO - 'TMOUT': '86400', 06:58:51 INFO - 'USER': 'cltbld', 06:58:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:51 INFO - '_': '/tools/buildbot/bin/python'} 06:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:51 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 06:58:51 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 06:58:51 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 06:58:51 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 06:58:51 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 06:58:51 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 06:58:53 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:53 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 06:58:53 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 06:58:53 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 06:58:53 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 06:58:53 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 06:58:53 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 06:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:54 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 06:58:54 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 06:58:54 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 06:58:54 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 06:58:54 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 06:58:54 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 06:58:54 INFO - Downloading docopt-0.6.1.tar.gz 06:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:54 INFO - Running setup.py install for blobuploader 06:58:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:58:54 INFO - Running setup.py install for requests 06:58:54 INFO - Running setup.py install for docopt 06:58:54 INFO - Successfully installed blobuploader requests docopt 06:58:54 INFO - Cleaning up... 06:58:54 INFO - Return code: 0 06:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58:54 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')]} 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:54 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')]} 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:54 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:58:54 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 06:58:54 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 06:58:54 INFO - Using env: {'DISPLAY': ':0', 06:58:54 INFO - 'HOME': '/home/cltbld', 06:58:54 INFO - 'LANG': 'en_US.UTF-8', 06:58:54 INFO - 'LANGUAGE': 'en_US:en', 06:58:54 INFO - 'LOGNAME': 'cltbld', 06:58:54 INFO - 'MAIL': '/var/mail/cltbld', 06:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:54 INFO - 'MOZ_NO_REMOTE': '1', 06:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:54 INFO - 'NO_EM_RESTART': '1', 06:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:54 INFO - 'SHELL': '/bin/bash', 06:58:54 INFO - 'SHLVL': '1', 06:58:54 INFO - 'TERM': 'linux', 06:58:54 INFO - 'TMOUT': '86400', 06:58:54 INFO - 'USER': 'cltbld', 06:58:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:54 INFO - '_': '/tools/buildbot/bin/python'} 06:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:55 INFO - Running setup.py (path:/tmp/pip-AW8rVW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:55 INFO - Running setup.py (path:/tmp/pip-SIYCUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:55 INFO - Running setup.py (path:/tmp/pip-6LjRLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:55 INFO - Running setup.py (path:/tmp/pip-v6OnGb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:55 INFO - Running setup.py (path:/tmp/pip-Go29b0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:55 INFO - Running setup.py (path:/tmp/pip-Tx1VTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:55 INFO - Running setup.py (path:/tmp/pip-le1lQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:55 INFO - Running setup.py (path:/tmp/pip-4laDOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:55 INFO - Running setup.py (path:/tmp/pip-mrD26R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:55 INFO - Running setup.py (path:/tmp/pip-hbcZdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:55 INFO - Running setup.py (path:/tmp/pip-xXR40Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:55 INFO - Running setup.py (path:/tmp/pip-vg1apM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:56 INFO - Running setup.py (path:/tmp/pip-s_sTF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:56 INFO - Running setup.py (path:/tmp/pip-TWqhlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:56 INFO - Running setup.py (path:/tmp/pip-0OTTyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:56 INFO - Running setup.py (path:/tmp/pip-188y4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:56 INFO - Running setup.py (path:/tmp/pip-BuLepY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:56 INFO - Running setup.py install for manifestparser 06:58:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:58:56 INFO - Running setup.py install for mozcrash 06:58:56 INFO - Running setup.py install for mozdebug 06:58:56 INFO - Running setup.py install for mozdevice 06:58:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:58:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:58:56 INFO - Running setup.py install for mozfile 06:58:56 INFO - Running setup.py install for mozhttpd 06:58:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozinfo 06:58:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozInstall 06:58:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozleak 06:58:57 INFO - Running setup.py install for mozlog 06:58:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for moznetwork 06:58:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozprocess 06:58:57 INFO - Running setup.py install for mozprofile 06:58:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozrunner 06:58:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:58:57 INFO - Running setup.py install for mozscreenshot 06:58:57 INFO - Running setup.py install for moztest 06:58:58 INFO - Running setup.py install for mozversion 06:58:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:58:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:58 INFO - Cleaning up... 06:58:58 INFO - Return code: 0 06:58:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58:58 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')]} 06:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:58 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')]} 06:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:58 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:58:58 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 06:58:58 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 06:58:58 INFO - Using env: {'DISPLAY': ':0', 06:58:58 INFO - 'HOME': '/home/cltbld', 06:58:58 INFO - 'LANG': 'en_US.UTF-8', 06:58:58 INFO - 'LANGUAGE': 'en_US:en', 06:58:58 INFO - 'LOGNAME': 'cltbld', 06:58:58 INFO - 'MAIL': '/var/mail/cltbld', 06:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:58 INFO - 'MOZ_NO_REMOTE': '1', 06:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:58 INFO - 'NO_EM_RESTART': '1', 06:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:58 INFO - 'SHELL': '/bin/bash', 06:58:58 INFO - 'SHLVL': '1', 06:58:58 INFO - 'TERM': 'linux', 06:58:58 INFO - 'TMOUT': '86400', 06:58:58 INFO - 'USER': 'cltbld', 06:58:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:58 INFO - '_': '/tools/buildbot/bin/python'} 06:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:58 INFO - Running setup.py (path:/tmp/pip-wh90Xz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:58 INFO - Running setup.py (path:/tmp/pip-lyr5qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:58 INFO - Running setup.py (path:/tmp/pip-apyhHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:58 INFO - Running setup.py (path:/tmp/pip-VCLKOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:58 INFO - Running setup.py (path:/tmp/pip-EJNy25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:58 INFO - Running setup.py (path:/tmp/pip-_S6zEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:58 INFO - Running setup.py (path:/tmp/pip-6g1A9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:58 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)) 06:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:58 INFO - Running setup.py (path:/tmp/pip-IGxu9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:59 INFO - Running setup.py (path:/tmp/pip-iTKp9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:59 INFO - Running setup.py (path:/tmp/pip-ser9cO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:59 INFO - Running setup.py (path:/tmp/pip-x9frwu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:59 INFO - Running setup.py (path:/tmp/pip-3K546M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:59 INFO - Running setup.py (path:/tmp/pip-i9hvEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:59 INFO - Running setup.py (path:/tmp/pip-U9Zr53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:59 INFO - Running setup.py (path:/tmp/pip-z5enhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:59 INFO - Running setup.py (path:/tmp/pip-UNR2v8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:59 INFO - Running setup.py (path:/tmp/pip-TWXbJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:59 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)) 06:58:59 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)) 06:58:59 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)) 06:58:59 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)) 06:58:59 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)) 06:58:59 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)) 06:58:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06: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 06: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 06: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 06: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 06: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 06: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 06:59:01 INFO - Downloading blessings-1.6.tar.gz 06:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:01 INFO - Installing collected packages: blessings 06:59:01 INFO - Running setup.py install for blessings 06:59:01 INFO - Successfully installed blessings 06:59:01 INFO - Cleaning up... 06:59:01 INFO - Return code: 0 06:59:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:59:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:59:01 INFO - Reading from file tmpfile_stdout 06:59:01 INFO - Current package versions: 06:59:01 INFO - argparse == 1.2.1 06:59:01 INFO - blessings == 1.6 06:59:01 INFO - blobuploader == 1.2.4 06:59:01 INFO - docopt == 0.6.1 06:59:01 INFO - manifestparser == 1.1 06:59:01 INFO - mozInstall == 1.12 06:59:01 INFO - mozcrash == 0.16 06:59:01 INFO - mozdebug == 0.1 06:59:01 INFO - mozdevice == 0.47 06:59:01 INFO - mozfile == 1.2 06:59:01 INFO - mozhttpd == 0.7 06:59:01 INFO - mozinfo == 0.9 06:59:01 INFO - mozleak == 0.1 06:59:01 INFO - mozlog == 3.1 06:59:01 INFO - moznetwork == 0.27 06:59:01 INFO - mozprocess == 0.22 06:59:01 INFO - mozprofile == 0.27 06:59:01 INFO - mozrunner == 6.11 06:59:01 INFO - mozscreenshot == 0.1 06:59:01 INFO - mozsystemmonitor == 0.0 06:59:01 INFO - moztest == 0.7 06:59:01 INFO - mozversion == 1.4 06:59:01 INFO - psutil == 3.1.1 06:59:01 INFO - requests == 1.2.3 06:59:01 INFO - wsgiref == 0.1.2 06:59:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:59:01 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')]} 06:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:01 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')]} 06:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:01 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:59:01 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 06:59:01 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 06:59:01 INFO - Using env: {'DISPLAY': ':0', 06:59:01 INFO - 'HOME': '/home/cltbld', 06:59:01 INFO - 'LANG': 'en_US.UTF-8', 06:59:01 INFO - 'LANGUAGE': 'en_US:en', 06:59:01 INFO - 'LOGNAME': 'cltbld', 06:59:01 INFO - 'MAIL': '/var/mail/cltbld', 06:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:01 INFO - 'MOZ_NO_REMOTE': '1', 06:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:01 INFO - 'NO_EM_RESTART': '1', 06:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:01 INFO - 'SHELL': '/bin/bash', 06:59:01 INFO - 'SHLVL': '1', 06:59:01 INFO - 'TERM': 'linux', 06:59:01 INFO - 'TMOUT': '86400', 06:59:01 INFO - 'USER': 'cltbld', 06:59:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:01 INFO - '_': '/tools/buildbot/bin/python'} 06:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 INFO - Cleaning up... 06:59:02 INFO - Return code: 0 06:59:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:59:02 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')]} 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 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')]} 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:59:02 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 06:59:02 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 06:59:02 INFO - Using env: {'DISPLAY': ':0', 06:59:02 INFO - 'HOME': '/home/cltbld', 06:59:02 INFO - 'LANG': 'en_US.UTF-8', 06:59:02 INFO - 'LANGUAGE': 'en_US:en', 06:59:02 INFO - 'LOGNAME': 'cltbld', 06:59:02 INFO - 'MAIL': '/var/mail/cltbld', 06:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:02 INFO - 'MOZ_NO_REMOTE': '1', 06:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:02 INFO - 'NO_EM_RESTART': '1', 06:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:02 INFO - 'SHELL': '/bin/bash', 06:59:02 INFO - 'SHLVL': '1', 06:59:02 INFO - 'TERM': 'linux', 06:59:02 INFO - 'TMOUT': '86400', 06:59:02 INFO - 'USER': 'cltbld', 06:59:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:02 INFO - '_': '/tools/buildbot/bin/python'} 06:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:02 INFO - Downloading/unpacking jsonschema 06: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 06: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 06: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 06: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 06: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 06: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 06:59:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:04 INFO - Downloading/unpacking functools32 (from jsonschema) 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:04 INFO - warning: no files found matching '*.txt' 06:59:04 INFO - no previously-included directories found matching 'build' 06:59:04 INFO - no previously-included directories found matching 'dist' 06:59:04 INFO - no previously-included directories found matching '.git*' 06:59:04 INFO - Installing collected packages: jsonschema, functools32 06:59:04 INFO - Running setup.py install for functools32 06:59:04 INFO - warning: no files found matching '*.txt' 06:59:04 INFO - no previously-included directories found matching 'build' 06:59:04 INFO - no previously-included directories found matching 'dist' 06:59:04 INFO - no previously-included directories found matching '.git*' 06:59:04 INFO - Successfully installed jsonschema functools32 06:59:04 INFO - Cleaning up... 06:59:04 INFO - Return code: 0 06:59:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:59:04 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')]} 06:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:04 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')]} 06:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:04 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 0x7f863f053f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', '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 06:59:04 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 06:59:04 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 06:59:04 INFO - Using env: {'DISPLAY': ':0', 06:59:04 INFO - 'HOME': '/home/cltbld', 06:59:04 INFO - 'LANG': 'en_US.UTF-8', 06:59:04 INFO - 'LANGUAGE': 'en_US:en', 06:59:04 INFO - 'LOGNAME': 'cltbld', 06:59:04 INFO - 'MAIL': '/var/mail/cltbld', 06:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:04 INFO - 'MOZ_NO_REMOTE': '1', 06:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:04 INFO - 'NO_EM_RESTART': '1', 06:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:04 INFO - 'SHELL': '/bin/bash', 06:59:04 INFO - 'SHLVL': '1', 06:59:04 INFO - 'TERM': 'linux', 06:59:04 INFO - 'TMOUT': '86400', 06:59:04 INFO - 'USER': 'cltbld', 06:59:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:04 INFO - '_': '/tools/buildbot/bin/python'} 06:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:04 INFO - Downloading/unpacking flake8 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:04 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 06:59:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:59:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:59:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:06 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 06:59:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:59:07 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 06:59:07 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 06:59:07 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 06:59:07 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 06:59:07 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 06:59:07 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 06:59:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:59:07 INFO - no previously-included directories found matching 'docs/_build' 06:59:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:59:07 INFO - Running setup.py install for pep8 06:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:59:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:59:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:59:07 INFO - no previously-included directories found matching 'docs/_build' 06:59:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:59:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:59:07 INFO - Cleaning up... 06:59:07 INFO - Return code: 0 06:59:07 INFO - Running post-action listener: _resource_record_post_action 06:59:07 INFO - Running post-action listener: _start_resource_monitoring 06:59:07 INFO - Starting resource monitoring. 06:59:07 INFO - ##### 06:59:07 INFO - ##### Running install step. 06:59:07 INFO - ##### 06:59:07 INFO - Running pre-action listener: _resource_record_pre_action 06:59:07 INFO - Running main action method: install 06:59:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:59:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:59:07 INFO - Reading from file tmpfile_stdout 06:59:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:59:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:59:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:59:07 INFO - Reading from file tmpfile_stdout 06:59:07 INFO - Output received: 06:59:07 INFO - Usage: mozinstall [options] installer 06:59:07 INFO - Options: 06:59:07 INFO - -h, --help show this help message and exit 06:59:07 INFO - -d DEST, --destination=DEST 06:59:07 INFO - Directory to install application into. [default: 06:59:07 INFO - "/builds/slave/test-pgo"] 06:59:07 INFO - --app=APP Application being installed. [default: firefox] 06:59:07 INFO - mkdir: /builds/slave/test-pgo/build/application 06:59:07 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'] 06:59:07 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 06:59:22 INFO - Reading from file tmpfile_stdout 06:59:22 INFO - Output received: 06:59:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:59:22 INFO - Running post-action listener: _resource_record_post_action 06:59:22 INFO - ##### 06:59:22 INFO - ##### Running run-tests step. 06:59:22 INFO - ##### 06:59:22 INFO - Running pre-action listener: _resource_record_pre_action 06:59:22 INFO - Running main action method: run_tests 06:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:59:22 INFO - Python 2.7.3 06:59:22 INFO - Return code: 0 06:59:22 INFO - grabbing minidump binary from tooltool 06:59:22 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')]} 06:59:22 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 0x1f88a50>, '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 0x1ef4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef49e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:59:22 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 06:59:22 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 06:59:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:22 INFO - Return code: 0 06:59:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:59:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:59:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:59:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:59:23 INFO - Return code: 0 06:59:23 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:59:23 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 06:59:23 INFO - Using env: {'DISPLAY': ':0', 06:59:23 INFO - 'HOME': '/home/cltbld', 06:59:23 INFO - 'LANG': 'en_US.UTF-8', 06:59:23 INFO - 'LANGUAGE': 'en_US:en', 06:59:23 INFO - 'LOGNAME': 'cltbld', 06:59:23 INFO - 'MAIL': '/var/mail/cltbld', 06:59:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:59:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:23 INFO - 'MOZ_NO_REMOTE': '1', 06:59:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:23 INFO - 'NO_EM_RESTART': '1', 06:59:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:59:23 INFO - 'SHELL': '/bin/bash', 06:59:23 INFO - 'SHLVL': '1', 06:59:23 INFO - 'TERM': 'linux', 06:59:23 INFO - 'TMOUT': '86400', 06:59:23 INFO - 'USER': 'cltbld', 06:59:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610', 06:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:23 INFO - '_': '/tools/buildbot/bin/python'} 06:59:23 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 06:59:24 INFO - mozversion INFO | application_buildid: 20160123043428 06:59:24 INFO - mozversion INFO | application_changeset: a046dae8d8e4367d834da27005766a93e36c536e 06:59:24 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 06:59:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:24 INFO - mozversion INFO | application_name: Firefox 06:59:24 INFO - mozversion INFO | application_remotingname: firefox-dev 06:59:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:24 INFO - mozversion INFO | application_vendor: Mozilla 06:59:24 INFO - mozversion INFO | application_version: 45.0a2 06:59:24 INFO - mozversion INFO | platform_buildid: 20160123043428 06:59:24 INFO - mozversion INFO | platform_changeset: a046dae8d8e4367d834da27005766a93e36c536e 06:59:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:24 INFO - mozversion INFO | platform_version: 45.0a2 06:59:24 INFO - 2016-01-23 06:59:24,303 DEBUG : using testdate: 1453561164 06:59:24 INFO - 2016-01-23 06:59:24,303 DEBUG : actual date: 1453561164 06:59:24 INFO - 2016-01-23 06:59:24,312 INFO : starting webserver on 'localhost:45283' 06:59:24 INFO - 2016-01-23 06:59:24,312 INFO : Starting test suite talos-linux64-ix-062.e 06:59:24 INFO - 2016-01-23 06:59:24,312 INFO : Starting test dromaeo_css 06:59:24 INFO - 2016-01-23 06:59:24,312 DEBUG : operating with platform_type : linux_ 06:59:24 INFO - 2016-01-23 06:59:24,313 INFO : Initialising browser for dromaeo_css test... 06:59:24 INFO - 2016-01-23 06:59:24,346 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8q1WQ/profile http://localhost:45283/getInfo.html 06:59:28 INFO - 2016-01-23 06:59:28,528 DEBUG : BROWSER_OUTPUT: 06:59:28 INFO - 2016-01-23 06:59:28,528 DEBUG : BROWSER_OUTPUT: (process:3425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:29 INFO - 2016-01-23 06:59:29,392 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:59:29 INFO - 2016-01-23 06:59:29,392 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:59:29 INFO - 2016-01-23 06:59:29,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:59:29 INFO - 2016-01-23 06:59:29,393 DEBUG : BROWSER_OUTPUT: __metrics 06:59:30 INFO - 2016-01-23 06:59:30,284 INFO : Browser initialized. 06:59:30 INFO - 2016-01-23 06:59:30,284 INFO : Running cycle 1/1 for dromaeo_css test... 06:59:30 INFO - 2016-01-23 06:59:30,285 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8q1WQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:59:31 INFO - 2016-01-23 06:59:31,527 DEBUG : BROWSER_OUTPUT: 06:59:31 INFO - 2016-01-23 06:59:31,527 DEBUG : BROWSER_OUTPUT: (process:3541): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:42 INFO - 2016-01-23 06:59:42,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 135938048 06:59:42 INFO - 2016-01-23 06:59:42,032 DEBUG : BROWSER_OUTPUT: 07:00:31 INFO - 2016-01-23 07:00:31,669 DEBUG : BROWSER_OUTPUT: 1453561231664 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] 07:02:40 INFO - 2016-01-23 07:02:40,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45283/tests/dromaeo/cssquery-ext.html) 07:02:41 INFO - 2016-01-23 07:02:41,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 140701696 07:02:41 INFO - 2016-01-23 07:02:41,145 DEBUG : BROWSER_OUTPUT: 07:05:42 INFO - 2016-01-23 07:05:42,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-ext.html (next: http://localhost:45283/tests/dromaeo/cssquery-jquery.html) 07:05:43 INFO - 2016-01-23 07:05:43,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 139304960 07:05:43 INFO - 2016-01-23 07:05:43,546 DEBUG : BROWSER_OUTPUT: 07:08:45 INFO - 2016-01-23 07:08:45,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45283/tests/dromaeo/cssquery-mootools.html) 07:08:45 INFO - 2016-01-23 07:08:45,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 07:08:45 INFO - 2016-01-23 07:08:45,789 DEBUG : BROWSER_OUTPUT: 07:11:47 INFO - 2016-01-23 07:11:47,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45283/tests/dromaeo/cssquery-prototype.html) 07:11:47 INFO - 2016-01-23 07:11:47,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 139554816 07:11:47 INFO - 2016-01-23 07:11:47,984 DEBUG : BROWSER_OUTPUT: 07:14:50 INFO - 2016-01-23 07:14:50,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45283/tests/dromaeo/cssquery-yui.html) 07:14:50 INFO - 2016-01-23 07:14:50,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 140046336 07:14:50 INFO - 2016-01-23 07:14:50,766 DEBUG : BROWSER_OUTPUT: 07:17:52 INFO - 2016-01-23 07:17:52,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/dromaeo/cssquery-yui.html (next: http://localhost:45283/tests/dromaeo/cssquery-dojo.html) 07:17:53 INFO - 2016-01-23 07:17:53,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 07:17:53 INFO - 2016-01-23 07:17:53,182 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,183 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:53 INFO - 2016-01-23 07:17:53,183 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:53 INFO - 2016-01-23 07:17:53,183 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:53 INFO - 2016-01-23 07:17:53,184 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:53 INFO - 2016-01-23 07:17:53,184 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3207.9198020049503;3263.86944522219;3272.280098378357;3275.803451792894;3292.4238258304804;5500.862478438031;5537.778488860446;5550.139728342103;5558.360788509322;5573.6098473106895;5549.223108764776;5561.944380556193;5563;5569.693666848321;5587.525060369863;5068.5945124390055;5074.847754567369;5132.496513249655;5169.327987361657;5184.818531351403;4931.950680493185;5084.262781896623;5111.054454925832;5114.718690472023;5185.974070129644;5066.569341605949;5119.56483698886;5160.845174644766;5182.7149506777305;5203.583713302926;5179.404368497614;5260.736963151827;5261.710605916673;5270.077736396153;5300.337457817773;4890.315355850184;4927.7536123193695;4997.375328083989;5128.25640282157;5148.871278218075;5302.09864323066;5364.061289274361;5426.294581704393;5445.618806683534;5458.808941687062;5956.612820166719;6008;6020.759169633253;6083.11794789753;6094.963856144422;5789.160571717078;5921.526277897758;6060;6102.176206212193;6180;5637.3517045539875;5642.210090587321;5660.716964151776;5661;5683.2895888014;6114.327423983358;6127.969360153171;6129.969350153221;6142.416470435302;6144.569880108439;5621.128725047624;5710.942890571041;5733.942660573424;5737.196792449061;5856.707164641751;5964.403559644088;6045.0327947528185;6073.908891366633;6090.299615544181;6094.6647934363145;6002.519798416116;6003.189569408074;6008.24896887889;6010.429009244115;6026.427489388501;5836.766529338864;5921.230240068763;5931.228940237827;6026.819195424145;6047.485963693048;4583.449986001701;4589.58693717567;4628.976855115703;4650.906981860344;4652.906941861143;4119.340905455113;4133.503979522417;4150.709450338508;4154.937675934863;4157.314043182841;5474.370447398521;5515.420880807537;5595.328560572757;5642.830715078472;5649;5924.289085309791;5998.130271110665;6001.309849367379;6003.339632640406;6012;5537.501624853702;5748.109043098327;5750.051241545182;5754.884902302014;5758.107493338539;5173.896522069537;5224.52979231871;5300.151975683949;5305.4164041955355;5337.439568845293;6078.057901025348;6085.726142323606;6100.69496525172;6119.908201376983;6181.258249010148;5729.427057294237;5853.0635098384055;6035.124906888476;6049.909251361145;6060.272767267956;6085.056816193497;6151.907721384094;6172.043333283348;6192.845178870564;6200.472959798468;6007.4643644048465;6032.095185722177;6038.245219347582;6041.697915104315;6044.365341639064;5905.881882362414;5945.10823376497;6089.48239399656;6174.8147555573405;6177.444030037318;5867.383924687846;5905.527557795452;5907;5909.52723782105;6028.668423236764;5833.300003999547;5871.442212989759;5875.353711091691;5883.176355310175;5919.348871624032;5622.072358061037;5664.37691853904;5692.686902220252;5757.884842303214;5817.749183925476;5885.970570147122;5887.1757953885635;5930.169776231245;5940.940590594038;5956.076808094752;5706.572007099568;5763.308402991668;5767.077267637158;5772.105323674838;5772.769089236552 07:17:53 INFO - 2016-01-23 07:17:53,187 DEBUG : BROWSER_OUTPUT: |1;ext.html;593.851537115721;613.8311964209843;622.8598565322801;632.5098049012018;642.1395330257454;40283.79858100709;40792.796036019776;41026.38460423089;41050.38424423636;41054.17891642165;44342.00460979256;44780.3282950756;44873.551264487425;44914.55085449145;44928.77535612325;8895.243904268129;8976.41653292534;9017.639294428214;9024.954875225614;9067.818643627124;8727.956360218222;8762.430442021248;8812.515311657857;8908.420952638091;8911.55442227886;8868.113188681113;8882.600282987249;8945.64217431302;8950.820983580325;8977.608470687053;8837.072107428723;8874.911250887473;8933;8972.282217422591;8985.550722463884;8799;8876.289896808239;8973.775655608597;8978.775530611721;8986.056464071244;40902.38646420306;40950;41024.58975410237;41374;41514.1697166055;3220.1305647475283;3258.8245275203594;3372.106391806173;3629;3766.0961369271176;31587.52618710721;32070.679293207002;32641;32739.83630081858;32786.50820237699;4207.64235040022;4225.366195070764;4272.316429371285;4287.742735435884;4313.4176886120285;261745;263057;264536.67731661414;264638;266564;45046.32430513545;45814.39649612248;45829;46051.5394846054;46180.769096154305;43780;43786;43837.56162438335;43866;43967;16993.490195294162;17220.397286094925;17245.913770431067;17250.913745431444;17278.13609319529;13578.796318055238;13652.771250587297;13664.65838354049;13745;13783.724325513434;15265.465708700141;15498.070115793089;15530.689386212438;15583.532494025198;15617.921910390376;6268.937310626835;6286.277078135981;6286.968565157236;6323.652199129092;6385.48916086712;940.5391358234416;967.4002118686459;970.3013830042358;1002.3835341265069;1143.7369405036723;28174.71825281721;28354.149375518766;29019.854900725782;29064.709352906622;29180.416391672046;1075.655790147161;1091.6179337232063;1093.294824837975;1140.749035212252;1169.6491052684162;14654.267286635626;14684.853151468562;14795.482158124629;15108.848911510964;15350;495335;495480;498152;500893;823837;58294;58585.41414585885;58925.11612325819;59074.40925590775;59153.40846591479;1454.4763885001391;1463.5389852196524;1495.745723227054;1515.1363722677968;1529.9847001530065;30553.694463055086;31337.216569585944;31380.35249408997;31485.842570787;32128.67871321257;48303.27545086897;49060.75469622629;49390.50609493859;49649.503504965935;49675.50324496709;305185;308808;309751;310603;311161;34340.656593434745;34573.406994475015;34806.47790283097;34904.47643285403;35230.47154292637;45097.098058038;45480.31779523243;45814;46597.767011164724;46691.29963050625;38556.22887542177;38563.807180963915;39104.2179156421;39824;40768.59231407648;38125;38379.808100959315;39155;39262.21475570415;39265;37383.81308093442;37922;38216.61783382131;38241;38299.42550861795;32888.835555822065;34334.48498272478;34453.794117205776;34535.30929381348;38068.61931380651;26020.8698956504;27154.321141970817;28223.803015035333;30039.399212016073;30443.695563044086 07:17:53 INFO - 2016-01-23 07:17:53,189 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.8518320446628;385.021855944271;387.4420833999043;388.3320688415924;390.1942488760709;16873.915630421845;17670.469885903443;18801.62396752066;18878.24487020521;18888.1500332485;11400.828987565172;11722;12083.516659333638;17657.470275891712;17717.202725877334;4949.752512374376;4970.726610036447;4974.10466116099;5056.039352523027;5077.466865979074;4966.751662416883;5110.488951104897;5271.393789714174;5281.498257665516;5287.2862163608;5204.869878253036;5217.5565076968505;5240.44975277596;5261.289725887013;5450.427705090968;5525.392206857243;5542.279503664538;5564;5585.413531579186;5597.74810133545;5232.293640358541;5329.147336426153;5371.570274378079;5401.864953376197;5422.53908417785;13252.46990120394;13387.933060334733;13461.528846490326;16111.43609973657;21996.780032199633;2041.3773798991301;2082.739657542807;2205.8125059369972;2250.5948929192737;2302.7582103879186;10098.747531311703;10214.744631384201;10413.219008574388;11422.71443213918;13131.883789877871;1909.8281154696006;1935.7677078750498;1976.2786582897284;2010.9597808043904;2021.9393418197478;65831.341686583;67260;67664;67867.66066169637;67915;10948.233623646427;11088.168387370979;11187.216894817284;11236.325820450798;11282.435878206057;14662.780058299135;14775.113493190443;14776.113433194043;14815;14837.258137093102;8603.741887743377;8673.913260867437;8674.132586741402;8712.607932643046;8712.869306960401;8529;8545.359098067669;8548.316134709208;8583.39916205872;8593;4483.461984561874;4506.436695413074;4533.002739397327;4734.881627959328;4797.664163508521;1909.0931807391655;1915.2913422033657;1931.2757715856553;1948.4057362504573;2000.2399088346335;945.1163162443138;958.942463452195;965.3049804141007;965.7199412170391;1080.9027187553002;17170.742438863428;18065.2773889043;18069.457916262534;18093.63812723738;18102.913825170268;980.7302991677345;981.2738573455591;990.356009025015;1002.173207104142;1013.7566983923805;10135.391876487434;10203.234757393226;10231.232657550714;10233.897661023295;10604.045635892806;458495;459691;464005;490843;676603;82352;87691.56154219316;88220.55889720639;88682.55658721665;89812.5509372462;1173.976520469586;1199.6401079676061;1217.31221859649;1226.1845872494691;1244.6141696074246;15481.690366192839;15903.52289431319;16135.919320403324;16320.265588048804;16595.585110372336;36560.63439365679;36752;36850.8157459211;37869;38077.809610951765;45573;46881.29678054764;47862.80342991453;48263.75868120637;49255.753721231165;9674.56464459087;10168.440735759308;10179.541920613738;10192.490375481048;10337.689869303933;11616.709582260512;17166.570835729206;17930.65520086025;17943.371981980566;18274.725879111556;14353.712925741636;14414.639634008814;14470.20413877247;14470.493532726305;15082.698346033238;13709.108907920952;14182;14581.343839527459;14859.702805943605;15273.083614983136;14672.193029383487;14721.190334531275;15025.474108406153;15040.172790496628;15239.161846098572;9358.578863951274;9533.570989305359;9782.80434391294;9887.851682224917;9923.702288931343;13694.589162325146;14697;14726.484573040321;14772.18752968597;14854.108753474826 07:17:53 INFO - 2016-01-23 07:17:53,190 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486.0637798187147;1515.3938424630146;1542.8302886682466;1577.2902194012697;1604.5266646339328;7746.457747957646;7793.883091753628;8053.275205231535;8106.270435660789;8140.552269625168;7622;7630.236976302367;7682.0397450318715;7708.730194443196;7720.420968427362;2212.203606701586;2245.550889822034;2247.7302723673183;2258.7741225877444;2259.028617694391;2184.9235276765316;2231.319447568491;2231.6987206727044;2250.133698526071;2255.3459496745922;2214.767449417804;2250.7749225077523;2254.7632498587577;2257.085880218514;2258.9435264118447;2243.069126312578;2270.080617349976;2285.3029825903095;2310.9884450577724;2318.4899322149186;2283.4748007958265;2336.3925379401308;2337.439014636492;2342.0748804222235;2345.026813872241;7825.13923468418;7971.282584567359;7975.641096150629;7988.081370642392;8005.359571234288;4681.88295292617;4736.384270044907;4785.545373189541;4787.928181077286;4791.6406269529925;3049.2224482756756;3104.9689503105133;3137.1686503076703;3138.0428969164395;3149.889753858604;1031.6389263757624;1046.3774054437674;1086;1096.5613754498265;1098.9285696429706;10570.418626975514;10612.097971672418;10663.733406664818;10699.304545204615;10700.304480208839;4085.2460647054554;4110.691698122653;4113.115680128787;4170.395292682544;4172.749635021908;8861.069587693328;8864.379493435397;8867.600957956907;8873.023967363713;8902.643894244287;4692.6245900327895;4708.364370809897;4723.0789995951145;4726.125666751662;4737.692050016738;4337.7180483268485;4378.868633940987;4379.49635791888;4392.494863090722;4413.58070983256;3363.075154332578;3367.0572239772905;3376.139084533428;3393.185635447475;3407.1993081625797;975.5707488704948;1003.1373019203625;1007.7228762090338;1011.1304278320638;1011.7369483934231;993.980120397588;1065.8454524093963;1192.2607983050564;1335.2455862437691;1454.9927250363892;7184.712611495482;7240.275972402717;7274.345308922222;7322.304381083789;7500.062492188476;1049.7218237167158;1110.161827820007;1156.8206927926185;1163.8021536338674;1164.231607139284;5741.339745929188;5756.366799652035;5795.913061304083;5798.449147330997;5814.9709251454315;9467.763305917408;9513.904860951441;9655.710328690151;9721.70834874955;9811.558479868423;9512.95243523778;9516.666916657883;9541.52292385378;9567.37812042215;9658;7545.773626791205;7611.010568626154;7633.69465221385;7737.961310193413;7763.378929685611;7195.748148814766;7228.927710722825;7242.855142897007;7268.818279543054;7271.4182865369585;8399.370047246359;8440.66237350499;8597.312215022908;8706.869396959177;8751.081136480578;8682.262007729414;8769.429987050822;8771.561421929006;8824.867626985471;8940.240079593048;6851.520393572402;6916.412104970933;6929.480288978448;6932.653367331714;6951.7914462566205;7568.735094271674;7596.734114305973;7631.236876312324;7707.036620422447;7722.38220942312;6836.38472537474;7144.607046612278;7191.137063552407;7223.169335526271;7337.229590893093;7122.358987691133;7172.784816455514;7174.67713952863;7267.818304542428;7334.486585938933;6951.339622735832;7024.297570242935;7058;7075.646217688992;7088.397486213729;6490.902636460552;6493.090967264492;6495.642739649365;6496.382843629847;6530.869382612226;6399.136116624196;6572.211334639874;6576;6578.80263592093;6613.503987201076 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.7229288861799;358.98384572694226;360.73125521486486;361.726896193374;365.52481773694177;6198.44214020738;6325.367463253672;6356.2054743157105;6363.045543168527;6440.194975628052;6205.441510264075;6337.176167098282;6358.745650173987;6373.394527519889;6375.553711240215;4853.5874450671645;4868.756562171895;4869.050535145648;4874;4883.12103821312;4861.61107111432;4882.2432522959;4884.291777692232;4886.53577910098;4886.804527818883;4754.9286760698615;4837.5646191842725;4837.693822667878;4843.200871856139;4846.151923413388;4777.498362671939;4792.640551958617;4795.896943702968;4829.9275510867365;4832.903341933159;4215.704900656955;4227.577242275778;4235.301175306071;4246.957530424687;4249.830006799755;5901.203337549418;5980.102984552308;5981.222441082631;6016.42843929826;6050.72771725269;5570.359408667974;5650.660960342351;5661.150827375926;5665.348484924245;5679.09134538476;6717.42901853343;6727.461803055744;6729;6742.123523941906;6774.322567743236;4694.2723877799;4694.835680751192;4700.4594471635855;4705.435347758291;4717.599004084657;6873;6972.860542789116;6993.755218567377;7001.579905205704;7016.508844380895;4818.8795280118275;4818.98801251734;4824.300476430898;4827.444843842933;4831.5651591356245;4858.05267972742;4890.339804126468;4897.265410188429;4906.9263961040615;4908.067467181224;5556.277683901148;5632.746526406321;5638.971805140948;5643;5662.462066103713;6688.097106890605;6780;6800.08198893153;6817.318268173143;6820.3861652451515;1637.6560922206231;1678.5216213379128;1687.7299632058812;1692.7122389193867;1711.7517959895995;1133.6599020294043;1152.982705259422;1160.7620437810228;1167.480471190312;1171.9355435450962;6422.678866056678;6496.35036496356;6503.934960650333;6506.869862602722;6542.182227221598;6838.974153876959;6877.277885821916;6883.346082122191;6914.0666010089;6939.653017349112;6376.808695739135;6468.06213099098;6470.12653291809;6482.57863238888;6499.610023398611;3728.217074414403;3744.5319335083113;3764.4353346997623;3767.8869633911027;3776.754510956779;7085.96457017722;7107;7122.5726456412785;7134.714611415485;7138.143422789195;6966.338197871194;7084.185318688416;7096.574205547684;7099.467539934422;7128.786136415916;6986.615736134459;7028.683709233097;7072.823179420453;7077.186123595852;7087.539309944837;6855.828604284933;6884.070650462124;6894.413974812197;6956.0609317741455;6959.686814093479;6783.18601767791;6826.829329266808;6869.107016087876;6878.58728476293;6887.552309099892;7107.182673992557;7124;7130.215676275502;7131.893021604784;7147.714091436284;4808.06242782654;4809.495003024772;4812.446568644651;4830.082284365959;4833.927491087707;6841.315868413119;6904.551204171713;6919.965400172967;6938.8612227756175;7115.217326094022;6864.176298844171;6865.382115609419;6875.7937261882225;6881.002254673144;6901.896471553031;6819.624920629413;6820.522563420513;6846.281140480178;6854.657267136723;6866.313368663094;6592.70332835014;6735.831604209934;6747.392734653905;6748.561343512656;6757.493188010821;6831.760888368884;6869.690863911236;6872.244053154049;6875.868480770977;6891.241963383924;6613.074169616354;6631.204255489372;6658.900116498159;6665.466762659073;6679.098321726505 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: |5;yui.html;734;747.8579069976704;776.4099284543745;791.398537111795;846.8687353460214;14110.082844615106;14481.237521968786;14594.927025364872;14630.049046811962;15099.396024159021;14491.49279775208;14611.123332600026;14653.267336633153;14662.486812961548;14695.706085878302;896.0322851320591;898.469902757373;899.8425275576781;903.3631289940608;913.2648218184358;905.9909400906006;907.2424525521197;908.3596064774351;910.4901255297054;912.3886995712855;944.6174299408716;950.7575568230126;951.3578334624101;953.2945620241006;955.4888134847857;927.0312523412982;928.4429342394577;936.9906300936972;941.3928016429398;948.340903072365;706.1208795050144;706.2302090721088;707.9044329015569;708.4651088428204;710.4813486155135;14498.637534061627;14513.854861451357;14562.708745825024;14659.34032968519;14678.853211467855;12749.362531873368;12864.22814631125;12942.352882355844;13425.597232083053;13488.460461581524;9668.90331096687;9850.458224797634;10009.949950250275;10452.425116618582;10566.78866422675;3756.1924186300075;3775.8300876460626;3836.635519625631;3838.2899163654815;3840.2511510255513;49374.25938610924;50394.74802626;50413;50918.745406272734;51501;10271.383716977005;10570.735731606772;10772.353658780497;10811.78376432467;11030.944845275722;18152.546186345447;19208.327708530134;19214.231430742893;19239.615207695766;19282.90358548198;7474.215207403253;7657.808554786175;8159.347252219808;8202.056763472157;8479.279261262862;4564.178447879413;4588.174128656807;4601.67788254819;4687.460941991646;4783.880402989884;3274.623418306925;3328.4008878401637;3330.0675810773023;3342.4819153031317;3346.0631023313513;587.6797145555682;616.608453631947;626.7148447456397;635.1552435261184;641.1024565608186;701.7754318618096;705.92234854166;705.9717611295594;721.3147509865648;726.4079774983477;9190.415341792726;9266.397684150508;9480.146786789222;9627.470489123025;9885.555150018266;631.5137344244906;688.1913751342253;702.199492578461;726.0670038999965;768.7117331000875;4178.8717046397915;4498.167838949739;4506.895810526442;4512.458504979358;4595.195840727859;60062.699686501284;60076.69961650164;60527;60569.69715151396;61137;54162.45837541574;54995.450045499834;55264.72367638136;55549.722251388484;55676.72161639166;49834.25248621201;50387.24419133716;50707.23939140916;50921.74539127355;51057;8569.228769410784;8914.37599368038;9043.773905652411;9056.320775941962;9070.682526111554;36914.44628330523;36974.44538331981;37094.44358334573;37523.06192345104;38055.619443805204;44663.77668111639;45648;46070;46366.536334637574;46796.29805552988;12415.317157556421;12594.496220151092;12775.233485990499;13409.932950335577;13776.65558361049;12784.232946023269;13827;13877.583672489842;14654.780178297548;14676.41294348214;12702.237865728086;12723.87276127264;12876.742465150457;13075.803862941873;13369.799453008018;11684.88315116838;11716.179867409199;11761.470733816828;12240;12597.244165350108;12035.398230088636;12052.156349055482;12091.51633934668;12180.390980451119;12237.877621223673;11025.338479690923;11178.664640060812;11261.324320540794;11287.20989530725;11312.377819220023;10190.031946965026;10563.735906602396;10636;10778.29941053829;10840.349579025284 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,294 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562273182__endTimestamp 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5569.32 Median:5754.88 stddev:621.83 (10.8%) stddev-sans-first:595.51 07:17:53 INFO - 2016-01-23 07:17:53,194 DEBUG : BROWSER_OUTPUT: Values: 3207.9 3263.9 3272.3 3275.8 3292.4 5500.9 5537.8 5550.1 5558.4 5573.6 5549.2 5561.9 5563.0 5569.7 5587.5 5068.6 5074.8 5132.5 5169.3 5184.8 4932.0 5084.3 5111.1 5114.7 5186.0 5066.6 5119.6 5160.8 5182.7 5203.6 5179.4 5260.7 5261.7 5270.1 5300.3 4890.3 4927.8 4997.4 5128.3 5148.9 5302.1 5364.1 5426.3 5445.6 5458.8 5956.6 6008.0 6020.8 6083.1 6095.0 5789.2 5921.5 6060.0 6102.2 6180.0 5637.4 5642.2 5660.7 5661.0 5683.3 6114.3 6128.0 6130.0 6142.4 6144.6 5621.1 5710.9 5733.9 5737.2 5856.7 5964.4 6045.0 6073.9 6090.3 6094.7 6002.5 6003.2 6008.2 6010.4 6026.4 5836.8 5921.2 5931.2 6026.8 6047.5 4583.4 4589.6 4629.0 4650.9 4652.9 4119.3 4133.5 4150.7 4154.9 4157.3 5474.4 5515.4 5595.3 5642.8 5649.0 5924.3 5998.1 6001.3 6003.3 6012.0 5537.5 5748.1 5750.1 5754.9 5758.1 5173.9 5224.5 5300.2 5305.4 5337.4 6078.1 6085.7 6100.7 6119.9 6181.3 5729.4 5853.1 6035.1 6049.9 6060.3 6085.1 6151.9 6172.0 6192.8 6200.5 6007.5 6032.1 6038.2 6041.7 6044.4 5905.9 5945.1 6089.5 6174.8 6177.4 5867.4 5905.5 5907.0 5909.5 6028.7 5833.3 5871.4 5875.4 5883.2 5919.3 5622.1 5664.4 5692.7 5757.9 5817.7 5886.0 5887.2 5930.2 5940.9 5956.1 5706.6 5763.3 5767.1 5772.1 5772.8 07:17:53 INFO - 2016-01-23 07:17:53,195 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,195 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53810.07 Median:40053.90 stddev:108851.44 (271.8%) stddev-sans-first:109083.47 07:17:53 INFO - 2016-01-23 07:17:53,195 DEBUG : BROWSER_OUTPUT: Values: 593.9 613.8 622.9 632.5 642.1 40283.8 40792.8 41026.4 41050.4 41054.2 44342.0 44780.3 44873.6 44914.6 44928.8 8895.2 8976.4 9017.6 9025.0 9067.8 8728.0 8762.4 8812.5 8908.4 8911.6 8868.1 8882.6 8945.6 8950.8 8977.6 8837.1 8874.9 8933.0 8972.3 8985.6 8799.0 8876.3 8973.8 8978.8 8986.1 40902.4 40950.0 41024.6 41374.0 41514.2 3220.1 3258.8 3372.1 3629.0 3766.1 31587.5 32070.7 32641.0 32739.8 32786.5 4207.6 4225.4 4272.3 4287.7 4313.4 261745.0 263057.0 264536.7 264638.0 266564.0 45046.3 45814.4 45829.0 46051.5 46180.8 43780.0 43786.0 43837.6 43866.0 43967.0 16993.5 17220.4 17245.9 17250.9 17278.1 13578.8 13652.8 13664.7 13745.0 13783.7 15265.5 15498.1 15530.7 15583.5 15617.9 6268.9 6286.3 6287.0 6323.7 6385.5 940.5 967.4 970.3 1002.4 1143.7 28174.7 28354.1 29019.9 29064.7 29180.4 1075.7 1091.6 1093.3 1140.7 1169.6 14654.3 14684.9 14795.5 15108.8 15350.0 495335.0 495480.0 498152.0 500893.0 823837.0 58294.0 58585.4 58925.1 59074.4 59153.4 1454.5 1463.5 1495.7 1515.1 1530.0 30553.7 31337.2 31380.4 31485.8 32128.7 48303.3 49060.8 49390.5 49649.5 49675.5 305185.0 308808.0 309751.0 310603.0 311161.0 34340.7 34573.4 34806.5 34904.5 35230.5 45097.1 45480.3 45814.0 46597.8 46691.3 38556.2 38563.8 39104.2 39824.0 40768.6 38125.0 38379.8 39155.0 39262.2 39265.0 37383.8 37922.0 38216.6 38241.0 38299.4 32888.8 34334.5 34453.8 34535.3 38068.6 26020.9 27154.3 28223.8 30039.4 30443.7 07:17:53 INFO - 2016-01-23 07:17:53,195 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,195 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28651.56 Median:2031.66 stddev:84725.12 (4170.2%) stddev-sans-first:84936.21 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: Values: 384.9 385.0 387.4 388.3 390.2 16873.9 17670.5 18801.6 18878.2 18888.2 11400.8 11722.0 12083.5 17657.5 17717.2 4949.8 4970.7 4974.1 5056.0 5077.5 4966.8 5110.5 5271.4 5281.5 5287.3 5204.9 5217.6 5240.4 5261.3 5450.4 5525.4 5542.3 5564.0 5585.4 5597.7 5232.3 5329.1 5371.6 5401.9 5422.5 13252.5 13387.9 13461.5 16111.4 21996.8 2041.4 2082.7 2205.8 2250.6 2302.8 10098.7 10214.7 10413.2 11422.7 13131.9 1909.8 1935.8 1976.3 2011.0 2021.9 65831.3 67260.0 67664.0 67867.7 67915.0 10948.2 11088.2 11187.2 11236.3 11282.4 14662.8 14775.1 14776.1 14815.0 14837.3 8603.7 8673.9 8674.1 8712.6 8712.9 8529.0 8545.4 8548.3 8583.4 8593.0 4483.5 4506.4 4533.0 4734.9 4797.7 1909.1 1915.3 1931.3 1948.4 2000.2 945.1 958.9 965.3 965.7 1080.9 17170.7 18065.3 18069.5 18093.6 18102.9 980.7 981.3 990.4 1002.2 1013.8 10135.4 10203.2 10231.2 10233.9 10604.0 458495.0 459691.0 464005.0 490843.0 676603.0 82352.0 87691.6 88220.6 88682.6 89812.6 1174.0 1199.6 1217.3 1226.2 1244.6 15481.7 15903.5 16135.9 16320.3 16595.6 36560.6 36752.0 36850.8 37869.0 38077.8 45573.0 46881.3 47862.8 48263.8 49255.8 9674.6 10168.4 10179.5 10192.5 10337.7 11616.7 17166.6 17930.7 17943.4 18274.7 14353.7 14414.6 14470.2 14470.5 15082.7 13709.1 14182.0 14581.3 14859.7 15273.1 14672.2 14721.2 15025.5 15040.2 15239.2 9358.6 9533.6 9782.8 9887.9 9923.7 13694.6 14697.0 14726.5 14772.2 14854.1 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5512.77 Median:6494.37 stddev:2876.97 (44.3%) stddev-sans-first:2869.13 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: Values: 1486.1 1515.4 1542.8 1577.3 1604.5 7746.5 7793.9 8053.3 8106.3 8140.6 7622.0 7630.2 7682.0 7708.7 7720.4 2212.2 2245.6 2247.7 2258.8 2259.0 2184.9 2231.3 2231.7 2250.1 2255.3 2214.8 2250.8 2254.8 2257.1 2258.9 2243.1 2270.1 2285.3 2311.0 2318.5 2283.5 2336.4 2337.4 2342.1 2345.0 7825.1 7971.3 7975.6 7988.1 8005.4 4681.9 4736.4 4785.5 4787.9 4791.6 3049.2 3105.0 3137.2 3138.0 3149.9 1031.6 1046.4 1086.0 1096.6 1098.9 10570.4 10612.1 10663.7 10699.3 10700.3 4085.2 4110.7 4113.1 4170.4 4172.7 8861.1 8864.4 8867.6 8873.0 8902.6 4692.6 4708.4 4723.1 4726.1 4737.7 4337.7 4378.9 4379.5 4392.5 4413.6 3363.1 3367.1 3376.1 3393.2 3407.2 975.6 1003.1 1007.7 1011.1 1011.7 994.0 1065.8 1192.3 1335.2 1455.0 7184.7 7240.3 7274.3 7322.3 7500.1 1049.7 1110.2 1156.8 1163.8 1164.2 5741.3 5756.4 5795.9 5798.4 5815.0 9467.8 9513.9 9655.7 9721.7 9811.6 9513.0 9516.7 9541.5 9567.4 9658.0 7545.8 7611.0 7633.7 7738.0 7763.4 7195.7 7228.9 7242.9 7268.8 7271.4 8399.4 8440.7 8597.3 8706.9 8751.1 8682.3 8769.4 8771.6 8824.9 8940.2 6851.5 6916.4 6929.5 6932.7 6951.8 7568.7 7596.7 7631.2 7707.0 7722.4 6836.4 7144.6 7191.1 7223.2 7337.2 7122.4 7172.8 7174.7 7267.8 7334.5 6951.3 7024.3 7058.0 7075.6 7088.4 6490.9 6493.1 6495.6 6496.4 6530.9 6399.1 6572.2 6576.0 6578.8 6613.5 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,196 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5641.53 Median:6431.44 stddev:1694.07 (26.3%) stddev-sans-first:1651.62 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: Values: 350.7 359.0 360.7 361.7 365.5 6198.4 6325.4 6356.2 6363.0 6440.2 6205.4 6337.2 6358.7 6373.4 6375.6 4853.6 4868.8 4869.1 4874.0 4883.1 4861.6 4882.2 4884.3 4886.5 4886.8 4754.9 4837.6 4837.7 4843.2 4846.2 4777.5 4792.6 4795.9 4829.9 4832.9 4215.7 4227.6 4235.3 4247.0 4249.8 5901.2 5980.1 5981.2 6016.4 6050.7 5570.4 5650.7 5661.2 5665.3 5679.1 6717.4 6727.5 6729.0 6742.1 6774.3 4694.3 4694.8 4700.5 4705.4 4717.6 6873.0 6972.9 6993.8 7001.6 7016.5 4818.9 4819.0 4824.3 4827.4 4831.6 4858.1 4890.3 4897.3 4906.9 4908.1 5556.3 5632.7 5639.0 5643.0 5662.5 6688.1 6780.0 6800.1 6817.3 6820.4 1637.7 1678.5 1687.7 1692.7 1711.8 1133.7 1153.0 1160.8 1167.5 1171.9 6422.7 6496.4 6503.9 6506.9 6542.2 6839.0 6877.3 6883.3 6914.1 6939.7 6376.8 6468.1 6470.1 6482.6 6499.6 3728.2 3744.5 3764.4 3767.9 3776.8 7086.0 7107.0 7122.6 7134.7 7138.1 6966.3 7084.2 7096.6 7099.5 7128.8 6986.6 7028.7 7072.8 7077.2 7087.5 6855.8 6884.1 6894.4 6956.1 6959.7 6783.2 6826.8 6869.1 6878.6 6887.6 7107.2 7124.0 7130.2 7131.9 7147.7 4808.1 4809.5 4812.4 4830.1 4833.9 6841.3 6904.6 6920.0 6938.9 7115.2 6864.2 6865.4 6875.8 6881.0 6901.9 6819.6 6820.5 6846.3 6854.7 6866.3 6592.7 6735.8 6747.4 6748.6 6757.5 6831.8 6869.7 6872.2 6875.9 6891.2 6613.1 6631.2 6658.9 6665.5 6679.1 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14787.46 Median:4591.68 stddev:16875.16 (367.5%) stddev-sans-first:16889.50 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: Values: 734.0 747.9 776.4 791.4 846.9 14110.1 14481.2 14594.9 14630.0 15099.4 14491.5 14611.1 14653.3 14662.5 14695.7 896.0 898.5 899.8 903.4 913.3 906.0 907.2 908.4 910.5 912.4 944.6 950.8 951.4 953.3 955.5 927.0 928.4 937.0 941.4 948.3 706.1 706.2 707.9 708.5 710.5 14498.6 14513.9 14562.7 14659.3 14678.9 12749.4 12864.2 12942.4 13425.6 13488.5 9668.9 9850.5 10009.9 10452.4 10566.8 3756.2 3775.8 3836.6 3838.3 3840.3 49374.3 50394.7 50413.0 50918.7 51501.0 10271.4 10570.7 10772.4 10811.8 11030.9 18152.5 19208.3 19214.2 19239.6 19282.9 7474.2 7657.8 8159.3 8202.1 8479.3 4564.2 4588.2 4601.7 4687.5 4783.9 3274.6 3328.4 3330.1 3342.5 3346.1 587.7 616.6 626.7 635.2 641.1 701.8 705.9 706.0 721.3 726.4 9190.4 9266.4 9480.1 9627.5 9885.6 631.5 688.2 702.2 726.1 768.7 4178.9 4498.2 4506.9 4512.5 4595.2 60062.7 60076.7 60527.0 60569.7 61137.0 54162.5 54995.5 55264.7 55549.7 55676.7 49834.3 50387.2 50707.2 50921.7 51057.0 8569.2 8914.4 9043.8 9056.3 9070.7 36914.4 36974.4 37094.4 37523.1 38055.6 44663.8 45648.0 46070.0 46366.5 46796.3 12415.3 12594.5 12775.2 13409.9 13776.7 12784.2 13827.0 13877.6 14654.8 14676.4 12702.2 12723.9 12876.7 13075.8 13369.8 11684.9 11716.2 11761.5 12240.0 12597.2 12035.4 12052.2 12091.5 12180.4 12237.9 11025.3 11178.7 11261.3 11287.2 11312.4 10190.0 10563.7 10636.0 10778.3 10840.3 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:53 INFO - 2016-01-23 07:17:53,198 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2016-01-23 07:17:53,816 INFO : Browser exited with error code: 0 07:17:53 INFO - 2016-01-23 07:17:53,834 INFO : Completed test dromaeo_css (00:18:29) 07:17:53 INFO - 2016-01-23 07:17:53,835 INFO : Starting test kraken 07:17:53 INFO - 2016-01-23 07:17:53,835 DEBUG : operating with platform_type : linux_ 07:17:53 INFO - 2016-01-23 07:17:53,835 INFO : Initialising browser for kraken test... 07:17:53 INFO - 2016-01-23 07:17:53,841 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSSoFB/profile http://localhost:45283/getInfo.html 07:17:57 INFO - 2016-01-23 07:17:57,480 DEBUG : BROWSER_OUTPUT: 07:17:57 INFO - 2016-01-23 07:17:57,480 DEBUG : BROWSER_OUTPUT: (process:3807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:17:58 INFO - 2016-01-23 07:17:58,396 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:17:58 INFO - 2016-01-23 07:17:58,396 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:17:58 INFO - 2016-01-23 07:17:58,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:17:58 INFO - 2016-01-23 07:17:58,396 DEBUG : BROWSER_OUTPUT: __metrics 07:17:59 INFO - 2016-01-23 07:17:59,372 INFO : Browser initialized. 07:17:59 INFO - 2016-01-23 07:17:59,372 INFO : Running cycle 1/1 for kraken test... 07:17:59 INFO - 2016-01-23 07:17:59,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSSoFB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:18:00 INFO - 2016-01-23 07:18:00,685 DEBUG : BROWSER_OUTPUT: 07:18:00 INFO - 2016-01-23 07:18:00,686 DEBUG : BROWSER_OUTPUT: (process:3920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:18:11 INFO - 2016-01-23 07:18:11,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 135479296 07:18:11 INFO - 2016-01-23 07:18:11,187 DEBUG : BROWSER_OUTPUT: 07:18:13 INFO - 2016-01-23 07:18:13,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45283/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:14 INFO - 2016-01-23 07:18:14,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 07:18:14 INFO - 2016-01-23 07:18:14,257 DEBUG : BROWSER_OUTPUT: 07:18:16 INFO - 2016-01-23 07:18:16,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45283/tests/kraken/driver.html?testName=audio-dft) 07:18:17 INFO - 2016-01-23 07:18:17,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 137973760 07:18:17 INFO - 2016-01-23 07:18:17,465 DEBUG : BROWSER_OUTPUT: 07:18:20 INFO - 2016-01-23 07:18:20,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45283/tests/kraken/driver.html?testName=audio-fft) 07:18:20 INFO - 2016-01-23 07:18:20,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 138518528 07:18:20 INFO - 2016-01-23 07:18:20,898 DEBUG : BROWSER_OUTPUT: 07:18:22 INFO - 2016-01-23 07:18:22,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45283/tests/kraken/driver.html?testName=audio-oscillator) 07:18:23 INFO - 2016-01-23 07:18:23,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 138137600 07:18:23 INFO - 2016-01-23 07:18:23,489 DEBUG : BROWSER_OUTPUT: 07:18:25 INFO - 2016-01-23 07:18:25,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:26 INFO - 2016-01-23 07:18:26,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 137895936 07:18:26 INFO - 2016-01-23 07:18:26,278 DEBUG : BROWSER_OUTPUT: 07:18:29 INFO - 2016-01-23 07:18:29,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45283/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:29 INFO - 2016-01-23 07:18:29,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 138960896 07:18:29 INFO - 2016-01-23 07:18:29,806 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45283/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:33 INFO - 2016-01-23 07:18:33,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 07:18:33 INFO - 2016-01-23 07:18:33,722 DEBUG : BROWSER_OUTPUT: 07:18:36 INFO - 2016-01-23 07:18:36,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45283/tests/kraken/driver.html?testName=json-parse-financial) 07:18:37 INFO - 2016-01-23 07:18:37,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 07:18:37 INFO - 2016-01-23 07:18:37,057 DEBUG : BROWSER_OUTPUT: 07:18:38 INFO - 2016-01-23 07:18:38,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:39 INFO - 2016-01-23 07:18:39,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 137891840 07:18:39 INFO - 2016-01-23 07:18:39,249 DEBUG : BROWSER_OUTPUT: 07:18:41 INFO - 2016-01-23 07:18:41,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:41 INFO - 2016-01-23 07:18:41,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 137752576 07:18:41 INFO - 2016-01-23 07:18:41,649 DEBUG : BROWSER_OUTPUT: 07:18:43 INFO - 2016-01-23 07:18:43,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:44 INFO - 2016-01-23 07:18:44,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 07:18:44 INFO - 2016-01-23 07:18:44,261 DEBUG : BROWSER_OUTPUT: 07:18:46 INFO - 2016-01-23 07:18:46,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:47 INFO - 2016-01-23 07:18:47,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 07:18:47 INFO - 2016-01-23 07:18:47,269 DEBUG : BROWSER_OUTPUT: 07:18:49 INFO - 2016-01-23 07:18:49,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:50 INFO - 2016-01-23 07:18:50,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 07:18:50 INFO - 2016-01-23 07:18:50,396 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45283/tests/kraken/driver.html?testName=ai-astar) 07:18:52 INFO - 2016-01-23 07:18:52,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 138338304 07:18:52 INFO - 2016-01-23 07:18:52,313 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:18:52 INFO - 2016-01-23 07:18:52,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:18:52 INFO - 2016-01-23 07:18:52,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:18:52 INFO - 2016-01-23 07:18:52,316 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;112;111;111;120;110;111;110;111 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;125;152;173;123;147;151;135;167;132 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;161;163;162;162;161;167;161 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;72;72;150;74;73;74;73;170;73 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;132;93;92;93;141;93;93;137 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;111;111;110;110;109;110;111;110 07:18:52 INFO - 2016-01-23 07:18:52,317 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;146;146;147;148;147;147;147 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;97;97;97;98;97;99;97 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;62;68;63;61;61;61;64;61 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;66;66;66;65;66;67;66;66 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;81;89;82;81;83;81;90;83 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;128;115;120;115;115;114;122;117;120 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;159;145;146;150;154;145;148;149;143 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;67;66;69;67;66;64;67;65;66 07:18:52 INFO - 2016-01-23 07:18:52,318 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:18:52 INFO - 2016-01-23 07:18:52,319 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:18:52 INFO - 2016-01-23 07:18:52,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,696 07:18:52 INFO - 2016-01-23 07:18:52,319 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:18:52 INFO - 2016-01-23 07:18:52,319 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562332314__endTimestamp 07:18:52 INFO - 2016-01-23 07:18:52,319 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:18:52 INFO - 2016-01-23 07:18:52,323 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:18:52 INFO - 2016-01-23 07:18:52,323 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,323 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.08 07:18:52 INFO - 2016-01-23 07:18:52,324 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 112.0 111.0 111.0 120.0 110.0 111.0 110.0 111.0 07:18:52 INFO - 2016-01-23 07:18:52,324 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,324 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:17.54 (11.6%) stddev-sans-first:17.71 07:18:52 INFO - 2016-01-23 07:18:52,324 DEBUG : BROWSER_OUTPUT: Values: 162.0 125.0 152.0 173.0 123.0 147.0 151.0 135.0 167.0 132.0 07:18:52 INFO - 2016-01-23 07:18:52,325 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,325 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 07:18:52 INFO - 2016-01-23 07:18:52,325 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 161.0 163.0 162.0 162.0 161.0 167.0 161.0 07:18:52 INFO - 2016-01-23 07:18:52,325 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,325 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.00 Median:73.00 stddev:36.72 (50.3%) stddev-sans-first:38.69 07:18:52 INFO - 2016-01-23 07:18:52,326 DEBUG : BROWSER_OUTPUT: Values: 79.0 72.0 72.0 150.0 74.0 73.0 74.0 73.0 170.0 73.0 07:18:52 INFO - 2016-01-23 07:18:52,326 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,326 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:21.14 (22.7%) stddev-sans-first:21.96 07:18:52 INFO - 2016-01-23 07:18:52,326 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 132.0 93.0 92.0 93.0 141.0 93.0 93.0 137.0 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 111.0 111.0 110.0 110.0 109.0 110.0 111.0 110.0 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 147.0 147.0 07:18:52 INFO - 2016-01-23 07:18:52,327 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 97.0 97.0 97.0 98.0 97.0 99.0 97.0 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:61.50 stddev:2.47 (4.0%) stddev-sans-first:2.35 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 62.0 68.0 63.0 61.0 61.0 61.0 64.0 61.0 07:18:52 INFO - 2016-01-23 07:18:52,328 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 67.0 66.0 66.0 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.37 (4.1%) stddev-sans-first:3.47 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 81.0 89.0 82.0 81.0 83.0 81.0 90.0 83.0 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:5.85 (4.9%) stddev-sans-first:4.56 07:18:52 INFO - 2016-01-23 07:18:52,329 DEBUG : BROWSER_OUTPUT: Values: 131.0 128.0 115.0 120.0 115.0 115.0 114.0 122.0 117.0 120.0 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:148.50 stddev:4.79 (3.2%) stddev-sans-first:5.04 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: Values: 147.0 159.0 145.0 146.0 150.0 154.0 145.0 148.0 149.0 143.0 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.40 (2.1%) stddev-sans-first:1.41 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 66.0 69.0 67.0 66.0 64.0 67.0 65.0 66.0 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:18:52 INFO - 2016-01-23 07:18:52,330 DEBUG : BROWSER_OUTPUT: 07:18:53 INFO - 2016-01-23 07:18:53,104 INFO : Browser exited with error code: 0 07:18:54 INFO - 2016-01-23 07:18:54,030 INFO : Completed test kraken (00:01:00) 07:18:54 INFO - 2016-01-23 07:18:54,031 INFO : Starting test v8_7 07:18:54 INFO - 2016-01-23 07:18:54,031 DEBUG : operating with platform_type : linux_ 07:18:54 INFO - 2016-01-23 07:18:54,031 INFO : Initialising browser for v8_7 test... 07:18:54 INFO - 2016-01-23 07:18:54,037 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfZKqSY/profile http://localhost:45283/getInfo.html 07:18:57 INFO - 2016-01-23 07:18:57,743 DEBUG : BROWSER_OUTPUT: 07:18:57 INFO - 2016-01-23 07:18:57,743 DEBUG : BROWSER_OUTPUT: (process:4227): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:18:58 INFO - 2016-01-23 07:18:58,578 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:18:58 INFO - 2016-01-23 07:18:58,578 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:18:58 INFO - 2016-01-23 07:18:58,579 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:18:58 INFO - 2016-01-23 07:18:58,579 DEBUG : BROWSER_OUTPUT: __metrics 07:18:59 INFO - 2016-01-23 07:18:59,532 INFO : Browser initialized. 07:18:59 INFO - 2016-01-23 07:18:59,532 INFO : Running cycle 1/1 for v8_7 test... 07:18:59 INFO - 2016-01-23 07:18:59,533 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfZKqSY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:19:00 INFO - 2016-01-23 07:19:00,789 DEBUG : BROWSER_OUTPUT: 07:19:00 INFO - 2016-01-23 07:19:00,789 DEBUG : BROWSER_OUTPUT: (process:4341): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:19:11 INFO - 2016-01-23 07:19:11,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 135581696 07:19:11 INFO - 2016-01-23 07:19:11,296 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45283/tests/v8_7/run.html (next: http://localhost:45283/tests/v8_7/run.html) 07:19:32 INFO - 2016-01-23 07:19:32,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 135983104 07:19:32 INFO - 2016-01-23 07:19:32,977 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,978 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:19:32 INFO - 2016-01-23 07:19:32,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:19:32 INFO - 2016-01-23 07:19:32,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |0;Richards;167.1402306535183 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.63889351774705 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |4;RayTrace;963.3911368015414 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |5;Earley;546.1496450027307 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |6;Boyer;11076.923076923076 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |7;RegExp;23651.162790697676 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |8;Splay;526.8703898840885 07:19:32 INFO - 2016-01-23 07:19:32,979 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562372977__endTimestamp 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: Values: 167.1 07:19:32 INFO - 2016-01-23 07:19:32,980 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,981 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 166.6 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 279.8 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 5170.1 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:963.39 Median:963.39 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 963.4 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.15 Median:546.15 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 546.1 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,982 DEBUG : BROWSER_OUTPUT: Values: 11076.9 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23651.16 Median:23651.16 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: Values: 23651.2 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.87 Median:526.87 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: Values: 526.9 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: Values: 4864.1 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:19:32 INFO - 2016-01-23 07:19:32,983 DEBUG : BROWSER_OUTPUT: 07:19:33 INFO - 2016-01-23 07:19:33,788 INFO : Browser exited with error code: 0 07:19:33 INFO - 2016-01-23 07:19:33,802 INFO : Completed test v8_7 (00:00:39) 07:19:34 INFO - 2016-01-23 07:19:34,004 INFO : Completed test suite (00:20:09) 07:19:34 INFO - 2016-01-23 07:19:34,005 DEBUG : Working with test: dromaeo_css 07:19:34 INFO - 2016-01-23 07:19:34,005 DEBUG : Generating results file: dromaeo_css 07:19:34 INFO - 2016-01-23 07:19:34,006 DEBUG : Working with test: kraken 07:19:34 INFO - 2016-01-23 07:19:34,006 DEBUG : Generating results file: kraken 07:19:34 INFO - 2016-01-23 07:19:34,006 INFO : javascript benchmark 07:19:34 INFO - 2016-01-23 07:19:34,006 DEBUG : Working with test: v8_7 07:19:34 INFO - 2016-01-23 07:19:34,007 DEBUG : Generating results file: v8_7 07:19:34 INFO - 2016-01-23 07:19:34,007 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:34 INFO - 2016-01-23 07:19:34,157 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 07:19:34 INFO - 2016-01-23 07:19:34,157 DEBUG : process_Request line: dromaeo_css 7312.84 graph.html#tests=[[72,52,43]] 07:19:34 INFO - 2016-01-23 07:19:34,157 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:34 INFO - 2016-01-23 07:19:34,276 DEBUG : process_Request line: kraken 1517.70 graph.html#tests=[[232,52,43]] 07:19:34 INFO - 2016-01-23 07:19:34,276 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:34 INFO - 2016-01-23 07:19:34,389 DEBUG : process_Request line: v8_7 23124.16 graph.html#tests=[[230,52,43]] 07:19:34 INFO - 2016-01-23 07:19:34,390 INFO : javascript benchmark 07:19:34 INFO - 2016-01-23 07:19:34,394 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.9198020049503, 3263.86944522219, 3272.280098378357, 3275.803451792894, 3292.4238258304804, 5500.862478438031, 5537.778488860446, 5550.139728342103, 5558.360788509322, 5573.6098473106895, 5549.223108764776, 5561.944380556193, 5563.0, 5569.693666848321, 5587.525060369863, 5068.5945124390055, 5074.847754567369, 5132.496513249655, 5169.327987361657, 5184.818531351403, 4931.950680493185, 5084.262781896623, 5111.054454925832, 5114.718690472023, 5185.974070129644, 5066.569341605949, 5119.56483698886, 5160.845174644766, 5182.7149506777305, 5203.583713302926, 5179.404368497614, 5260.736963151827, 5261.710605916673, 5270.077736396153, 5300.337457817773, 4890.315355850184, 4927.7536123193695, 4997.375328083989, 5128.25640282157, 5148.871278218075, 5302.09864323066, 5364.061289274361, 5426.294581704393, 5445.618806683534, 5458.808941687062, 5956.612820166719, 6008.0, 6020.759169633253, 6083.11794789753, 6094.963856144422, 5789.160571717078, 5921.526277897758, 6060.0, 6102.176206212193, 6180.0, 5637.3517045539875, 5642.210090587321, 5660.716964151776, 5661.0, 5683.2895888014, 6114.327423983358, 6127.969360153171, 6129.969350153221, 6142.416470435302, 6144.569880108439, 5621.128725047624, 5710.942890571041, 5733.942660573424, 5737.196792449061, 5856.707164641751, 5964.403559644088, 6045.0327947528185, 6073.908891366633, 6090.299615544181, 6094.6647934363145, 6002.519798416116, 6003.189569408074, 6008.24896887889, 6010.429009244115, 6026.427489388501, 5836.766529338864, 5921.230240068763, 5931.228940237827, 6026.819195424145, 6047.485963693048, 4583.449986001701, 4589.58693717567, 4628.976855115703, 4650.906981860344, 4652.906941861143, 4119.340905455113, 4133.503979522417, 4150.709450338508, 4154.937675934863, 4157.314043182841, 5474.370447398521, 5515.420880807537, 5595.328560572757, 5642.830715078472, 5649.0, 5924.289085309791, 5998.130271110665, 6001.309849367379, 6003.339632640406, 6012.0, 5537.501624853702, 5748.109043098327, 5750.051241545182, 5754.884902302014, 5758.107493338539, 5173.896522069537, 5224.52979231871, 5300.151975683949, 5305.4164041955355, 5337.439568845293, 6078.057901025348, 6085.726142323606, 6100.69496525172, 6119.908201376983, 6181.258249010148, 5729.427057294237, 5853.0635098384055, 6035.124906888476, 6049.909251361145, 6060.272767267956, 6085.056816193497, 6151.907721384094, 6172.043333283348, 6192.845178870564, 6200.472959798468, 6007.4643644048465, 6032.095185722177, 6038.245219347582, 6041.697915104315, 6044.365341639064, 5905.881882362414, 5945.10823376497, 6089.48239399656, 6174.8147555573405, 6177.444030037318, 5867.383924687846, 5905.527557795452, 5907.0, 5909.52723782105, 6028.668423236764, 5833.300003999547, 5871.442212989759, 5875.353711091691, 5883.176355310175, 5919.348871624032, 5622.072358061037, 5664.37691853904, 5692.686902220252, 5757.884842303214, 5817.749183925476, 5885.970570147122, 5887.1757953885635, 5930.169776231245, 5940.940590594038, 5956.076808094752, 5706.572007099568, 5763.308402991668, 5767.077267637158, 5772.105323674838, 5772.769089236552], "unit": "ms", "name": "dojo.html", "value": 5528.2303266502195}, {"lowerIsBetter": false, "replicates": [593.851537115721, 613.8311964209843, 622.8598565322801, 632.5098049012018, 642.1395330257454, 40283.79858100709, 40792.796036019776, 41026.38460423089, 41050.38424423636, 41054.17891642165, 44342.00460979256, 44780.3282950756, 44873.551264487425, 44914.55085449145, 44928.77535612325, 8895.243904268129, 8976.41653292534, 9017.639294428214, 9024.954875225614, 9067.818643627124, 8727.956360218222, 8762.430442021248, 8812.515311657857, 8908.420952638091, 8911.55442227886, 8868.113188681113, 8882.600282987249, 8945.64217431302, 8950.820983580325, 8977.608470687053, 8837.072107428723, 8874.911250887473, 8933.0, 8972.282217422591, 8985.550722463884, 8799.0, 8876.289896808239, 8973.775655608597, 8978.775530611721, 8986.056464071244, 40902.38646420306, 40950.0, 41024.58975410237, 41374.0, 41514.1697166055, 3220.1305647475283, 3258.8245275203594, 3372.106391806173, 3629.0, 3766.0961369271176, 31587.52618710721, 32070.679293207002, 32641.0, 32739.83630081858, 32786.50820237699, 4207.64235040022, 4225.366195070764, 4272.316429371285, 4287.742735435884, 4313.4176886120285, 261745.0, 263057.0, 264536.67731661414, 264638.0, 266564.0, 45046.32430513545, 45814.39649612248, 45829.0, 46051.5394846054, 46180.769096154305, 43780.0, 43786.0, 43837.56162438335, 43866.0, 43967.0, 16993.490195294162, 17220.397286094925, 17245.913770431067, 17250.913745431444, 17278.13609319529, 13578.796318055238, 13652.771250587297, 13664.65838354049, 13745.0, 13783.724325513434, 15265.465708700141, 15498.070115793089, 15530.689386212438, 15583.532494025198, 15617.921910390376, 6268.937310626835, 6286.277078135981, 6286.968565157236, 6323.652199129092, 6385.48916086712, 940.5391358234416, 967.4002118686459, 970.3013830042358, 1002.3835341265069, 1143.7369405036723, 28174.71825281721, 28354.149375518766, 29019.854900725782, 29064.709352906622, 29180.416391672046, 1075.655790147161, 1091.6179337232063, 1093.294824837975, 1140.749035212252, 1169.6491052684162, 14654.267286635626, 14684.853151468562, 14795.482158124629, 15108.848911510964, 15350.0, 495335.0, 495480.0, 498152.0, 500893.0, 823837.0, 58294.0, 58585.41414585885, 58925.11612325819, 59074.40925590775, 59153.40846591479, 1454.4763885001391, 1463.5389852196524, 1495.745723227054, 1515.1363722677968, 1529.9847001530065, 30553.694463055086, 31337.216569585944, 31380.35249408997, 31485.842570787, 32128.67871321257, 48303.27545086897, 49060.75469622629, 49390.50609493859, 49649.503504965935, 49675.50324496709, 305185.0, 308808.0, 309751.0, 310603.0, 311161.0, 34340.656593434745, 34573.406994475015, 34806.47790283097, 34904.47643285403, 35230.47154292637, 45097.098058038, 45480.31779523243, 45814.0, 46597.767011164724, 46691.29963050625, 38556.22887542177, 38563.807180963915, 39104.2179156421, 39824.0, 40768.59231407648, 38125.0, 38379.808100959315, 39155.0, 39262.21475570415, 39265.0, 37383.81308093442, 37922.0, 38216.61783382131, 38241.0, 38299.42550861795, 32888.835555822065, 34334.48498272478, 34453.794117205776, 34535.30929381348, 38068.61931380651, 26020.8698956504, 27154.321141970817, 28223.803015035333, 30039.399212016073, 30443.695563044086], "unit": "ms", "name": "ext.html", "value": 19205.425648045046}, {"lowerIsBetter": false, "replicates": [384.8518320446628, 385.021855944271, 387.4420833999043, 388.3320688415924, 390.1942488760709, 16873.915630421845, 17670.469885903443, 18801.62396752066, 18878.24487020521, 18888.1500332485, 11400.828987565172, 11722.0, 12083.516659333638, 17657.470275891712, 17717.202725877334, 4949.752512374376, 4970.726610036447, 4974.10466116099, 5056.039352523027, 5077.466865979074, 4966.751662416883, 5110.488951104897, 5271.393789714174, 5281.498257665516, 5287.2862163608, 5204.869878253036, 5217.5565076968505, 5240.44975277596, 5261.289725887013, 5450.427705090968, 5525.392206857243, 5542.279503664538, 5564.0, 5585.413531579186, 5597.74810133545, 5232.293640358541, 5329.147336426153, 5371.570274378079, 5401.864953376197, 5422.53908417785, 13252.46990120394, 13387.933060334733, 13461.528846490326, 16111.43609973657, 21996.780032199633, 2041.3773798991301, 2082.739657542807, 2205.8125059369972, 2250.5948929192737, 2302.7582103879186, 10098.747531311703, 10214.744631384201, 10413.219008574388, 11422.71443213918, 13131.883789877871, 1909.8281154696006, 1935.7677078750498, 1976.2786582897284, 2010.9597808043904, 2021.9393418197478, 65831.341686583, 67260.0, 67664.0, 67867.66066169637, 67915.0, 10948.233623646427, 11088.168387370979, 11187.216894817284, 11236.325820450798, 11282.435878206057, 14662.780058299135, 14775.113493190443, 14776.113433194043, 14815.0, 14837.258137093102, 8603.741887743377, 8673.913260867437, 8674.132586741402, 8712.607932643046, 8712.869306960401, 8529.0, 8545.359098067669, 8548.316134709208, 8583.39916205872, 8593.0, 4483.461984561874, 4506.436695413074, 4533.002739397327, 4734.881627959328, 4797.664163508521, 1909.0931807391655, 1915.2913422033657, 1931.2757715856553, 1948.4057362504573, 2000.2399088346335, 945.1163162443138, 958.942463452195, 965.3049804141007, 965.7199412170391, 1080.9027187553002, 17170.742438863428, 18065.2773889043, 18069.457916262534, 18093.63812723738, 18102.913825170268, 980.7302991677345, 981.2738573455591, 990.356009025015, 1002.173207104142, 1013.7566983923805, 10135.391876487434, 10203.234757393226, 10231.232657550714, 10233.897661023295, 10604.045635892806, 458495.0, 459691.0, 464005.0, 490843.0, 676603.0, 82352.0, 87691.56154219316, 88220.55889720639, 88682.55658721665, 89812.5509372462, 1173.976520469586, 1199.6401079676061, 1217.31221859649, 1226.1845872494691, 1244.6141696074246, 15481.690366192839, 15903.52289431319, 16135.919320403324, 16320.265588048804, 16595.585110372336, 36560.63439365679, 36752.0, 36850.8157459211, 37869.0, 38077.809610951765, 45573.0, 46881.29678054764, 47862.80342991453, 48263.75868120637, 49255.753721231165, 9674.56464459087, 10168.440735759308, 10179.541920613738, 10192.490375481048, 10337.689869303933, 11616.709582260512, 17166.570835729206, 17930.65520086025, 17943.371981980566, 18274.725879111556, 14353.712925741636, 14414.639634008814, 14470.20413877247, 14470.493532726305, 15082.698346033238, 13709.108907920952, 14182.0, 14581.343839527459, 14859.702805943605, 15273.083614983136, 14672.193029383487, 14721.190334531275, 15025.474108406153, 15040.172790496628, 15239.161846098572, 9358.578863951274, 9533.570989305359, 9782.80434391294, 9887.851682224917, 9923.702288931343, 13694.589162325146, 14697.0, 14726.484573040321, 14772.18752968597, 14854.108753474826], "unit": "ms", "name": "jquery.html", "value": 9180.795585586997}, {"lowerIsBetter": false, "replicates": [1486.0637798187147, 1515.3938424630146, 1542.8302886682466, 1577.2902194012697, 1604.5266646339328, 7746.457747957646, 7793.883091753628, 8053.275205231535, 8106.270435660789, 8140.552269625168, 7622.0, 7630.236976302367, 7682.0397450318715, 7708.730194443196, 7720.420968427362, 2212.203606701586, 2245.550889822034, 2247.7302723673183, 2258.7741225877444, 2259.028617694391, 2184.9235276765316, 2231.319447568491, 2231.6987206727044, 2250.133698526071, 2255.3459496745922, 2214.767449417804, 2250.7749225077523, 2254.7632498587577, 2257.085880218514, 2258.9435264118447, 2243.069126312578, 2270.080617349976, 2285.3029825903095, 2310.9884450577724, 2318.4899322149186, 2283.4748007958265, 2336.3925379401308, 2337.439014636492, 2342.0748804222235, 2345.026813872241, 7825.13923468418, 7971.282584567359, 7975.641096150629, 7988.081370642392, 8005.359571234288, 4681.88295292617, 4736.384270044907, 4785.545373189541, 4787.928181077286, 4791.6406269529925, 3049.2224482756756, 3104.9689503105133, 3137.1686503076703, 3138.0428969164395, 3149.889753858604, 1031.6389263757624, 1046.3774054437674, 1086.0, 1096.5613754498265, 1098.9285696429706, 10570.418626975514, 10612.097971672418, 10663.733406664818, 10699.304545204615, 10700.304480208839, 4085.2460647054554, 4110.691698122653, 4113.115680128787, 4170.395292682544, 4172.749635021908, 8861.069587693328, 8864.379493435397, 8867.600957956907, 8873.023967363713, 8902.643894244287, 4692.6245900327895, 4708.364370809897, 4723.0789995951145, 4726.125666751662, 4737.692050016738, 4337.7180483268485, 4378.868633940987, 4379.49635791888, 4392.494863090722, 4413.58070983256, 3363.075154332578, 3367.0572239772905, 3376.139084533428, 3393.185635447475, 3407.1993081625797, 975.5707488704948, 1003.1373019203625, 1007.7228762090338, 1011.1304278320638, 1011.7369483934231, 993.980120397588, 1065.8454524093963, 1192.2607983050564, 1335.2455862437691, 1454.9927250363892, 7184.712611495482, 7240.275972402717, 7274.345308922222, 7322.304381083789, 7500.062492188476, 1049.7218237167158, 1110.161827820007, 1156.8206927926185, 1163.8021536338674, 1164.231607139284, 5741.339745929188, 5756.366799652035, 5795.913061304083, 5798.449147330997, 5814.9709251454315, 9467.763305917408, 9513.904860951441, 9655.710328690151, 9721.70834874955, 9811.558479868423, 9512.95243523778, 9516.666916657883, 9541.52292385378, 9567.37812042215, 9658.0, 7545.773626791205, 7611.010568626154, 7633.69465221385, 7737.961310193413, 7763.378929685611, 7195.748148814766, 7228.927710722825, 7242.855142897007, 7268.818279543054, 7271.4182865369585, 8399.370047246359, 8440.66237350499, 8597.312215022908, 8706.869396959177, 8751.081136480578, 8682.262007729414, 8769.429987050822, 8771.561421929006, 8824.867626985471, 8940.240079593048, 6851.520393572402, 6916.412104970933, 6929.480288978448, 6932.653367331714, 6951.7914462566205, 7568.735094271674, 7596.734114305973, 7631.236876312324, 7707.036620422447, 7722.38220942312, 6836.38472537474, 7144.607046612278, 7191.137063552407, 7223.169335526271, 7337.229590893093, 7122.358987691133, 7172.784816455514, 7174.67713952863, 7267.818304542428, 7334.486585938933, 6951.339622735832, 7024.297570242935, 7058.0, 7075.646217688992, 7088.397486213729, 6490.902636460552, 6493.090967264492, 6495.642739649365, 6496.382843629847, 6530.869382612226, 6399.136116624196, 6572.211334639874, 6576.0, 6578.80263592093, 6613.503987201076], "unit": "ms", "name": "mootools.html", "value": 4510.098916252398}, {"lowerIsBetter": false, "replicates": [350.7229288861799, 358.98384572694226, 360.73125521486486, 361.726896193374, 365.52481773694177, 6198.44214020738, 6325.367463253672, 6356.2054743157105, 6363.045543168527, 6440.194975628052, 6205.441510264075, 6337.176167098282, 6358.745650173987, 6373.394527519889, 6375.553711240215, 4853.5874450671645, 4868.756562171895, 4869.050535145648, 4874.0, 4883.12103821312, 4861.61107111432, 4882.2432522959, 4884.291777692232, 4886.53577910098, 4886.804527818883, 4754.9286760698615, 4837.5646191842725, 4837.693822667878, 4843.200871856139, 4846.151923413388, 4777.498362671939, 4792.640551958617, 4795.896943702968, 4829.9275510867365, 4832.903341933159, 4215.704900656955, 4227.577242275778, 4235.301175306071, 4246.957530424687, 4249.830006799755, 5901.203337549418, 5980.102984552308, 5981.222441082631, 6016.42843929826, 6050.72771725269, 5570.359408667974, 5650.660960342351, 5661.150827375926, 5665.348484924245, 5679.09134538476, 6717.42901853343, 6727.461803055744, 6729.0, 6742.123523941906, 6774.322567743236, 4694.2723877799, 4694.835680751192, 4700.4594471635855, 4705.435347758291, 4717.599004084657, 6873.0, 6972.860542789116, 6993.755218567377, 7001.579905205704, 7016.508844380895, 4818.8795280118275, 4818.98801251734, 4824.300476430898, 4827.444843842933, 4831.5651591356245, 4858.05267972742, 4890.339804126468, 4897.265410188429, 4906.9263961040615, 4908.067467181224, 5556.277683901148, 5632.746526406321, 5638.971805140948, 5643.0, 5662.462066103713, 6688.097106890605, 6780.0, 6800.08198893153, 6817.318268173143, 6820.3861652451515, 1637.6560922206231, 1678.5216213379128, 1687.7299632058812, 1692.7122389193867, 1711.7517959895995, 1133.6599020294043, 1152.982705259422, 1160.7620437810228, 1167.480471190312, 1171.9355435450962, 6422.678866056678, 6496.35036496356, 6503.934960650333, 6506.869862602722, 6542.182227221598, 6838.974153876959, 6877.277885821916, 6883.346082122191, 6914.0666010089, 6939.653017349112, 6376.808695739135, 6468.06213099098, 6470.12653291809, 6482.57863238888, 6499.610023398611, 3728.217074414403, 3744.5319335083113, 3764.4353346997623, 3767.8869633911027, 3776.754510956779, 7085.96457017722, 7107.0, 7122.5726456412785, 7134.714611415485, 7138.143422789195, 6966.338197871194, 7084.185318688416, 7096.574205547684, 7099.467539934422, 7128.786136415916, 6986.615736134459, 7028.683709233097, 7072.823179420453, 7077.186123595852, 7087.539309944837, 6855.828604284933, 6884.070650462124, 6894.413974812197, 6956.0609317741455, 6959.686814093479, 6783.18601767791, 6826.829329266808, 6869.107016087876, 6878.58728476293, 6887.552309099892, 7107.182673992557, 7124.0, 7130.215676275502, 7131.893021604784, 7147.714091436284, 4808.06242782654, 4809.495003024772, 4812.446568644651, 4830.082284365959, 4833.927491087707, 6841.315868413119, 6904.551204171713, 6919.965400172967, 6938.8612227756175, 7115.217326094022, 6864.176298844171, 6865.382115609419, 6875.7937261882225, 6881.002254673144, 6901.896471553031, 6819.624920629413, 6820.522563420513, 6846.281140480178, 6854.657267136723, 6866.313368663094, 6592.70332835014, 6735.831604209934, 6747.392734653905, 6748.561343512656, 6757.493188010821, 6831.760888368884, 6869.690863911236, 6872.244053154049, 6875.868480770977, 6891.241963383924, 6613.074169616354, 6631.204255489372, 6658.900116498159, 6665.466762659073, 6679.098321726505], "unit": "ms", "name": "prototype.html", "value": 5090.364798698592}, {"lowerIsBetter": false, "replicates": [734.0, 747.8579069976704, 776.4099284543745, 791.398537111795, 846.8687353460214, 14110.082844615106, 14481.237521968786, 14594.927025364872, 14630.049046811962, 15099.396024159021, 14491.49279775208, 14611.123332600026, 14653.267336633153, 14662.486812961548, 14695.706085878302, 896.0322851320591, 898.469902757373, 899.8425275576781, 903.3631289940608, 913.2648218184358, 905.9909400906006, 907.2424525521197, 908.3596064774351, 910.4901255297054, 912.3886995712855, 944.6174299408716, 950.7575568230126, 951.3578334624101, 953.2945620241006, 955.4888134847857, 927.0312523412982, 928.4429342394577, 936.9906300936972, 941.3928016429398, 948.340903072365, 706.1208795050144, 706.2302090721088, 707.9044329015569, 708.4651088428204, 710.4813486155135, 14498.637534061627, 14513.854861451357, 14562.708745825024, 14659.34032968519, 14678.853211467855, 12749.362531873368, 12864.22814631125, 12942.352882355844, 13425.597232083053, 13488.460461581524, 9668.90331096687, 9850.458224797634, 10009.949950250275, 10452.425116618582, 10566.78866422675, 3756.1924186300075, 3775.8300876460626, 3836.635519625631, 3838.2899163654815, 3840.2511510255513, 49374.25938610924, 50394.74802626, 50413.0, 50918.745406272734, 51501.0, 10271.383716977005, 10570.735731606772, 10772.353658780497, 10811.78376432467, 11030.944845275722, 18152.546186345447, 19208.327708530134, 19214.231430742893, 19239.615207695766, 19282.90358548198, 7474.215207403253, 7657.808554786175, 8159.347252219808, 8202.056763472157, 8479.279261262862, 4564.178447879413, 4588.174128656807, 4601.67788254819, 4687.460941991646, 4783.880402989884, 3274.623418306925, 3328.4008878401637, 3330.0675810773023, 3342.4819153031317, 3346.0631023313513, 587.6797145555682, 616.608453631947, 626.7148447456397, 635.1552435261184, 641.1024565608186, 701.7754318618096, 705.92234854166, 705.9717611295594, 721.3147509865648, 726.4079774983477, 9190.415341792726, 9266.397684150508, 9480.146786789222, 9627.470489123025, 9885.555150018266, 631.5137344244906, 688.1913751342253, 702.199492578461, 726.0670038999965, 768.7117331000875, 4178.8717046397915, 4498.167838949739, 4506.895810526442, 4512.458504979358, 4595.195840727859, 60062.699686501284, 60076.69961650164, 60527.0, 60569.69715151396, 61137.0, 54162.45837541574, 54995.450045499834, 55264.72367638136, 55549.722251388484, 55676.72161639166, 49834.25248621201, 50387.24419133716, 50707.23939140916, 50921.74539127355, 51057.0, 8569.228769410784, 8914.37599368038, 9043.773905652411, 9056.320775941962, 9070.682526111554, 36914.44628330523, 36974.44538331981, 37094.44358334573, 37523.06192345104, 38055.619443805204, 44663.77668111639, 45648.0, 46070.0, 46366.536334637574, 46796.29805552988, 12415.317157556421, 12594.496220151092, 12775.233485990499, 13409.932950335577, 13776.65558361049, 12784.232946023269, 13827.0, 13877.583672489842, 14654.780178297548, 14676.41294348214, 12702.237865728086, 12723.87276127264, 12876.742465150457, 13075.803862941873, 13369.799453008018, 11684.88315116838, 11716.179867409199, 11761.470733816828, 12240.0, 12597.244165350108, 12035.398230088636, 12052.156349055482, 12091.51633934668, 12180.390980451119, 12237.877621223673, 11025.338479690923, 11178.664640060812, 11261.324320540794, 11287.20989530725, 11312.377819220023, 10190.031946965026, 10563.735906602396, 10636.0, 10778.29941053829, 10840.349579025284], "unit": "ms", "name": "yui.html", "value": 6833.6883665507}], "name": "dromaeo_css", "value": 7312.843933852363}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 111.0, 111.0, 120.0, 110.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [162.0, 125.0, 152.0, 173.0, 123.0, 147.0, 151.0, 135.0, 167.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 167.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [79.0, 72.0, 72.0, 150.0, 74.0, 73.0, 74.0, 73.0, 170.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 93.0, 92.0, 93.0, 141.0, 93.0, 93.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 98.0, 97.0, 99.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 62.0, 68.0, 63.0, 61.0, 61.0, 61.0, 64.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 81.0, 89.0, 82.0, 81.0, 83.0, 81.0, 90.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [131.0, 128.0, 115.0, 120.0, 115.0, 115.0, 114.0, 122.0, 117.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [147.0, 159.0, 145.0, 146.0, 150.0, 154.0, 145.0, 148.0, 149.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 69.0, 67.0, 66.0, 64.0, 67.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1517.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "DeltaBlue", "value": 396.77411799999993}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [963.3911368015414], "unit": "score", "name": "RayTrace", "value": 768.1085820000003}, {"lowerIsBetter": false, "replicates": [546.1496450027307], "unit": "score", "name": "Earley", "value": 1220.2937529999997}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [23651.162790697676], "unit": "score", "name": "RegExp", "value": 38.51755653883975}, {"lowerIsBetter": false, "replicates": [526.8703898840885], "unit": "score", "name": "Splay", "value": 154.66991800000002}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 23124.155576965444}]} 07:19:34 INFO - RETURN: dromaeo_css: 7312.84 07:19:34 INFO - RETURN: kraken: 1517.70 07:19:34 INFO - RETURN: v8_7: 23124.16 07:19:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23124.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1517.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7312.84"}}} 07:19:34 INFO - Return code: 0 07:19:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:19:34 INFO - # TBPL SUCCESS # 07:19:34 INFO - Running post-action listener: _resource_record_post_action 07:19:34 INFO - Running post-run listener: _resource_record_post_run 07:19:35 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8048640; Write bytes: 449331200; Read time: 2076; Write time: 332408 07:19:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13365248; Read time: 0; Write time: 2240 07:19:35 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 6311936; Write bytes: 430387200; Read time: 1980; Write time: 325120 07:19:35 INFO - Running post-run listener: _upload_blobber_files 07:19:35 INFO - Blob upload gear active. 07:19:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:19:35 INFO - Copying logs to upload dir... 07:19:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.060080 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-23 07:19:35.645328) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:35.648712) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009939 build_url: 'https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:35.703941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:35.704393) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453558880.464509-1591626610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:35.755316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 07:19:35.755759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 07:19:35.756117) ========= ========= Total master_lag: 0.29 =========