builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1453561093.32 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.324651) ========= 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.325085) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.325413) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006461 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.354319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.354594) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.383665) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.383929) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.442168) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.442450) ========= 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.442777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.443045) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 06:58:14-- 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% 83.9M=0s 2016-01-23 06:58:14 (83.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160234 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.644289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.644567) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017187 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.694868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:13.695233) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 06:58:14,406 truncating revision to first 12 chars 2016-01-23 06:58:14,406 Setting DEBUG logging. 2016-01-23 06:58:14,406 attempt 1/10 2016-01-23 06:58:14,406 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,638 unpacking tar archive at: mozilla-aurora-a046dae8d8e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.264443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.264742) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a046dae8d8e4367d834da27005766a93e36c536e program finished with exit code 0 elapsedTime=0.003386 script_repo_revision: 'a046dae8d8e4367d834da27005766a93e36c536e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.312462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.312753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 06:58:14.324233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-23 06:58:14.324504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:58:15 INFO - MultiFileLogger online at 20160123 06:58:15 in /builds/slave/test-pgo 06:58:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:58:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:58:15 INFO - {'append_to_log': False, 06:58:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:58:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:58:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:58:15 INFO - 'branch': 'Mozilla-Aurora', 06:58:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:58:15 INFO - 'config_files': ('talos/linux_config.py',), 06:58:15 INFO - 'default_actions': ('clobber', 06:58:15 INFO - 'read-buildbot-config', 06:58:15 INFO - 'download-and-extract', 06:58:15 INFO - 'populate-webroot', 06:58:15 INFO - 'create-virtualenv', 06:58:15 INFO - 'install', 06:58:15 INFO - 'run-tests'), 06:58:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:58:15 INFO - 'download_minidump_stackwalk': True, 06:58:15 INFO - 'download_symbols': 'ondemand', 06:58:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:58:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:58:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:58:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:58:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:58:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:58:15 INFO - 'installer_path': 'installer.exe', 06:58:15 INFO - 'log_level': 'info', 06:58:15 INFO - 'log_name': 'talos', 06:58:15 INFO - 'log_to_console': True, 06:58:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:58:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:58:15 INFO - 'opt_config_files': (), 06:58:15 INFO - 'pip_index': False, 06:58:15 INFO - 'sps_profile': False, 06:58:15 INFO - 'sps_profile_interval': 0, 06:58:15 INFO - 'suite': 'dromaeojs', 06:58:15 INFO - 'system_bits': '32', 06:58:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:58:15 INFO - 'title': 'talos-linux64-ix-039', 06:58:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:58:15 INFO - 'use_talos_json': True, 06:58:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:58:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:58:15 INFO - 'work_dir': 'build'} 06:58:15 INFO - ##### 06:58:15 INFO - ##### Running clobber step. 06:58:15 INFO - ##### 06:58:15 INFO - Running pre-action listener: _resource_record_pre_action 06:58:15 INFO - Running main action method: clobber 06:58:15 INFO - rmtree: /builds/slave/test-pgo/build 06:58:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:58:15 INFO - Running post-action listener: _resource_record_post_action 06:58:15 INFO - ##### 06:58:15 INFO - ##### Running read-buildbot-config step. 06:58:15 INFO - ##### 06:58:15 INFO - Running pre-action listener: _resource_record_pre_action 06:58:15 INFO - Running main action method: read_buildbot_config 06:58:15 INFO - Using buildbot properties: 06:58:15 INFO - { 06:58:15 INFO - "properties": { 06:58:15 INFO - "buildnumber": 109, 06:58:15 INFO - "product": "firefox", 06:58:15 INFO - "script_repo_revision": "production", 06:58:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:58:15 INFO - "repository": "", 06:58:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:58:15 INFO - "buildid": "20160123043428", 06:58:15 INFO - "slavename": "talos-linux64-ix-039", 06:58:15 INFO - "pgo_build": "True", 06:58:15 INFO - "basedir": "/builds/slave/test-pgo", 06:58:15 INFO - "project": "", 06:58:15 INFO - "platform": "ubuntu64_hw", 06:58:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:58:15 INFO - "slavebuilddir": "test", 06:58:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:58:15 INFO - "branch": "mozilla-aurora", 06:58:15 INFO - "repo_path": "releases/mozilla-aurora", 06:58:15 INFO - "stage_platform": "linux64-pgo", 06:58:15 INFO - "builduid": "8e8aa56e42ab45a4af8dbc53de481fcc", 06:58:15 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:15 INFO - }, 06:58:15 INFO - "sourcestamp": { 06:58:15 INFO - "repository": "", 06:58:15 INFO - "hasPatch": false, 06:58:15 INFO - "project": "", 06:58:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 06:58:15 INFO - "changes": [ 06:58:15 INFO - { 06:58:15 INFO - "category": null, 06:58:15 INFO - "files": [ 06:58:15 INFO - { 06:58:15 INFO - "url": null, 06:58:15 INFO - "name": "https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 06:58:15 INFO - } 06:58:15 INFO - ], 06:58:15 INFO - "repository": "", 06:58:15 INFO - "rev": "a046dae8d8e4367d834da27005766a93e36c536e", 06:58:15 INFO - "who": "ffxbld", 06:58:15 INFO - "when": 1453561070, 06:58:15 INFO - "number": 7505280, 06:58:15 INFO - "comments": "No bug, Automated blocklist update from host bld-linux64-spot-432 - a=blocklist-update", 06:58:15 INFO - "project": "", 06:58:15 INFO - "at": "Sat 23 Jan 2016 06:57:50", 06:58:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 06:58:15 INFO - "revlink": "", 06:58:15 INFO - "properties": [ 06:58:15 INFO - [ 06:58:15 INFO - "buildid", 06:58:15 INFO - "20160123043428", 06:58:15 INFO - "Change" 06:58:15 INFO - ], 06:58:15 INFO - [ 06:58:15 INFO - "builduid", 06:58:15 INFO - "8e8aa56e42ab45a4af8dbc53de481fcc", 06:58:15 INFO - "Change" 06:58:15 INFO - ], 06:58:15 INFO - [ 06:58:15 INFO - "pgo_build", 06:58:15 INFO - "True", 06:58:15 INFO - "Change" 06:58:15 INFO - ] 06:58:15 INFO - ], 06:58:15 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:15 INFO - } 06:58:15 INFO - ], 06:58:15 INFO - "revision": "a046dae8d8e4367d834da27005766a93e36c536e" 06:58:15 INFO - } 06:58:15 INFO - } 06:58:15 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:15 INFO - Running post-action listener: _resource_record_post_action 06:58:15 INFO - ##### 06:58:15 INFO - ##### Running download-and-extract step. 06:58:15 INFO - ##### 06:58:15 INFO - Running pre-action listener: _resource_record_pre_action 06:58:15 INFO - Running main action method: download_and_extract 06:58:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:58:15 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:15 INFO - https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json 06:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/test_packages.json 06:58:15 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:15 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:16 INFO - Downloaded 1302 bytes. 06:58:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:58:16 INFO - Using the following test package requirements: 06:58:16 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:16 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:58:16 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'jsshell-linux-x86_64.zip'], 06:58:16 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:58:16 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:16 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:58:16 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:58:16 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:58:16 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 06:58:16 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 06:58:16 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:58:16 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:58:16 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:16 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:16 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:16 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:16 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:16 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:17 INFO - Downloaded 23159733 bytes. 06:58:17 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:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:17 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:18 INFO - Return code: 0 06:58:18 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:18 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:18 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:18 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:18 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:18 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:18 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:20 INFO - Downloaded 23159733 bytes. 06:58:20 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:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 06:58:20 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:21 INFO - Return code: 0 06:58:21 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:21 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:21 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:21 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:21 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:21 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:22 INFO - Downloaded 11132038 bytes. 06:58:22 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:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:22 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:23 INFO - Return code: 0 06:58:23 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:23 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:23 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:23 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:23 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:23 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:24 INFO - Downloaded 58024306 bytes. 06:58:24 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:24 INFO - mkdir: /builds/slave/test-pgo/properties 06:58:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:58:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:58:24 INFO - Contents: 06:58:24 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:24 INFO - Running post-action listener: _resource_record_post_action 06:58:24 INFO - Running post-action listener: set_extra_try_arguments 06:58:24 INFO - ##### 06:58:24 INFO - ##### Running populate-webroot step. 06:58:24 INFO - ##### 06:58:24 INFO - Running pre-action listener: _resource_record_pre_action 06:58:24 INFO - Running main action method: populate_webroot 06:58:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:24 INFO - '--tppagecycles', 06:58:24 INFO - '7'], 06:58:24 INFO - 'tests': ['tsvgm']}}, 06:58:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:58:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'tests': ['damp', 'tps']}, 06:58:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['damp', 'tps']}, 06:58:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:58:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:24 INFO - 'other': {'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'other_l64': {'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'other_nol64': {'tests': ['a11yr', 06:58:24 INFO - 'ts_paint', 06:58:24 INFO - 'tpaint', 06:58:24 INFO - 'sessionrestore', 06:58:24 INFO - 'sessionrestore_no_auto_restore']}, 06:58:24 INFO - 'svgr': {'tests': ['tsvgx', 06:58:24 INFO - 'tsvgr_opacity', 06:58:24 INFO - 'tart', 06:58:24 INFO - 'tscrollx', 06:58:24 INFO - 'cart']}, 06:58:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['tsvgx', 06:58:24 INFO - 'tsvgr_opacity', 06:58:24 INFO - 'tart', 06:58:24 INFO - 'tscrollx', 06:58:24 INFO - 'cart']}, 06:58:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'tests': ['tp5o']}, 06:58:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'talos_options': ['--e10s'], 06:58:24 INFO - 'tests': ['tp5o']}, 06:58:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'talos_options': ['--xperf_path', 06:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:24 INFO - 'tests': ['tp5n']}, 06:58:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:24 INFO - 'talos_options': ['--e10s', 06:58:24 INFO - '--xperf_path', 06:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:24 INFO - 'tests': ['tp5n']}}, 06:58:24 INFO - 'talos.zip': {'path': '', 06:58:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:24 INFO - Running post-action listener: _resource_record_post_action 06:58:24 INFO - ##### 06:58:24 INFO - ##### Running create-virtualenv step. 06:58:24 INFO - ##### 06:58:24 INFO - Running pre-action listener: _resource_record_pre_action 06:58:24 INFO - Running main action method: create_virtualenv 06:58:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:58:24 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:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:58:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:24 INFO - Using real prefix '/usr' 06:58:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:58:25 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:27 INFO - Installing pip.................done. 06:58:27 INFO - Return code: 0 06:58:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 06:58:27 INFO - 'HOME': '/home/cltbld', 06:58:27 INFO - 'LANG': 'en_US.UTF-8', 06:58:27 INFO - 'LANGUAGE': 'en_US:en', 06:58:27 INFO - 'LOGNAME': 'cltbld', 06:58:27 INFO - 'MAIL': '/var/mail/cltbld', 06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:27 INFO - 'MOZ_NO_REMOTE': '1', 06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:27 INFO - 'NO_EM_RESTART': '1', 06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:27 INFO - 'SHELL': '/bin/bash', 06:58:27 INFO - 'SHLVL': '1', 06:58:27 INFO - 'TERM': 'linux', 06:58:27 INFO - 'TMOUT': '86400', 06:58:27 INFO - 'USER': 'cltbld', 06:58:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:27 INFO - '_': '/tools/buildbot/bin/python'} 06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:27 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:27 INFO - Cleaning up... 06:58:27 INFO - Return code: 0 06:58:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 06:58:27 INFO - 'HOME': '/home/cltbld', 06:58:27 INFO - 'LANG': 'en_US.UTF-8', 06:58:27 INFO - 'LANGUAGE': 'en_US:en', 06:58:27 INFO - 'LOGNAME': 'cltbld', 06:58:27 INFO - 'MAIL': '/var/mail/cltbld', 06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:27 INFO - 'MOZ_NO_REMOTE': '1', 06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:27 INFO - 'NO_EM_RESTART': '1', 06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:27 INFO - 'SHELL': '/bin/bash', 06:58:27 INFO - 'SHLVL': '1', 06:58:27 INFO - 'TERM': 'linux', 06:58:27 INFO - 'TMOUT': '86400', 06:58:27 INFO - 'USER': 'cltbld', 06:58:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:27 INFO - '_': '/tools/buildbot/bin/python'} 06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:27 INFO - Downloading/unpacking psutil>=0.7.1 06:58:27 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:27 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:27 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:27 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:27 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:27 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:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:29 INFO - Installing collected packages: psutil 06:58:29 INFO - Running setup.py install for psutil 06:58:29 INFO - building 'psutil._psutil_linux' extension 06:58:29 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:29 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:29 INFO - building 'psutil._psutil_posix' extension 06:58:29 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:29 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:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:29 INFO - Successfully installed psutil 06:58:29 INFO - Cleaning up... 06:58:30 INFO - Return code: 0 06:58:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:58:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:30 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 06:58:30 INFO - 'HOME': '/home/cltbld', 06:58:30 INFO - 'LANG': 'en_US.UTF-8', 06:58:30 INFO - 'LANGUAGE': 'en_US:en', 06:58:30 INFO - 'LOGNAME': 'cltbld', 06:58:30 INFO - 'MAIL': '/var/mail/cltbld', 06:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:30 INFO - 'MOZ_NO_REMOTE': '1', 06:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:30 INFO - 'NO_EM_RESTART': '1', 06:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:30 INFO - 'SHELL': '/bin/bash', 06:58:30 INFO - 'SHLVL': '1', 06:58:30 INFO - 'TERM': 'linux', 06:58:30 INFO - 'TMOUT': '86400', 06:58:30 INFO - 'USER': 'cltbld', 06:58:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:30 INFO - '_': '/tools/buildbot/bin/python'} 06:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:30 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:30 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:30 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:30 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:30 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:30 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:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:32 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:32 INFO - Installing collected packages: mozsystemmonitor 06:58:32 INFO - Running setup.py install for mozsystemmonitor 06:58:32 INFO - Successfully installed mozsystemmonitor 06:58:32 INFO - Cleaning up... 06:58:32 INFO - Return code: 0 06:58:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:58:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 06:58:32 INFO - 'HOME': '/home/cltbld', 06:58:32 INFO - 'LANG': 'en_US.UTF-8', 06:58:32 INFO - 'LANGUAGE': 'en_US:en', 06:58:32 INFO - 'LOGNAME': 'cltbld', 06:58:32 INFO - 'MAIL': '/var/mail/cltbld', 06:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:32 INFO - 'MOZ_NO_REMOTE': '1', 06:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:32 INFO - 'NO_EM_RESTART': '1', 06:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:32 INFO - 'SHELL': '/bin/bash', 06:58:32 INFO - 'SHLVL': '1', 06:58:32 INFO - 'TERM': 'linux', 06:58:32 INFO - 'TMOUT': '86400', 06:58:32 INFO - 'USER': 'cltbld', 06:58:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:32 INFO - '_': '/tools/buildbot/bin/python'} 06:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:32 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:32 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:32 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:32 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:32 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:32 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:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:58:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Downloading docopt-0.6.1.tar.gz 06:58:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:34 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:34 INFO - Running setup.py install for blobuploader 06:58:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:58:34 INFO - Running setup.py install for requests 06:58:35 INFO - Running setup.py install for docopt 06:58:35 INFO - Successfully installed blobuploader requests docopt 06:58:35 INFO - Cleaning up... 06:58:35 INFO - Return code: 0 06:58:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:35 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 06:58:35 INFO - 'HOME': '/home/cltbld', 06:58:35 INFO - 'LANG': 'en_US.UTF-8', 06:58:35 INFO - 'LANGUAGE': 'en_US:en', 06:58:35 INFO - 'LOGNAME': 'cltbld', 06:58:35 INFO - 'MAIL': '/var/mail/cltbld', 06:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:35 INFO - 'MOZ_NO_REMOTE': '1', 06:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:35 INFO - 'NO_EM_RESTART': '1', 06:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:35 INFO - 'SHELL': '/bin/bash', 06:58:35 INFO - 'SHLVL': '1', 06:58:35 INFO - 'TERM': 'linux', 06:58:35 INFO - 'TMOUT': '86400', 06:58:35 INFO - 'USER': 'cltbld', 06:58:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:35 INFO - '_': '/tools/buildbot/bin/python'} 06:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:35 INFO - Running setup.py (path:/tmp/pip-E9Xmma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:35 INFO - Running setup.py (path:/tmp/pip-AjNWs4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:35 INFO - Running setup.py (path:/tmp/pip-S40E0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:35 INFO - Running setup.py (path:/tmp/pip-pr2ZC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:35 INFO - Running setup.py (path:/tmp/pip-vvwkoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:36 INFO - Running setup.py (path:/tmp/pip-quQ1cM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:36 INFO - Running setup.py (path:/tmp/pip-8tveAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:36 INFO - Running setup.py (path:/tmp/pip-4mm2e9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:36 INFO - Running setup.py (path:/tmp/pip-N5rxIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:36 INFO - Running setup.py (path:/tmp/pip-j7AYZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:36 INFO - Running setup.py (path:/tmp/pip-kf3zwD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:36 INFO - Running setup.py (path:/tmp/pip-Dyo7b7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:36 INFO - Running setup.py (path:/tmp/pip-FArLVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:36 INFO - Running setup.py (path:/tmp/pip-J3csTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:36 INFO - Running setup.py (path:/tmp/pip-7OmjtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:36 INFO - Running setup.py (path:/tmp/pip-mF7lfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:36 INFO - Running setup.py (path:/tmp/pip-nYrqhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:36 INFO - Running setup.py install for manifestparser 06:58:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for mozcrash 06:58:37 INFO - Running setup.py install for mozdebug 06:58:37 INFO - Running setup.py install for mozdevice 06:58:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for mozfile 06:58:37 INFO - Running setup.py install for mozhttpd 06:58:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for mozinfo 06:58:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for mozInstall 06:58:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for mozleak 06:58:37 INFO - Running setup.py install for mozlog 06:58:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:58:37 INFO - Running setup.py install for moznetwork 06:58:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Running setup.py install for mozprocess 06:58:38 INFO - Running setup.py install for mozprofile 06:58:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Running setup.py install for mozrunner 06:58:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Running setup.py install for mozscreenshot 06:58:38 INFO - Running setup.py install for moztest 06:58:38 INFO - Running setup.py install for mozversion 06:58:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:58:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:38 INFO - Cleaning up... 06:58:38 INFO - Return code: 0 06:58:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:38 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 06:58:38 INFO - 'HOME': '/home/cltbld', 06:58:38 INFO - 'LANG': 'en_US.UTF-8', 06:58:38 INFO - 'LANGUAGE': 'en_US:en', 06:58:38 INFO - 'LOGNAME': 'cltbld', 06:58:38 INFO - 'MAIL': '/var/mail/cltbld', 06:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:38 INFO - 'MOZ_NO_REMOTE': '1', 06:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:38 INFO - 'NO_EM_RESTART': '1', 06:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:38 INFO - 'SHELL': '/bin/bash', 06:58:38 INFO - 'SHLVL': '1', 06:58:38 INFO - 'TERM': 'linux', 06:58:38 INFO - 'TMOUT': '86400', 06:58:38 INFO - 'USER': 'cltbld', 06:58:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:38 INFO - '_': '/tools/buildbot/bin/python'} 06:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:38 INFO - Running setup.py (path:/tmp/pip-sgUjeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:39 INFO - Running setup.py (path:/tmp/pip-F5x0AD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:39 INFO - Running setup.py (path:/tmp/pip-NjSNrT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:39 INFO - Running setup.py (path:/tmp/pip-e6ELO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:39 INFO - Running setup.py (path:/tmp/pip-XJKTIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:39 INFO - Running setup.py (path:/tmp/pip-l5Tk1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:39 INFO - Running setup.py (path:/tmp/pip-3yryZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:39 INFO - Running setup.py (path:/tmp/pip-Djc7bE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:39 INFO - Running setup.py (path:/tmp/pip-GfVc4F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:39 INFO - Running setup.py (path:/tmp/pip-9_gc6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:39 INFO - Running setup.py (path:/tmp/pip-UgSYba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:39 INFO - Running setup.py (path:/tmp/pip-5aQInB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:39 INFO - Running setup.py (path:/tmp/pip-1pzJwZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:39 INFO - Running setup.py (path:/tmp/pip-la93Np-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:39 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:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:39 INFO - Running setup.py (path:/tmp/pip-TD5d5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:40 INFO - Running setup.py (path:/tmp/pip-zsM2jR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:40 INFO - Running setup.py (path:/tmp/pip-hdUSiF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloading blessings-1.6.tar.gz 06:58:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:41 INFO - Installing collected packages: blessings 06:58:42 INFO - Running setup.py install for blessings 06:58:42 INFO - Successfully installed blessings 06:58:42 INFO - Cleaning up... 06:58:42 INFO - Return code: 0 06:58:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:58:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:58:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:58:42 INFO - Reading from file tmpfile_stdout 06:58:42 INFO - Current package versions: 06:58:42 INFO - argparse == 1.2.1 06:58:42 INFO - blessings == 1.6 06:58:42 INFO - blobuploader == 1.2.4 06:58:42 INFO - docopt == 0.6.1 06:58:42 INFO - manifestparser == 1.1 06:58:42 INFO - mozInstall == 1.12 06:58:42 INFO - mozcrash == 0.16 06:58:42 INFO - mozdebug == 0.1 06:58:42 INFO - mozdevice == 0.47 06:58:42 INFO - mozfile == 1.2 06:58:42 INFO - mozhttpd == 0.7 06:58:42 INFO - mozinfo == 0.9 06:58:42 INFO - mozleak == 0.1 06:58:42 INFO - mozlog == 3.1 06:58:42 INFO - moznetwork == 0.27 06:58:42 INFO - mozprocess == 0.22 06:58:42 INFO - mozprofile == 0.27 06:58:42 INFO - mozrunner == 6.11 06:58:42 INFO - mozscreenshot == 0.1 06:58:42 INFO - mozsystemmonitor == 0.0 06:58:42 INFO - moztest == 0.7 06:58:42 INFO - mozversion == 1.4 06:58:42 INFO - psutil == 3.1.1 06:58:42 INFO - requests == 1.2.3 06:58:42 INFO - wsgiref == 0.1.2 06:58:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:42 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:42 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:58:42 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:58:42 INFO - Using env: {'DISPLAY': ':0', 06:58:42 INFO - 'HOME': '/home/cltbld', 06:58:42 INFO - 'LANG': 'en_US.UTF-8', 06:58:42 INFO - 'LANGUAGE': 'en_US:en', 06:58:42 INFO - 'LOGNAME': 'cltbld', 06:58:42 INFO - 'MAIL': '/var/mail/cltbld', 06:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:42 INFO - 'MOZ_NO_REMOTE': '1', 06:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:42 INFO - 'NO_EM_RESTART': '1', 06:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:42 INFO - 'SHELL': '/bin/bash', 06:58:42 INFO - 'SHLVL': '1', 06:58:42 INFO - 'TERM': 'linux', 06:58:42 INFO - 'TMOUT': '86400', 06:58:42 INFO - 'USER': 'cltbld', 06:58:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:42 INFO - '_': '/tools/buildbot/bin/python'} 06:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 INFO - Cleaning up... 06:58:42 INFO - Return code: 0 06:58:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:58:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:42 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 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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:42 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:58:42 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:58:42 INFO - Using env: {'DISPLAY': ':0', 06:58:42 INFO - 'HOME': '/home/cltbld', 06:58:42 INFO - 'LANG': 'en_US.UTF-8', 06:58:42 INFO - 'LANGUAGE': 'en_US:en', 06:58:42 INFO - 'LOGNAME': 'cltbld', 06:58:42 INFO - 'MAIL': '/var/mail/cltbld', 06:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:42 INFO - 'MOZ_NO_REMOTE': '1', 06:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:42 INFO - 'NO_EM_RESTART': '1', 06:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:42 INFO - 'SHELL': '/bin/bash', 06:58:42 INFO - 'SHLVL': '1', 06:58:42 INFO - 'TERM': 'linux', 06:58:42 INFO - 'TMOUT': '86400', 06:58:42 INFO - 'USER': 'cltbld', 06:58:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:42 INFO - '_': '/tools/buildbot/bin/python'} 06:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:42 INFO - Downloading/unpacking jsonschema 06:58:42 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:42 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:42 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:42 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:42 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:42 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:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:44 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:44 INFO - warning: no files found matching '*.txt' 06:58:44 INFO - no previously-included directories found matching 'build' 06:58:44 INFO - no previously-included directories found matching 'dist' 06:58:44 INFO - no previously-included directories found matching '.git*' 06:58:44 INFO - Installing collected packages: jsonschema, functools32 06:58:44 INFO - Running setup.py install for functools32 06:58:44 INFO - warning: no files found matching '*.txt' 06:58:44 INFO - no previously-included directories found matching 'build' 06:58:44 INFO - no previously-included directories found matching 'dist' 06:58:44 INFO - no previously-included directories found matching '.git*' 06:58:44 INFO - Successfully installed jsonschema functools32 06:58:44 INFO - Cleaning up... 06:58:45 INFO - Return code: 0 06:58:45 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1744ebef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', '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', 'flake8'] 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 flake8 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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 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 flake8 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:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58:46 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:46 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:46 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:46 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:46 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:46 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 - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:47 INFO - no previously-included directories found matching 'docs/_build' 06:58:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:47 INFO - Running setup.py install for pep8 06:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:47 INFO - no previously-included directories found matching 'docs/_build' 06:58:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:58:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:47 INFO - Cleaning up... 06:58:47 INFO - Return code: 0 06:58:47 INFO - Running post-action listener: _resource_record_post_action 06:58:47 INFO - Running post-action listener: _start_resource_monitoring 06:58:47 INFO - Starting resource monitoring. 06:58:47 INFO - ##### 06:58:47 INFO - ##### Running install step. 06:58:47 INFO - ##### 06:58:47 INFO - Running pre-action listener: _resource_record_pre_action 06:58:47 INFO - Running main action method: install 06:58:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:58:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:58:48 INFO - Reading from file tmpfile_stdout 06:58:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:58:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:58:48 INFO - Reading from file tmpfile_stdout 06:58:48 INFO - Output received: 06:58:48 INFO - Usage: mozinstall [options] installer 06:58:48 INFO - Options: 06:58:48 INFO - -h, --help show this help message and exit 06:58:48 INFO - -d DEST, --destination=DEST 06:58:48 INFO - Directory to install application into. [default: 06:58:48 INFO - "/builds/slave/test-pgo"] 06:58:48 INFO - --app=APP Application being installed. [default: firefox] 06:58:48 INFO - mkdir: /builds/slave/test-pgo/build/application 06:58:48 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:58:48 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:03 INFO - Reading from file tmpfile_stdout 06:59:03 INFO - Output received: 06:59:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:59:03 INFO - Running post-action listener: _resource_record_post_action 06:59:03 INFO - ##### 06:59:03 INFO - ##### Running run-tests step. 06:59:03 INFO - ##### 06:59:03 INFO - Running pre-action listener: _resource_record_pre_action 06:59:03 INFO - Running main action method: run_tests 06:59:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:59:03 INFO - Python 2.7.3 06:59:03 INFO - Return code: 0 06:59:03 INFO - grabbing minidump binary from tooltool 06:59:03 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:03 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 0x22d8350>, '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 0x22d9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d96e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:59:03 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:03 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:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:03 INFO - Return code: 0 06:59:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:59:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:59:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:59:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:59:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:59:04 INFO - Return code: 0 06:59:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:59:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 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 - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:59:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:04 INFO - 'MOZ_NO_REMOTE': '1', 06:59:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 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': '/builds/slave/test-pgo/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 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': '5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325', 06:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:04 INFO - '_': '/tools/buildbot/bin/python'} 06:59:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ka1tEZhrR1uJFCd18NkiwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 06:59:04 INFO - mozversion INFO | application_buildid: 20160123043428 06:59:04 INFO - mozversion INFO | application_changeset: a046dae8d8e4367d834da27005766a93e36c536e 06:59:04 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 06:59:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:04 INFO - mozversion INFO | application_name: Firefox 06:59:04 INFO - mozversion INFO | application_remotingname: firefox-dev 06:59:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:04 INFO - mozversion INFO | application_vendor: Mozilla 06:59:04 INFO - mozversion INFO | application_version: 45.0a2 06:59:04 INFO - mozversion INFO | platform_buildid: 20160123043428 06:59:04 INFO - mozversion INFO | platform_changeset: a046dae8d8e4367d834da27005766a93e36c536e 06:59:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:04 INFO - mozversion INFO | platform_version: 45.0a2 06:59:04 INFO - 2016-01-23 06:59:04,343 DEBUG : using testdate: 1453561144 06:59:04 INFO - 2016-01-23 06:59:04,343 DEBUG : actual date: 1453561144 06:59:04 INFO - 2016-01-23 06:59:04,351 INFO : starting webserver on 'localhost:43620' 06:59:04 INFO - 2016-01-23 06:59:04,352 INFO : Starting test suite talos-linux64-ix-039 06:59:04 INFO - 2016-01-23 06:59:04,352 INFO : Starting test dromaeo_css 06:59:04 INFO - 2016-01-23 06:59:04,352 DEBUG : operating with platform_type : linux_ 06:59:04 INFO - 2016-01-23 06:59:04,353 INFO : Initialising browser for dromaeo_css test... 06:59:04 INFO - 2016-01-23 06:59:04,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbxqH3q/profile http://localhost:43620/getInfo.html 06:59:08 INFO - 2016-01-23 06:59:08,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:59:08 INFO - 2016-01-23 06:59:08,713 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:59:08 INFO - 2016-01-23 06:59:08,713 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:59:08 INFO - 2016-01-23 06:59:08,713 DEBUG : BROWSER_OUTPUT: __metrics 06:59:08 INFO - 2016-01-23 06:59:08,890 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:59:09 INFO - 2016-01-23 06:59:09,736 INFO : Browser initialized. 06:59:09 INFO - 2016-01-23 06:59:09,737 INFO : Running cycle 1/1 for dromaeo_css test... 06:59:09 INFO - 2016-01-23 06:59:09,737 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbxqH3q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:59:21 INFO - 2016-01-23 06:59:21,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 137211904 06:59:21 INFO - 2016-01-23 06:59:21,521 DEBUG : BROWSER_OUTPUT: 07:00:12 INFO - 2016-01-23 07:00:12,338 DEBUG : BROWSER_OUTPUT: 1453561212337 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:21 INFO - 2016-01-23 07:02:21,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43620/tests/dromaeo/cssquery-ext.html) 07:02:22 INFO - 2016-01-23 07:02:22,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 261079040 07:02:22 INFO - 2016-01-23 07:02:22,438 DEBUG : BROWSER_OUTPUT: 07:05:24 INFO - 2016-01-23 07:05:24,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-ext.html (next: http://localhost:43620/tests/dromaeo/cssquery-jquery.html) 07:05:25 INFO - 2016-01-23 07:05:25,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 220377088 07:05:25 INFO - 2016-01-23 07:05:25,166 DEBUG : BROWSER_OUTPUT: 07:08:26 INFO - 2016-01-23 07:08:26,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43620/tests/dromaeo/cssquery-mootools.html) 07:08:27 INFO - 2016-01-23 07:08:27,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 223404032 07:08:27 INFO - 2016-01-23 07:08:27,547 DEBUG : BROWSER_OUTPUT: 07:11:29 INFO - 2016-01-23 07:11:29,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43620/tests/dromaeo/cssquery-prototype.html) 07:11:29 INFO - 2016-01-23 07:11:29,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 200953856 07:11:29 INFO - 2016-01-23 07:11:29,909 DEBUG : BROWSER_OUTPUT: 07:14:32 INFO - 2016-01-23 07:14:32,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43620/tests/dromaeo/cssquery-yui.html) 07:14:32 INFO - 2016-01-23 07:14:32,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 204288000 07:14:32 INFO - 2016-01-23 07:14:32,913 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/dromaeo/cssquery-yui.html (next: http://localhost:43620/tests/dromaeo/cssquery-dojo.html) 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 245518336 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:35 INFO - 2016-01-23 07:17:35,353 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:35 INFO - 2016-01-23 07:17:35,355 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3163.8259895705737;3232.0627018164732;3261.608606967164;3262.347530493902;3276.83615819209;5504.862378440541;5531.142672885704;5545.916811247835;5559.11054231323;5587.692676902769;5517.172424136382;5575.944240557593;5595;5600.355959064709;5601.747921343539;4909.091818013679;5023.8492845214705;5071.923921141186;5091.389033316007;5174.094533456649;4982.302477653131;5044.092063428581;5045.394552653686;5048.1670524363435;5051.217061355495;4916.926246106294;5014.5737612303;5016.147254966646;5052.797888084472;5091.490850914916;4998.7250701211415;5089.185730283137;5099.566536844335;5101.566366858821;5122.129238029544;4963.1810751226;5068.341115654978;5069.518395752398;5077.339945807058;5089.389273287229;5156.432792392871;5236.581073514109;5289.629725919149;5366.114591092465;5392.083345831218;5892.528597712173;5920.289565252154;5930.525557955353;5939.821805345803;5942.435468630516;5906.5570082244;5956.463918247336;5973.1040343948325;5973.970130149321;6014.669193194372;5355.839324820262;5440.347158341025;5502.422245664227;5556.833295001116;5558.249636299129;6065.1486306195;6075.878482430415;6113.663748493786;6113.84715382119;6125.356837531995;5866.911996320058;5870.501007414332;5871.178035075093;5872.941270587325;5882.499987501024;5675.233843431167;5758.798442054592;5815.505682016991;5907.409259074144;5973.372795856372;5897.616654917417;5903.616264942765;5906.379830117861;5908.675022873697;5934.228550288435;5862.325832529228;5895.793647222326;5916.437938395846;5918.881622367615;5920.526357891358;4473.284274516127;4492.483364413069;4524;4553.043860789271;4569.246074397754;4079.082206503513;4094.1197642507004;4096.09885825118;4113.074558224375;4113.218488487178;5489.752961116759;5708.628939119027;5712.200291959129;5714.200011998323;5717.028105222123;5915.940840591625;5956.55325850563;5983.640981541122;6014.278286605635;6057.121717350959;5549.472800083986;5572.693501857437;5573.164025396142;5654.830355089354;5659.3208814941645;5002.224655178453;5091.363579552556;5177.249298851645;5183.922241166386;5187.377514698261;6000.789972350947;6051.667158306335;6055.182550355734;6084.361142080018;6099.085137229363;5889.823305300848;5903.586748927534;5909.734061967308;5910.143029260647;5982.7008649568215;5873.853153671193;5946.881062378641;6054.515638748801;6055.091736239599;6060.606060606046;5828.417158284137;5870.324912635102;5872.0898260769645;5875.970620146872;5900.1149827526215;5936.673482958306;5966.701664916824;6045.6070355426755;6046.606970546901;6053.757849685963;5575.526080283222;5658.85852853682;5711.314642242791;5872.236609240771;5883.470487656132;5754.798582049608;5760.0783874579865;5760.279965004374;5764.193012978102;5833.066709326487;5676.545876329967;5676.801311954227;5678.14827775837;5682.77268909239;5685.658860468385;5633.577481688808;5668.688222147656;5710.771569137188;5739.713014349182;5782.942170578409;5689.203511508309;5751.281089863767;5752.367239603724;5752.453516915886;5756.42435756421 07:17:35 INFO - 2016-01-23 07:17:35,356 DEBUG : BROWSER_OUTPUT: |1;ext.html;589.5224867857033;629.8551333193366;633.8098570428872;634.9523785716069;637.5377851057987;31750.841245793767;32466.837665811698;32528.67471325286;32570.67429325706;32606.99999999997;33621.49567756485;42167.36748948768;42181.367279490754;42332.78833605828;42388.364174537404;9044.592993315317;9176.403533770317;9178.495182764946;9179.31155163362;9195.356325057248;8238.176182381743;8423.284020858235;8981.371304008722;9083.818323633523;9117.45295282282;8185.3451723861945;10966.232363734542;11221.046211072027;11226.550937962513;11227.214095013353;10759.139268858511;10857;10874.293170943942;10875.728106797314;10884.564617415374;8246.134155913604;8415;8441.902552668114;10608.469576521144;10769.946150269277;42575.36136957948;43011.784941075406;43223.351649724966;43285.35071973923;43285.56714432847;3325;3963.1479231964977;4154.875353739392;4253.574642535753;4321.503027151855;30558.84720576405;30699.232519186975;30760;30914.381712365626;32060.038198854072;4082.0611259410207;4082.9591704082877;4110.486189226347;4125.463689720317;4190.727602705814;233423;234317;234644;234827;236050;57273.427265727645;57620.423795761504;57652.135217971765;57730.711346443;57738.42261577331;61028.08457873135;61154.69422652947;61254.69372653197;61283.69358153181;61501;17736.467905962843;18114.184861681257;18251.45245642633;18272.269109235483;18299.817001830077;12912.870871291354;12936.482540698455;12936.870631293756;12938.805917911239;12939.741205175844;19624.509387265432;20033.398998030083;20247.19011239534;20255.29106481266;20285.695714564292;7974.4848478788845;8238.588070596446;8270.751877443687;8275.131111233233;8302.958485207535;976.5898322704481;1021.9591216351412;1028.7325295423243;1045.9592705258165;1133.7619099989095;26406.47187056248;26432.47135057288;26548.60177097345;27423.86288068587;27796.86101569479;1029.4852573713144;1109.2678831970861;1109.589451902785;1122.9157813163881;1154.6651471073462;14045;14193.858061419254;14341.282935853165;16775.496735097724;17319.04745239024;334336;340000;340856;341951;342456;49293;55202.17196742052;55512.16731749027;55554.44445555493;55610.16584751232;1343.7245364700213;1425.5723283015054;1439.2659743530874;1453.4622189789634;1454.5854431486975;27471;27581.31046723848;27837.16488505348;28073.298167545974;28311.858440707663;41181;41389.1722165561;41414.58585414107;41547.7922610385;41720.37419438772;186346;187535;187708;187994;226686;33118.337633247684;33441;33528.329433410705;33577.83211083929;33881.66118338884;45622.771886140355;47125;47502.52497474981;47717.52282477131;47736.28395574139;39633.36443515303;40143.799281004576;40534;41074.794626026676;41159.38260926028;38745;41715.33138674419;41976;42510.36234456424;43101.56898430976;37824.43263350997;38100;38187.61812381952;38990.220195595364;39858.800705996284;29772.255693607833;30847.84576077105;31467.898623548066;31495.21261968469;31547.842260789468;24299.878500607385;24581.13966011181;24587.50824983526;24849.254522364357;24992.37519062038 07:17:35 INFO - 2016-01-23 07:17:35,357 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.42144572418516;385.335296613342;386.9864554740584;386.9922601547969;392.1177350960339;14865.628359290997;17165.227564759585;17204.82795172048;19669.21323147074;19681.114349854255;17213;17519.91240043801;17664.205110770014;19004.904975475103;19383.90308048461;5068.06240845443;5186.740662966856;5197.324347834776;5197.48025197481;5203.375594928614;3911.4915061042025;4019.859304924328;5131.1277082895995;5484.588655850807;5682.914756278659;5535.972320138394;5622.128570071645;5665.971670141644;5676.545876329905;5753.424657534255;5516.696581688006;5609.49514543691;5612.69130197841;5616.691081990489;5622.381538030813;5423.322084739408;5424.1321388578035;5425.159100339453;5427;5433;20356.18575256988;22207.44481387962;22398.552028959493;22467.32598022062;22609.886950565306;2140.6146893559153;2167.5448155887284;2210.1490925993608;2219.5006123622215;2242.7532971373134;10016.89983100167;10475.423851688154;11796.203796203796;14386.640333991629;14529.256489221361;1951.9512012199666;1967.1049672399024;1977.2881762565464;1977.7033444983224;1993.7408136942104;63758;65179.674101629185;65679.67160164217;66380.3361966379;67092.66453667701;11094;11283;11284.830727539094;11288.927551882558;11361.943190283995;15007.774883376758;15012.47456339023;15023.699526009637;15041.172735499435;15041.172735499435;8587.914120858712;8632;8644.178803013703;8645.13548645143;8658.437201581877;8082.878756818653;8104;8397.6221070052;8474.491530508067;8496.980362356557;4689.859304220879;4741.739204343794;4780.856574302777;4849.175640141185;4872.4640289568115;1784.4614439234836;1836.6143109946793;1899.9145038473303;1906.9332573359866;2008.0682203982058;471.25776901380465;975.7365511311906;983.8868530119128;1028.7582418131733;1132.8897680273378;10645.988631080036;10751.08615767653;10907.29102608328;10930.180236482296;11242.94378528102;462.43582828948627;466.88327918020497;480.4474853918022;486.7931129270046;499.0268975497794;5963.224780778558;6199.659018754011;6204.348543402968;6209.06863970399;6211.782587609502;614341;619992.1003554851;630476;631895;649848;86121.56939215264;86130.13869861221;86413.56793215993;86465.13534864696;87121;528.5084871069942;533.1416419564498;533.1868899927641;533.4025891002102;533.5278278723358;10551.366917984946;10654.094401975919;10679.89320106789;15383.846161538242;15943.362265509713;34568.82715586406;34896.47655285223;35240.647593524765;36941;38969.41545876757;46794;46901.76549117233;47973.280400793315;48081;48140.27789583229;9891.604335826487;10463;10471.94764026175;10472.790544189225;10473.795513516043;12209.69475763113;14981.325840336993;18908.716369254198;19025.95357255364;19454.610907781484;15738.449154279546;15779.526614201592;15901.204939753197;16034;16206.108664023592;15345.6163595911;15352.846471535142;15595.532134035997;15920.124393158025;16148.838511614733;12447.813282800946;16213.432529861399;16415.507534773977;16562;16591.17044147812;9254.907450925404;10289.176865850864;10332.431716255678;10362.067413932782;10446.373217606968;10474.738131546772;10542.314749541561;13615.65960850947;15969.520914372588;16365.099919504542 07:17:35 INFO - 2016-01-23 07:17:35,357 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1558.8674962628177;1608.437047033538;1644.4902080355084;1780.0216516086543;1881.0594702648675;6827.829304267396;7623.504472209303;7806.375489960804;7814.843703125934;7835.608219589027;7615.352695020916;7793.688252469909;7795.259450352221;7795.883061754078;7800.843983120334;1827.734978428127;1855.6195979824172;2233.7207849018873;2248.786365295294;2257.7403598586125;2328.5924963131383;2335.2760644200266;2335.5795956727784;2335.92992210234;2340.871252081135;2206.3932418584936;2268.6823844661762;2272.4318920269934;2273.374821923976;2274.044901141516;2220.5003874128274;2223.1996481266733;2247.4493749031512;2254.9210777622707;2258.378945789921;2239.8320125990454;2262;2275.055851821492;2275.0672224388086;2278.1798552521077;7784.688612455495;7839.568823714693;7840.41196910234;7843.37253019757;7846.215378462165;4668.50980647034;4711.599514041311;4717.457492388385;4761.642876784255;4767.094252092092;3077.81533108012;3117.0960421477744;3120.3915236528887;3130.827804470753;3255.4140254754134;1027.7790275090817;1035.8083754505365;1051.369178492898;1092.071739021833;1098.1105304703217;10522.947385263102;10524.421156836372;10567.682969510926;10574.52414641343;10584.894151058545;3979.6020397959974;4059.2490389278078;4080.6327430531396;4097.836086556564;4116.650084742771;8532.360072994426;8548.358873084419;8559.101294364127;8560.957195214109;8561.914380856111;4611.469680986729;4641.721496710208;4641.814327426932;4649.814007439664;4651.023285110097;4310.43964284641;4310.978445107817;4315.719478233905;4318.287482565342;4320;3211.197200699825;3278.3115545735664;3314.93370132596;3348.8995330140133;3401.9489707654407;1068.1134658233648;1079.3092420850662;1079.8110330692098;1081.086481922774;1083.7453198498347;1132.8753837077916;1134.3760931487648;1188.9359023673765;1349.39951721483;1413.8798202152932;7386.630668466555;7470.215627359049;7487.8502429951095;7516;7558.697652093854;658.8517583543664;663.7079684938611;664.1299897134769;668.1748041169152;811.1280373598405;5676.77292908279;5776.56675749312;5778.133280008033;5835.533157347402;5838.678872662044;9295.53522323881;9303;9357.438553686801;9419;9673.129418352382;9335.766605834908;9457;9554.378965367228;9572.664956726621;9664.985176556502;7216.458765592602;7414.703411863465;7415.1843297237265;7436.330730234305;7493.063367079115;7510;7588.696452142073;7603.429742769204;7605.88591171144;7608.80977975555;8452.281556067803;8522.74431767048;8559.358048146538;8678.869816952625;8694.391392602458;8684.43551169172;8687.782805429915;8710.956445217733;8800.075992020746;8835.69075082369;7040.964795175992;7148.17795953472;7158.3915367192285;7160.964195178991;7162.176349719849;6582.572132811352;6872.656367181521;7365.852682946418;7477.738279160203;7497.400207983239;7032.472564557576;7076.0801095857205;7135.286471352823;7189.1013623297085;7200.783976480714;6862.4166945808165;6902.206246281742;7027.8945815811785;7135.393491553276;7194.676239569337;7018.227994920657;7138.39323657495;7154.35610795031;7163.964180179066;7169.068021157216;6273.843153921006;6297.96851015742;6310.368963103653;6312.147860038836;6318.9052164216655;6226.25284965807;6255.906161407492;6261.812145635456;6264.843378915563;6273 07:17:35 INFO - 2016-01-23 07:17:35,358 DEBUG : BROWSER_OUTPUT: |4;prototype.html;349.50195970741703;352.2479506254147;358.89771415146686;359.55774397491086;361.14408851023063;5853.414658534144;5968.641881487114;5994.910076348853;6005.129256257846;6045.546584006195;5790.884182316351;5886.205362276091;5919.37846526115;5925.585209035369;5962.850928726784;4663.626909847204;4678.836240731575;4687.554682305175;4688.179568575502;4697.201475749131;4444.266695995173;4555.74943378114;4574.565416285448;4662.790174442158;4675.625949924015;4606.953930460686;4624.167649823031;4628.722276663411;4636.53634636537;4656.5343465653505;4602.746848923308;4617.568553748332;4637.721736695809;4638.83764068256;4655.627549796008;4114.136031433402;4126.525449573277;4129;4135.503739551243;4141.006158521933;5491.560675145979;5619.241402410704;5638.915416268759;5644.745986430579;5668.178114173422;5399.5680345572655;5410.91883621746;5411.918821217685;5413.756380962866;5419.945800541984;6310.116583678288;6312.179416675803;6316.873662526724;6317.1156038154695;6325.209348831396;4353.847615333448;4458.5318541553315;4462.843800466968;4567.611753000966;4582.175208462475;6525.967370163166;6560.376764207393;6568.408843204087;6586.868262634768;6588.736450541973;4677.2750223715375;4678.929816052762;4681.040386720714;4681.29780532916;4686.882827929329;4593.885152871205;4692.741899195577;4695.154872122982;4739.241721324641;4755.476897541268;5406.864828379322;5414.675119492843;5420.53925416344;5421.2139239810795;5423.755930983037;6323.620582765049;6343.651099189589;6375.394337537927;6388.648624325614;6390.041493775878;1662.4846297647769;1685.3932584269899;1686.5783554111472;1686.898786072815;1689.2145152504145;1117.871444783844;1125.8254970479588;1158.154547180563;1160.640201537526;1164.318873459036;6176.3514830943;6177.073438984098;6182.907256391158;6187.195664563578;6189.133521307021;6519.8696026079215;6531.314212007671;6536.607803531803;6543.1166792483355;6544.280129185786;6057.091436284504;6179.62922224668;6181.660008699565;6182.28903676074;6189.195404597373;3519.4720791881423;3533.575970883459;3554.608993010767;3555.1823080691584;3557.2351944332095;6721.66391680414;6725.083351244872;6726.327367263235;6731.024001519752;6735.158105236846;6563.474922006228;6702;6707.618795327686;6715.46276297895;6715.5299129060495;6714.362135597111;6716.664166791738;6719.832004199934;6720.798376048726;6722.899156512656;6354.301026887131;6525.282218956006;6527.2167339919515;6531.706073226811;6535.869282614416;6333.145025421509;6405.743770249138;6523.6738163092605;6558.737650494118;6572;6737.191537015589;6742.898856517254;6770.661466926733;6790.490713196431;6793.354631310018;4652.837150699709;4664.463586687574;4675.251959686434;4706.529347065266;4736;6581;6582.275949645631;6590.7693230736695;6592.80221593353;6597.406233439014;6411.6794160290865;6419.967900160469;6431.549791514549;6434.581752186093;6437.903431448625;6337.780638134571;6407.775727849503;6434.549581529248;6440.903386449113;6443;6344.27040890285;6346.397092276226;6348.746050157942;6352.618842869442;6354.555181137276;6415.037744338387;6468.935310646833;6470.579412338183;6474.223093228654;6479.352064793671;6135.7238924249405;6250.312465628686;6260.436560709376;6266.905996410149;6281.057841323838 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: |5;yui.html;865.8831057807196;879.9032106468287;920.6869664314132;925.6158694141932;928.3084102343755;14082.788758168623;14495.49265775698;14496.347664355102;14502.492412765541;14506.564803055926;13070.93464532676;13161.934190329059;13167.078304518687;13170.01224908131;13201.075924685276;761.075293518375;766.030970821908;902.3908861518481;904.1004200820194;914.4970266353512;918.2149262380668;920.4661296448078;928.0441145620022;928.215657769184;928.4058202750246;944.6599224279254;945.3524335829944;947.606743201574;952.057463111518;954.298590535959;785.5208322923013;794.9523028618272;947.9052094790535;960.6061514778977;962.5572236771023;711.6655172069119;713.7359177104453;714.1002337055296;714.2821464428268;717.4224749076991;13944.790828137586;14152.36314365856;14163.716725665532;14189.148651080865;14275.357608907623;13218.86781132186;13431.328433578283;13485.865141348559;13852.168869867739;13967.161970281815;10829.83755243672;10876;10956.178286628534;11108.888911110866;11159;3687.3547129252274;3789.905252368685;3793.620637936212;3816.446615240802;3820.522434695663;50966.49033509655;53128.46871531274;53513;53707.73146134283;53797.92404151934;10431.113355364727;10494.947525262478;10571.20715946307;10878.836817447745;10975.50610222542;19595.804041959396;19607.705884411746;19613.50966225856;19615.509612259808;19634.410967670992;7728.149903510609;7941.682332706627;8006.559639219782;8069.878951815727;8659.350548708871;4543.636509079266;4590.8163673453355;4675.602573781267;4676.649251306166;4680.555347242007;3367.966320336814;3377.712894403954;3380.543626610376;3387.6104248011793;3389.5254664347012;605.9727312270959;621.586644881149;627.9277883043417;631.9936800632026;633.240111865763;706.4524993130365;707.7416742888809;710.4281053751677;743.6170372258291;776.4952780692595;8379.162083791694;8851.60167792451;9060.773480663036;9346.485943273185;9736.269779766404;646.0567571345794;660.2108286543521;699.40899939551;736.4329466310911;740.6629983357559;4258.446401967724;4432.401625780479;4530.22986092365;4561.429821272341;4765.332853400527;64252.678736606016;64464.67767661226;64508.35491645117;64565;64730;59040.40959590435;59614.403855961755;59746.70126649426;60291.39708602858;61167.69416152891;51494;51677.48322516727;51915.740421297654;52133.478665213624;52244.21633675498;8958.641654334015;9012.594433250651;9174.495402752913;9299.302552308469;9385;37719.245615087;37926.62073379231;38461.423078653286;38927.6107238924;38959.026024349616;45973.77013115047;49897.50102498929;50485;50583.49416505788;50976.74511627418;11619.419029048682;11653.30080195191;12055.15613907018;12227.388630568614;12458.937705311415;13258.204507729568;13534.932325338705;13551.390187441786;13993.230372329212;14269.215193164475;11924;12275.508979641072;12327.75344493123;12691.492340306284;12972.35138243103;12301.138920275853;12552.435140418886;12710.110292279453;12978.620816494808;13224.537141200397;11829.704257393634;11906.107041971714;11934.22427542207;12544;12588.244705317711;10986.615468458565;11026.117910567296;11033.752534686651;11275.436228188722;11446;10137.866590712512;10545.10366618846;10615.840762388416;10654.520546575268;10733.248672592843 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1068 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562255353__endTimestamp 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5496.36 Median:5708.63 stddev:613.37 (10.7%) stddev-sans-first:587.32 07:17:35 INFO - 2016-01-23 07:17:35,360 DEBUG : BROWSER_OUTPUT: Values: 3163.8 3232.1 3261.6 3262.3 3276.8 5504.9 5531.1 5545.9 5559.1 5587.7 5517.2 5575.9 5595.0 5600.4 5601.7 4909.1 5023.8 5071.9 5091.4 5174.1 4982.3 5044.1 5045.4 5048.2 5051.2 4916.9 5014.6 5016.1 5052.8 5091.5 4998.7 5089.2 5099.6 5101.6 5122.1 4963.2 5068.3 5069.5 5077.3 5089.4 5156.4 5236.6 5289.6 5366.1 5392.1 5892.5 5920.3 5930.5 5939.8 5942.4 5906.6 5956.5 5973.1 5974.0 6014.7 5355.8 5440.3 5502.4 5556.8 5558.2 6065.1 6075.9 6113.7 6113.8 6125.4 5866.9 5870.5 5871.2 5872.9 5882.5 5675.2 5758.8 5815.5 5907.4 5973.4 5897.6 5903.6 5906.4 5908.7 5934.2 5862.3 5895.8 5916.4 5918.9 5920.5 4473.3 4492.5 4524.0 4553.0 4569.2 4079.1 4094.1 4096.1 4113.1 4113.2 5489.8 5708.6 5712.2 5714.2 5717.0 5915.9 5956.6 5983.6 6014.3 6057.1 5549.5 5572.7 5573.2 5654.8 5659.3 5002.2 5091.4 5177.2 5183.9 5187.4 6000.8 6051.7 6055.2 6084.4 6099.1 5889.8 5903.6 5909.7 5910.1 5982.7 5873.9 5946.9 6054.5 6055.1 6060.6 5828.4 5870.3 5872.1 5876.0 5900.1 5936.7 5966.7 6045.6 6046.6 6053.8 5575.5 5658.9 5711.3 5872.2 5883.5 5754.8 5760.1 5760.3 5764.2 5833.1 5676.5 5676.8 5678.1 5682.8 5685.7 5633.6 5668.7 5710.8 5739.7 5782.9 5689.2 5751.3 5752.4 5752.5 5756.4 07:17:35 INFO - 2016-01-23 07:17:35,361 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,361 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43856.63 Median:33599.66 stddev:68911.27 (205.1%) stddev-sans-first:69028.00 07:17:35 INFO - 2016-01-23 07:17:35,361 DEBUG : BROWSER_OUTPUT: Values: 589.5 629.9 633.8 635.0 637.5 31750.8 32466.8 32528.7 32570.7 32607.0 33621.5 42167.4 42181.4 42332.8 42388.4 9044.6 9176.4 9178.5 9179.3 9195.4 8238.2 8423.3 8981.4 9083.8 9117.5 8185.3 10966.2 11221.0 11226.6 11227.2 10759.1 10857.0 10874.3 10875.7 10884.6 8246.1 8415.0 8441.9 10608.5 10769.9 42575.4 43011.8 43223.4 43285.4 43285.6 3325.0 3963.1 4154.9 4253.6 4321.5 30558.8 30699.2 30760.0 30914.4 32060.0 4082.1 4083.0 4110.5 4125.5 4190.7 233423.0 234317.0 234644.0 234827.0 236050.0 57273.4 57620.4 57652.1 57730.7 57738.4 61028.1 61154.7 61254.7 61283.7 61501.0 17736.5 18114.2 18251.5 18272.3 18299.8 12912.9 12936.5 12936.9 12938.8 12939.7 19624.5 20033.4 20247.2 20255.3 20285.7 7974.5 8238.6 8270.8 8275.1 8303.0 976.6 1022.0 1028.7 1046.0 1133.8 26406.5 26432.5 26548.6 27423.9 27796.9 1029.5 1109.3 1109.6 1122.9 1154.7 14045.0 14193.9 14341.3 16775.5 17319.0 334336.0 340000.0 340856.0 341951.0 342456.0 49293.0 55202.2 55512.2 55554.4 55610.2 1343.7 1425.6 1439.3 1453.5 1454.6 27471.0 27581.3 27837.2 28073.3 28311.9 41181.0 41389.2 41414.6 41547.8 41720.4 186346.0 187535.0 187708.0 187994.0 226686.0 33118.3 33441.0 33528.3 33577.8 33881.7 45622.8 47125.0 47502.5 47717.5 47736.3 39633.4 40143.8 40534.0 41074.8 41159.4 38745.0 41715.3 41976.0 42510.4 43101.6 37824.4 38100.0 38187.6 38990.2 39858.8 29772.3 30847.8 31467.9 31495.2 31547.8 24299.9 24581.1 24587.5 24849.3 24992.4 07:17:35 INFO - 2016-01-23 07:17:35,361 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,361 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31834.26 Median:34732.65 stddev:102860.16 (296.1%) stddev-sans-first:103121.60 07:17:35 INFO - 2016-01-23 07:17:35,362 DEBUG : BROWSER_OUTPUT: Values: 384.4 385.3 387.0 387.0 392.1 14865.6 17165.2 17204.8 19669.2 19681.1 17213.0 17519.9 17664.2 19004.9 19383.9 5068.1 5186.7 5197.3 5197.5 5203.4 3911.5 4019.9 5131.1 5484.6 5682.9 5536.0 5622.1 5666.0 5676.5 5753.4 5516.7 5609.5 5612.7 5616.7 5622.4 5423.3 5424.1 5425.2 5427.0 5433.0 20356.2 22207.4 22398.6 22467.3 22609.9 2140.6 2167.5 2210.1 2219.5 2242.8 10016.9 10475.4 11796.2 14386.6 14529.3 1952.0 1967.1 1977.3 1977.7 1993.7 63758.0 65179.7 65679.7 66380.3 67092.7 11094.0 11283.0 11284.8 11288.9 11361.9 15007.8 15012.5 15023.7 15041.2 15041.2 8587.9 8632.0 8644.2 8645.1 8658.4 8082.9 8104.0 8397.6 8474.5 8497.0 4689.9 4741.7 4780.9 4849.2 4872.5 1784.5 1836.6 1899.9 1906.9 2008.1 471.3 975.7 983.9 1028.8 1132.9 10646.0 10751.1 10907.3 10930.2 11242.9 462.4 466.9 480.4 486.8 499.0 5963.2 6199.7 6204.3 6209.1 6211.8 614341.0 619992.1 630476.0 631895.0 649848.0 86121.6 86130.1 86413.6 86465.1 87121.0 528.5 533.1 533.2 533.4 533.5 10551.4 10654.1 10679.9 15383.8 15943.4 34568.8 34896.5 35240.6 36941.0 38969.4 46794.0 46901.8 47973.3 48081.0 48140.3 9891.6 10463.0 10471.9 10472.8 10473.8 12209.7 14981.3 18908.7 19026.0 19454.6 15738.4 15779.5 15901.2 16034.0 16206.1 15345.6 15352.8 15595.5 15920.1 16148.8 12447.8 16213.4 16415.5 16562.0 16591.2 9254.9 10289.2 10332.4 10362.1 10446.4 10474.7 10542.3 13615.7 15969.5 16365.1 07:17:35 INFO - 2016-01-23 07:17:35,362 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5446.18 Median:6285.91 stddev:2851.69 (45.4%) stddev-sans-first:2844.72 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: Values: 1558.9 1608.4 1644.5 1780.0 1881.1 6827.8 7623.5 7806.4 7814.8 7835.6 7615.4 7793.7 7795.3 7795.9 7800.8 1827.7 1855.6 2233.7 2248.8 2257.7 2328.6 2335.3 2335.6 2335.9 2340.9 2206.4 2268.7 2272.4 2273.4 2274.0 2220.5 2223.2 2247.4 2254.9 2258.4 2239.8 2262.0 2275.1 2275.1 2278.2 7784.7 7839.6 7840.4 7843.4 7846.2 4668.5 4711.6 4717.5 4761.6 4767.1 3077.8 3117.1 3120.4 3130.8 3255.4 1027.8 1035.8 1051.4 1092.1 1098.1 10522.9 10524.4 10567.7 10574.5 10584.9 3979.6 4059.2 4080.6 4097.8 4116.7 8532.4 8548.4 8559.1 8561.0 8561.9 4611.5 4641.7 4641.8 4649.8 4651.0 4310.4 4311.0 4315.7 4318.3 4320.0 3211.2 3278.3 3314.9 3348.9 3401.9 1068.1 1079.3 1079.8 1081.1 1083.7 1132.9 1134.4 1188.9 1349.4 1413.9 7386.6 7470.2 7487.9 7516.0 7558.7 658.9 663.7 664.1 668.2 811.1 5676.8 5776.6 5778.1 5835.5 5838.7 9295.5 9303.0 9357.4 9419.0 9673.1 9335.8 9457.0 9554.4 9572.7 9665.0 7216.5 7414.7 7415.2 7436.3 7493.1 7510.0 7588.7 7603.4 7605.9 7608.8 8452.3 8522.7 8559.4 8678.9 8694.4 8684.4 8687.8 8711.0 8800.1 8835.7 7041.0 7148.2 7158.4 7161.0 7162.2 6582.6 6872.7 7365.9 7477.7 7497.4 7032.5 7076.1 7135.3 7189.1 7200.8 6862.4 6902.2 7027.9 7135.4 7194.7 7018.2 7138.4 7154.4 7164.0 7169.1 6273.8 6298.0 6310.4 6312.1 6318.9 6226.3 6255.9 6261.8 6264.8 6273.0 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5353.13 Median:6096.41 stddev:1576.30 (25.9%) stddev-sans-first:1535.33 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: Values: 349.5 352.2 358.9 359.6 361.1 5853.4 5968.6 5994.9 6005.1 6045.5 5790.9 5886.2 5919.4 5925.6 5962.9 4663.6 4678.8 4687.6 4688.2 4697.2 4444.3 4555.7 4574.6 4662.8 4675.6 4607.0 4624.2 4628.7 4636.5 4656.5 4602.7 4617.6 4637.7 4638.8 4655.6 4114.1 4126.5 4129.0 4135.5 4141.0 5491.6 5619.2 5638.9 5644.7 5668.2 5399.6 5410.9 5411.9 5413.8 5419.9 6310.1 6312.2 6316.9 6317.1 6325.2 4353.8 4458.5 4462.8 4567.6 4582.2 6526.0 6560.4 6568.4 6586.9 6588.7 4677.3 4678.9 4681.0 4681.3 4686.9 4593.9 4692.7 4695.2 4739.2 4755.5 5406.9 5414.7 5420.5 5421.2 5423.8 6323.6 6343.7 6375.4 6388.6 6390.0 1662.5 1685.4 1686.6 1686.9 1689.2 1117.9 1125.8 1158.2 1160.6 1164.3 6176.4 6177.1 6182.9 6187.2 6189.1 6519.9 6531.3 6536.6 6543.1 6544.3 6057.1 6179.6 6181.7 6182.3 6189.2 3519.5 3533.6 3554.6 3555.2 3557.2 6721.7 6725.1 6726.3 6731.0 6735.2 6563.5 6702.0 6707.6 6715.5 6715.5 6714.4 6716.7 6719.8 6720.8 6722.9 6354.3 6525.3 6527.2 6531.7 6535.9 6333.1 6405.7 6523.7 6558.7 6572.0 6737.2 6742.9 6770.7 6790.5 6793.4 4652.8 4664.5 4675.3 4706.5 4736.0 6581.0 6582.3 6590.8 6592.8 6597.4 6411.7 6420.0 6431.5 6434.6 6437.9 6337.8 6407.8 6434.5 6440.9 6443.0 6344.3 6346.4 6348.7 6352.6 6354.6 6415.0 6468.9 6470.6 6474.2 6479.4 6135.7 6250.3 6260.4 6266.9 6281.1 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15239.63 Median:25282.29 stddev:17972.32 (71.1%) stddev-sans-first:17990.32 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: Values: 865.9 879.9 920.7 925.6 928.3 14082.8 14495.5 14496.3 14502.5 14506.6 13070.9 13161.9 13167.1 13170.0 13201.1 761.1 766.0 902.4 904.1 914.5 918.2 920.5 928.0 928.2 928.4 944.7 945.4 947.6 952.1 954.3 785.5 795.0 947.9 960.6 962.6 711.7 713.7 714.1 714.3 717.4 13944.8 14152.4 14163.7 14189.1 14275.4 13218.9 13431.3 13485.9 13852.2 13967.2 10829.8 10876.0 10956.2 11108.9 11159.0 3687.4 3789.9 3793.6 3816.4 3820.5 50966.5 53128.5 53513.0 53707.7 53797.9 10431.1 10494.9 10571.2 10878.8 10975.5 19595.8 19607.7 19613.5 19615.5 19634.4 7728.1 7941.7 8006.6 8069.9 8659.4 4543.6 4590.8 4675.6 4676.6 4680.6 3368.0 3377.7 3380.5 3387.6 3389.5 606.0 621.6 627.9 632.0 633.2 706.5 707.7 710.4 743.6 776.5 8379.2 8851.6 9060.8 9346.5 9736.3 646.1 660.2 699.4 736.4 740.7 4258.4 4432.4 4530.2 4561.4 4765.3 64252.7 64464.7 64508.4 64565.0 64730.0 59040.4 59614.4 59746.7 60291.4 61167.7 51494.0 51677.5 51915.7 52133.5 52244.2 8958.6 9012.6 9174.5 9299.3 9385.0 37719.2 37926.6 38461.4 38927.6 38959.0 45973.8 49897.5 50485.0 50583.5 50976.7 11619.4 11653.3 12055.2 12227.4 12458.9 13258.2 13534.9 13551.4 13993.2 14269.2 11924.0 12275.5 12327.8 12691.5 12972.4 12301.1 12552.4 12710.1 12978.6 13224.5 11829.7 11906.1 11934.2 12544.0 12588.2 10986.6 11026.1 11033.8 11275.4 11446.0 10137.9 10545.1 10615.8 10654.5 10733.2 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:35 INFO - 2016-01-23 07:17:35,363 DEBUG : BROWSER_OUTPUT: 07:17:36 INFO - 2016-01-23 07:17:36,041 INFO : Browser exited with error code: 0 07:17:36 INFO - 2016-01-23 07:17:36,063 INFO : Completed test dromaeo_css (00:18:31) 07:17:36 INFO - 2016-01-23 07:17:36,063 INFO : Starting test kraken 07:17:36 INFO - 2016-01-23 07:17:36,063 DEBUG : operating with platform_type : linux_ 07:17:36 INFO - 2016-01-23 07:17:36,063 INFO : Initialising browser for kraken test... 07:17:36 INFO - 2016-01-23 07:17:36,069 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4pIeNq/profile http://localhost:43620/getInfo.html 07:17:39 INFO - 2016-01-23 07:17:39,762 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:17:39 INFO - 2016-01-23 07:17:39,762 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:17:39 INFO - 2016-01-23 07:17:39,762 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:17:39 INFO - 2016-01-23 07:17:39,762 DEBUG : BROWSER_OUTPUT: __metrics 07:17:39 INFO - 2016-01-23 07:17:39,967 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:40 INFO - 2016-01-23 07:17:40,939 INFO : Browser initialized. 07:17:40 INFO - 2016-01-23 07:17:40,940 INFO : Running cycle 1/1 for kraken test... 07:17:40 INFO - 2016-01-23 07:17:40,940 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4pIeNq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:17:52 INFO - 2016-01-23 07:17:52,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 138211328 07:17:52 INFO - 2016-01-23 07:17:52,675 DEBUG : BROWSER_OUTPUT: 07:17:55 INFO - 2016-01-23 07:17:55,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43620/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:55 INFO - 2016-01-23 07:17:55,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 169541632 07:17:55 INFO - 2016-01-23 07:17:55,694 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2016-01-23 07:17:58,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43620/tests/kraken/driver.html?testName=audio-dft) 07:17:58 INFO - 2016-01-23 07:17:58,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 166199296 07:17:58 INFO - 2016-01-23 07:17:58,816 DEBUG : BROWSER_OUTPUT: 07:18:01 INFO - 2016-01-23 07:18:01,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43620/tests/kraken/driver.html?testName=audio-fft) 07:18:02 INFO - 2016-01-23 07:18:02,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 164257792 07:18:02 INFO - 2016-01-23 07:18:02,176 DEBUG : BROWSER_OUTPUT: 07:18:04 INFO - 2016-01-23 07:18:04,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43620/tests/kraken/driver.html?testName=audio-oscillator) 07:18:04 INFO - 2016-01-23 07:18:04,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 164839424 07:18:04 INFO - 2016-01-23 07:18:04,706 DEBUG : BROWSER_OUTPUT: 07:18:06 INFO - 2016-01-23 07:18:06,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:07 INFO - 2016-01-23 07:18:07,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 163086336 07:18:07 INFO - 2016-01-23 07:18:07,462 DEBUG : BROWSER_OUTPUT: 07:18:10 INFO - 2016-01-23 07:18:10,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43620/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:10 INFO - 2016-01-23 07:18:10,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 163704832 07:18:10 INFO - 2016-01-23 07:18:10,892 DEBUG : BROWSER_OUTPUT: 07:18:14 INFO - 2016-01-23 07:18:14,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43620/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:14 INFO - 2016-01-23 07:18:14,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 163352576 07:18:14 INFO - 2016-01-23 07:18:14,813 DEBUG : BROWSER_OUTPUT: 07:18:17 INFO - 2016-01-23 07:18:17,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43620/tests/kraken/driver.html?testName=json-parse-financial) 07:18:18 INFO - 2016-01-23 07:18:18,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 162754560 07:18:18 INFO - 2016-01-23 07:18:18,080 DEBUG : BROWSER_OUTPUT: 07:18:19 INFO - 2016-01-23 07:18:19,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:20 INFO - 2016-01-23 07:18:20,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 168308736 07:18:20 INFO - 2016-01-23 07:18:20,219 DEBUG : BROWSER_OUTPUT: 07:18:22 INFO - 2016-01-23 07:18:22,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:22 INFO - 2016-01-23 07:18:22,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 166236160 07:18:22 INFO - 2016-01-23 07:18:22,603 DEBUG : BROWSER_OUTPUT: 07:18:24 INFO - 2016-01-23 07:18:24,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:25 INFO - 2016-01-23 07:18:25,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 175677440 07:18:25 INFO - 2016-01-23 07:18:25,146 DEBUG : BROWSER_OUTPUT: 07:18:27 INFO - 2016-01-23 07:18:27,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:28 INFO - 2016-01-23 07:18:28,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 181571584 07:18:28 INFO - 2016-01-23 07:18:28,075 DEBUG : BROWSER_OUTPUT: 07:18:30 INFO - 2016-01-23 07:18:30,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:31 INFO - 2016-01-23 07:18:31,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 179982336 07:18:31 INFO - 2016-01-23 07:18:31,136 DEBUG : BROWSER_OUTPUT: 07:18:32 INFO - 2016-01-23 07:18:32,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43620/tests/kraken/driver.html?testName=ai-astar) 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 237985792 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;104;108;111;109;99;109;108;110 07:18:33 INFO - 2016-01-23 07:18:33,034 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;125;143;167;123;144;150;124;165;122 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;161;161;162;159;162;161 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;71;71;160;71;71;71;73;145;72 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;95;139;94;94;95;137;92;94;130 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;145;146;146;145 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;95;95;95;95;95;95;95;95 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;58;59;68;58;58;58;57;56;58 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;65;66;65;65;65;65;65;66 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;79;81;81;80;80;80;81;81;80 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;119;119;115;111;119;111;120;118;120 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;147;152;146;148;134;143;142;146;132 07:18:33 INFO - 2016-01-23 07:18:33,035 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;67;65;68;66;64;64;64;64 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,893 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562313029__endTimestamp 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.50 (3.2%) stddev-sans-first:3.71 07:18:33 INFO - 2016-01-23 07:18:33,036 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 104.0 108.0 111.0 109.0 99.0 109.0 108.0 110.0 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:146.00 stddev:17.08 (11.7%) stddev-sans-first:17.93 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: Values: 148.0 125.0 143.0 167.0 123.0 144.0 150.0 124.0 165.0 122.0 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 161.0 161.0 162.0 159.0 162.0 161.0 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,037 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.20 Median:71.00 stddev:34.12 (48.1%) stddev-sans-first:35.95 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: Values: 77.0 71.0 71.0 160.0 71.0 71.0 71.0 73.0 145.0 72.0 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.00 stddev:20.18 (21.5%) stddev-sans-first:20.82 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 139.0 94.0 94.0 95.0 137.0 92.0 94.0 130.0 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,038 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.33 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.44 (5.9%) stddev-sans-first:3.52 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: Values: 56.0 58.0 59.0 68.0 58.0 58.0 58.0 57.0 56.0 58.0 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 07:18:33 INFO - 2016-01-23 07:18:33,039 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,040 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:0.79 (1.0%) stddev-sans-first:0.71 07:18:33 INFO - 2016-01-23 07:18:33,040 DEBUG : BROWSER_OUTPUT: Values: 79.0 79.0 81.0 81.0 80.0 80.0 80.0 81.0 81.0 80.0 07:18:33 INFO - 2016-01-23 07:18:33,040 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,040 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:119.00 stddev:3.92 (3.3%) stddev-sans-first:3.66 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: Values: 111.0 119.0 119.0 115.0 111.0 119.0 111.0 120.0 118.0 120.0 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:146.00 stddev:6.59 (4.5%) stddev-sans-first:6.54 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: Values: 136.0 147.0 152.0 146.0 148.0 134.0 143.0 142.0 146.0 132.0 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 67.0 65.0 68.0 66.0 64.0 64.0 64.0 64.0 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:18:33 INFO - 2016-01-23 07:18:33,041 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2016-01-23 07:18:33,862 INFO : Browser exited with error code: 0 07:18:33 INFO - 2016-01-23 07:18:33,913 INFO : Completed test kraken (00:00:57) 07:18:33 INFO - 2016-01-23 07:18:33,913 INFO : Starting test v8_7 07:18:33 INFO - 2016-01-23 07:18:33,913 DEBUG : operating with platform_type : linux_ 07:18:33 INFO - 2016-01-23 07:18:33,913 INFO : Initialising browser for v8_7 test... 07:18:33 INFO - 2016-01-23 07:18:33,919 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL2BsG7/profile http://localhost:43620/getInfo.html 07:18:37 INFO - 2016-01-23 07:18:37,981 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:18:37 INFO - 2016-01-23 07:18:37,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:18:37 INFO - 2016-01-23 07:18:37,982 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:18:37 INFO - 2016-01-23 07:18:37,982 DEBUG : BROWSER_OUTPUT: __metrics 07:18:38 INFO - 2016-01-23 07:18:38,124 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:38 INFO - 2016-01-23 07:18:38,890 INFO : Browser initialized. 07:18:38 INFO - 2016-01-23 07:18:38,891 INFO : Running cycle 1/1 for v8_7 test... 07:18:38 INFO - 2016-01-23 07:18:38,891 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL2BsG7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:18:50 INFO - 2016-01-23 07:18:50,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 137228288 07:18:50 INFO - 2016-01-23 07:18:50,663 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43620/tests/v8_7/run.html (next: http://localhost:43620/tests/v8_7/run.html) 07:19:12 INFO - 2016-01-23 07:19:12,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 426192896 07:19:12 INFO - 2016-01-23 07:19:12,285 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0982334489021 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.9804532087874 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |4;RayTrace;954.1984732824427 07:19:12 INFO - 2016-01-23 07:19:12,286 DEBUG : BROWSER_OUTPUT: |5;Earley;564.652738565782 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: |6;Boyer;11043.956043956045 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: |8;Splay;527.9535864978903 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: __startTimestamp1453562352278__endTimestamp 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.10 Median:165.10 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: Values: 165.1 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.98 Median:172.98 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,287 DEBUG : BROWSER_OUTPUT: Values: 173.0 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: Values: 278.9 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: Values: 5181.3 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:954.20 Median:954.20 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: Values: 954.2 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:564.65 Median:564.65 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: Values: 564.7 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11043.96 Median:11043.96 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: Values: 11044.0 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,288 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: Values: 24047.6 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.95 Median:527.95 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: Values: 528.0 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:19:12 INFO - 2016-01-23 07:19:12,289 DEBUG : BROWSER_OUTPUT: 07:19:13 INFO - 2016-01-23 07:19:13,141 INFO : Browser exited with error code: 0 07:19:13 INFO - 2016-01-23 07:19:13,153 INFO : Completed test v8_7 (00:00:39) 07:19:13 INFO - 2016-01-23 07:19:13,326 INFO : Completed test suite (00:20:08) 07:19:13 INFO - 2016-01-23 07:19:13,326 DEBUG : Working with test: dromaeo_css 07:19:13 INFO - 2016-01-23 07:19:13,326 DEBUG : Generating results file: dromaeo_css 07:19:13 INFO - 2016-01-23 07:19:13,327 DEBUG : Working with test: kraken 07:19:13 INFO - 2016-01-23 07:19:13,327 DEBUG : Generating results file: kraken 07:19:13 INFO - 2016-01-23 07:19:13,327 INFO : javascript benchmark 07:19:13 INFO - 2016-01-23 07:19:13,328 DEBUG : Working with test: v8_7 07:19:13 INFO - 2016-01-23 07:19:13,328 DEBUG : Generating results file: v8_7 07:19:13 INFO - 2016-01-23 07:19:13,328 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:13 INFO - 2016-01-23 07:19:13,390 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 07:19:13 INFO - 2016-01-23 07:19:13,390 DEBUG : process_Request line: dromaeo_css 7155.75 graph.html#tests=[[72,52,35]] 07:19:13 INFO - 2016-01-23 07:19:13,390 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:13 INFO - 2016-01-23 07:19:13,506 DEBUG : process_Request line: kraken 1482.10 graph.html#tests=[[232,52,35]] 07:19:13 INFO - 2016-01-23 07:19:13,506 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:13 INFO - 2016-01-23 07:19:13,635 DEBUG : process_Request line: v8_7 22992.15 graph.html#tests=[[230,52,35]] 07:19:13 INFO - 2016-01-23 07:19:13,636 INFO : javascript benchmark 07:19:13 INFO - 2016-01-23 07:19:13,640 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.8259895705737, 3232.0627018164732, 3261.608606967164, 3262.347530493902, 3276.83615819209, 5504.862378440541, 5531.142672885704, 5545.916811247835, 5559.11054231323, 5587.692676902769, 5517.172424136382, 5575.944240557593, 5595.0, 5600.355959064709, 5601.747921343539, 4909.091818013679, 5023.8492845214705, 5071.923921141186, 5091.389033316007, 5174.094533456649, 4982.302477653131, 5044.092063428581, 5045.394552653686, 5048.1670524363435, 5051.217061355495, 4916.926246106294, 5014.5737612303, 5016.147254966646, 5052.797888084472, 5091.490850914916, 4998.7250701211415, 5089.185730283137, 5099.566536844335, 5101.566366858821, 5122.129238029544, 4963.1810751226, 5068.341115654978, 5069.518395752398, 5077.339945807058, 5089.389273287229, 5156.432792392871, 5236.581073514109, 5289.629725919149, 5366.114591092465, 5392.083345831218, 5892.528597712173, 5920.289565252154, 5930.525557955353, 5939.821805345803, 5942.435468630516, 5906.5570082244, 5956.463918247336, 5973.1040343948325, 5973.970130149321, 6014.669193194372, 5355.839324820262, 5440.347158341025, 5502.422245664227, 5556.833295001116, 5558.249636299129, 6065.1486306195, 6075.878482430415, 6113.663748493786, 6113.84715382119, 6125.356837531995, 5866.911996320058, 5870.501007414332, 5871.178035075093, 5872.941270587325, 5882.499987501024, 5675.233843431167, 5758.798442054592, 5815.505682016991, 5907.409259074144, 5973.372795856372, 5897.616654917417, 5903.616264942765, 5906.379830117861, 5908.675022873697, 5934.228550288435, 5862.325832529228, 5895.793647222326, 5916.437938395846, 5918.881622367615, 5920.526357891358, 4473.284274516127, 4492.483364413069, 4524.0, 4553.043860789271, 4569.246074397754, 4079.082206503513, 4094.1197642507004, 4096.09885825118, 4113.074558224375, 4113.218488487178, 5489.752961116759, 5708.628939119027, 5712.200291959129, 5714.200011998323, 5717.028105222123, 5915.940840591625, 5956.55325850563, 5983.640981541122, 6014.278286605635, 6057.121717350959, 5549.472800083986, 5572.693501857437, 5573.164025396142, 5654.830355089354, 5659.3208814941645, 5002.224655178453, 5091.363579552556, 5177.249298851645, 5183.922241166386, 5187.377514698261, 6000.789972350947, 6051.667158306335, 6055.182550355734, 6084.361142080018, 6099.085137229363, 5889.823305300848, 5903.586748927534, 5909.734061967308, 5910.143029260647, 5982.7008649568215, 5873.853153671193, 5946.881062378641, 6054.515638748801, 6055.091736239599, 6060.606060606046, 5828.417158284137, 5870.324912635102, 5872.0898260769645, 5875.970620146872, 5900.1149827526215, 5936.673482958306, 5966.701664916824, 6045.6070355426755, 6046.606970546901, 6053.757849685963, 5575.526080283222, 5658.85852853682, 5711.314642242791, 5872.236609240771, 5883.470487656132, 5754.798582049608, 5760.0783874579865, 5760.279965004374, 5764.193012978102, 5833.066709326487, 5676.545876329967, 5676.801311954227, 5678.14827775837, 5682.77268909239, 5685.658860468385, 5633.577481688808, 5668.688222147656, 5710.771569137188, 5739.713014349182, 5782.942170578409, 5689.203511508309, 5751.281089863767, 5752.367239603724, 5752.453516915886, 5756.42435756421], "unit": "ms", "name": "dojo.html", "value": 5455.906922055824}, {"lowerIsBetter": false, "replicates": [589.5224867857033, 629.8551333193366, 633.8098570428872, 634.9523785716069, 637.5377851057987, 31750.841245793767, 32466.837665811698, 32528.67471325286, 32570.67429325706, 32606.99999999997, 33621.49567756485, 42167.36748948768, 42181.367279490754, 42332.78833605828, 42388.364174537404, 9044.592993315317, 9176.403533770317, 9178.495182764946, 9179.31155163362, 9195.356325057248, 8238.176182381743, 8423.284020858235, 8981.371304008722, 9083.818323633523, 9117.45295282282, 8185.3451723861945, 10966.232363734542, 11221.046211072027, 11226.550937962513, 11227.214095013353, 10759.139268858511, 10857.0, 10874.293170943942, 10875.728106797314, 10884.564617415374, 8246.134155913604, 8415.0, 8441.902552668114, 10608.469576521144, 10769.946150269277, 42575.36136957948, 43011.784941075406, 43223.351649724966, 43285.35071973923, 43285.56714432847, 3325.0, 3963.1479231964977, 4154.875353739392, 4253.574642535753, 4321.503027151855, 30558.84720576405, 30699.232519186975, 30760.0, 30914.381712365626, 32060.038198854072, 4082.0611259410207, 4082.9591704082877, 4110.486189226347, 4125.463689720317, 4190.727602705814, 233423.0, 234317.0, 234644.0, 234827.0, 236050.0, 57273.427265727645, 57620.423795761504, 57652.135217971765, 57730.711346443, 57738.42261577331, 61028.08457873135, 61154.69422652947, 61254.69372653197, 61283.69358153181, 61501.0, 17736.467905962843, 18114.184861681257, 18251.45245642633, 18272.269109235483, 18299.817001830077, 12912.870871291354, 12936.482540698455, 12936.870631293756, 12938.805917911239, 12939.741205175844, 19624.509387265432, 20033.398998030083, 20247.19011239534, 20255.29106481266, 20285.695714564292, 7974.4848478788845, 8238.588070596446, 8270.751877443687, 8275.131111233233, 8302.958485207535, 976.5898322704481, 1021.9591216351412, 1028.7325295423243, 1045.9592705258165, 1133.7619099989095, 26406.47187056248, 26432.47135057288, 26548.60177097345, 27423.86288068587, 27796.86101569479, 1029.4852573713144, 1109.2678831970861, 1109.589451902785, 1122.9157813163881, 1154.6651471073462, 14045.0, 14193.858061419254, 14341.282935853165, 16775.496735097724, 17319.04745239024, 334336.0, 340000.0, 340856.0, 341951.0, 342456.0, 49293.0, 55202.17196742052, 55512.16731749027, 55554.44445555493, 55610.16584751232, 1343.7245364700213, 1425.5723283015054, 1439.2659743530874, 1453.4622189789634, 1454.5854431486975, 27471.0, 27581.31046723848, 27837.16488505348, 28073.298167545974, 28311.858440707663, 41181.0, 41389.1722165561, 41414.58585414107, 41547.7922610385, 41720.37419438772, 186346.0, 187535.0, 187708.0, 187994.0, 226686.0, 33118.337633247684, 33441.0, 33528.329433410705, 33577.83211083929, 33881.66118338884, 45622.771886140355, 47125.0, 47502.52497474981, 47717.52282477131, 47736.28395574139, 39633.36443515303, 40143.799281004576, 40534.0, 41074.794626026676, 41159.38260926028, 38745.0, 41715.33138674419, 41976.0, 42510.36234456424, 43101.56898430976, 37824.43263350997, 38100.0, 38187.61812381952, 38990.220195595364, 39858.800705996284, 29772.255693607833, 30847.84576077105, 31467.898623548066, 31495.21261968469, 31547.842260789468, 24299.878500607385, 24581.13966011181, 24587.50824983526, 24849.254522364357, 24992.37519062038], "unit": "ms", "name": "ext.html", "value": 19007.029868173024}, {"lowerIsBetter": false, "replicates": [384.42144572418516, 385.335296613342, 386.9864554740584, 386.9922601547969, 392.1177350960339, 14865.628359290997, 17165.227564759585, 17204.82795172048, 19669.21323147074, 19681.114349854255, 17213.0, 17519.91240043801, 17664.205110770014, 19004.904975475103, 19383.90308048461, 5068.06240845443, 5186.740662966856, 5197.324347834776, 5197.48025197481, 5203.375594928614, 3911.4915061042025, 4019.859304924328, 5131.1277082895995, 5484.588655850807, 5682.914756278659, 5535.972320138394, 5622.128570071645, 5665.971670141644, 5676.545876329905, 5753.424657534255, 5516.696581688006, 5609.49514543691, 5612.69130197841, 5616.691081990489, 5622.381538030813, 5423.322084739408, 5424.1321388578035, 5425.159100339453, 5427.0, 5433.0, 20356.18575256988, 22207.44481387962, 22398.552028959493, 22467.32598022062, 22609.886950565306, 2140.6146893559153, 2167.5448155887284, 2210.1490925993608, 2219.5006123622215, 2242.7532971373134, 10016.89983100167, 10475.423851688154, 11796.203796203796, 14386.640333991629, 14529.256489221361, 1951.9512012199666, 1967.1049672399024, 1977.2881762565464, 1977.7033444983224, 1993.7408136942104, 63758.0, 65179.674101629185, 65679.67160164217, 66380.3361966379, 67092.66453667701, 11094.0, 11283.0, 11284.830727539094, 11288.927551882558, 11361.943190283995, 15007.774883376758, 15012.47456339023, 15023.699526009637, 15041.172735499435, 15041.172735499435, 8587.914120858712, 8632.0, 8644.178803013703, 8645.13548645143, 8658.437201581877, 8082.878756818653, 8104.0, 8397.6221070052, 8474.491530508067, 8496.980362356557, 4689.859304220879, 4741.739204343794, 4780.856574302777, 4849.175640141185, 4872.4640289568115, 1784.4614439234836, 1836.6143109946793, 1899.9145038473303, 1906.9332573359866, 2008.0682203982058, 471.25776901380465, 975.7365511311906, 983.8868530119128, 1028.7582418131733, 1132.8897680273378, 10645.988631080036, 10751.08615767653, 10907.29102608328, 10930.180236482296, 11242.94378528102, 462.43582828948627, 466.88327918020497, 480.4474853918022, 486.7931129270046, 499.0268975497794, 5963.224780778558, 6199.659018754011, 6204.348543402968, 6209.06863970399, 6211.782587609502, 614341.0, 619992.1003554851, 630476.0, 631895.0, 649848.0, 86121.56939215264, 86130.13869861221, 86413.56793215993, 86465.13534864696, 87121.0, 528.5084871069942, 533.1416419564498, 533.1868899927641, 533.4025891002102, 533.5278278723358, 10551.366917984946, 10654.094401975919, 10679.89320106789, 15383.846161538242, 15943.362265509713, 34568.82715586406, 34896.47655285223, 35240.647593524765, 36941.0, 38969.41545876757, 46794.0, 46901.76549117233, 47973.280400793315, 48081.0, 48140.27789583229, 9891.604335826487, 10463.0, 10471.94764026175, 10472.790544189225, 10473.795513516043, 12209.69475763113, 14981.325840336993, 18908.716369254198, 19025.95357255364, 19454.610907781484, 15738.449154279546, 15779.526614201592, 15901.204939753197, 16034.0, 16206.108664023592, 15345.6163595911, 15352.846471535142, 15595.532134035997, 15920.124393158025, 16148.838511614733, 12447.813282800946, 16213.432529861399, 16415.507534773977, 16562.0, 16591.17044147812, 9254.907450925404, 10289.176865850864, 10332.431716255678, 10362.067413932782, 10446.373217606968, 10474.738131546772, 10542.314749541561, 13615.65960850947, 15969.520914372588, 16365.099919504542], "unit": "ms", "name": "jquery.html", "value": 8739.590212240133}, {"lowerIsBetter": false, "replicates": [1558.8674962628177, 1608.437047033538, 1644.4902080355084, 1780.0216516086543, 1881.0594702648675, 6827.829304267396, 7623.504472209303, 7806.375489960804, 7814.843703125934, 7835.608219589027, 7615.352695020916, 7793.688252469909, 7795.259450352221, 7795.883061754078, 7800.843983120334, 1827.734978428127, 1855.6195979824172, 2233.7207849018873, 2248.786365295294, 2257.7403598586125, 2328.5924963131383, 2335.2760644200266, 2335.5795956727784, 2335.92992210234, 2340.871252081135, 2206.3932418584936, 2268.6823844661762, 2272.4318920269934, 2273.374821923976, 2274.044901141516, 2220.5003874128274, 2223.1996481266733, 2247.4493749031512, 2254.9210777622707, 2258.378945789921, 2239.8320125990454, 2262.0, 2275.055851821492, 2275.0672224388086, 2278.1798552521077, 7784.688612455495, 7839.568823714693, 7840.41196910234, 7843.37253019757, 7846.215378462165, 4668.50980647034, 4711.599514041311, 4717.457492388385, 4761.642876784255, 4767.094252092092, 3077.81533108012, 3117.0960421477744, 3120.3915236528887, 3130.827804470753, 3255.4140254754134, 1027.7790275090817, 1035.8083754505365, 1051.369178492898, 1092.071739021833, 1098.1105304703217, 10522.947385263102, 10524.421156836372, 10567.682969510926, 10574.52414641343, 10584.894151058545, 3979.6020397959974, 4059.2490389278078, 4080.6327430531396, 4097.836086556564, 4116.650084742771, 8532.360072994426, 8548.358873084419, 8559.101294364127, 8560.957195214109, 8561.914380856111, 4611.469680986729, 4641.721496710208, 4641.814327426932, 4649.814007439664, 4651.023285110097, 4310.43964284641, 4310.978445107817, 4315.719478233905, 4318.287482565342, 4320.0, 3211.197200699825, 3278.3115545735664, 3314.93370132596, 3348.8995330140133, 3401.9489707654407, 1068.1134658233648, 1079.3092420850662, 1079.8110330692098, 1081.086481922774, 1083.7453198498347, 1132.8753837077916, 1134.3760931487648, 1188.9359023673765, 1349.39951721483, 1413.8798202152932, 7386.630668466555, 7470.215627359049, 7487.8502429951095, 7516.0, 7558.697652093854, 658.8517583543664, 663.7079684938611, 664.1299897134769, 668.1748041169152, 811.1280373598405, 5676.77292908279, 5776.56675749312, 5778.133280008033, 5835.533157347402, 5838.678872662044, 9295.53522323881, 9303.0, 9357.438553686801, 9419.0, 9673.129418352382, 9335.766605834908, 9457.0, 9554.378965367228, 9572.664956726621, 9664.985176556502, 7216.458765592602, 7414.703411863465, 7415.1843297237265, 7436.330730234305, 7493.063367079115, 7510.0, 7588.696452142073, 7603.429742769204, 7605.88591171144, 7608.80977975555, 8452.281556067803, 8522.74431767048, 8559.358048146538, 8678.869816952625, 8694.391392602458, 8684.43551169172, 8687.782805429915, 8710.956445217733, 8800.075992020746, 8835.69075082369, 7040.964795175992, 7148.17795953472, 7158.3915367192285, 7160.964195178991, 7162.176349719849, 6582.572132811352, 6872.656367181521, 7365.852682946418, 7477.738279160203, 7497.400207983239, 7032.472564557576, 7076.0801095857205, 7135.286471352823, 7189.1013623297085, 7200.783976480714, 6862.4166945808165, 6902.206246281742, 7027.8945815811785, 7135.393491553276, 7194.676239569337, 7018.227994920657, 7138.39323657495, 7154.35610795031, 7163.964180179066, 7169.068021157216, 6273.843153921006, 6297.96851015742, 6310.368963103653, 6312.147860038836, 6318.9052164216655, 6226.25284965807, 6255.906161407492, 6261.812145635456, 6264.843378915563, 6273.0], "unit": "ms", "name": "mootools.html", "value": 4427.408870965525}, {"lowerIsBetter": false, "replicates": [349.50195970741703, 352.2479506254147, 358.89771415146686, 359.55774397491086, 361.14408851023063, 5853.414658534144, 5968.641881487114, 5994.910076348853, 6005.129256257846, 6045.546584006195, 5790.884182316351, 5886.205362276091, 5919.37846526115, 5925.585209035369, 5962.850928726784, 4663.626909847204, 4678.836240731575, 4687.554682305175, 4688.179568575502, 4697.201475749131, 4444.266695995173, 4555.74943378114, 4574.565416285448, 4662.790174442158, 4675.625949924015, 4606.953930460686, 4624.167649823031, 4628.722276663411, 4636.53634636537, 4656.5343465653505, 4602.746848923308, 4617.568553748332, 4637.721736695809, 4638.83764068256, 4655.627549796008, 4114.136031433402, 4126.525449573277, 4129.0, 4135.503739551243, 4141.006158521933, 5491.560675145979, 5619.241402410704, 5638.915416268759, 5644.745986430579, 5668.178114173422, 5399.5680345572655, 5410.91883621746, 5411.918821217685, 5413.756380962866, 5419.945800541984, 6310.116583678288, 6312.179416675803, 6316.873662526724, 6317.1156038154695, 6325.209348831396, 4353.847615333448, 4458.5318541553315, 4462.843800466968, 4567.611753000966, 4582.175208462475, 6525.967370163166, 6560.376764207393, 6568.408843204087, 6586.868262634768, 6588.736450541973, 4677.2750223715375, 4678.929816052762, 4681.040386720714, 4681.29780532916, 4686.882827929329, 4593.885152871205, 4692.741899195577, 4695.154872122982, 4739.241721324641, 4755.476897541268, 5406.864828379322, 5414.675119492843, 5420.53925416344, 5421.2139239810795, 5423.755930983037, 6323.620582765049, 6343.651099189589, 6375.394337537927, 6388.648624325614, 6390.041493775878, 1662.4846297647769, 1685.3932584269899, 1686.5783554111472, 1686.898786072815, 1689.2145152504145, 1117.871444783844, 1125.8254970479588, 1158.154547180563, 1160.640201537526, 1164.318873459036, 6176.3514830943, 6177.073438984098, 6182.907256391158, 6187.195664563578, 6189.133521307021, 6519.8696026079215, 6531.314212007671, 6536.607803531803, 6543.1166792483355, 6544.280129185786, 6057.091436284504, 6179.62922224668, 6181.660008699565, 6182.28903676074, 6189.195404597373, 3519.4720791881423, 3533.575970883459, 3554.608993010767, 3555.1823080691584, 3557.2351944332095, 6721.66391680414, 6725.083351244872, 6726.327367263235, 6731.024001519752, 6735.158105236846, 6563.474922006228, 6702.0, 6707.618795327686, 6715.46276297895, 6715.5299129060495, 6714.362135597111, 6716.664166791738, 6719.832004199934, 6720.798376048726, 6722.899156512656, 6354.301026887131, 6525.282218956006, 6527.2167339919515, 6531.706073226811, 6535.869282614416, 6333.145025421509, 6405.743770249138, 6523.6738163092605, 6558.737650494118, 6572.0, 6737.191537015589, 6742.898856517254, 6770.661466926733, 6790.490713196431, 6793.354631310018, 4652.837150699709, 4664.463586687574, 4675.251959686434, 4706.529347065266, 4736.0, 6581.0, 6582.275949645631, 6590.7693230736695, 6592.80221593353, 6597.406233439014, 6411.6794160290865, 6419.967900160469, 6431.549791514549, 6434.581752186093, 6437.903431448625, 6337.780638134571, 6407.775727849503, 6434.549581529248, 6440.903386449113, 6443.0, 6344.27040890285, 6346.397092276226, 6348.746050157942, 6352.618842869442, 6354.555181137276, 6415.037744338387, 6468.935310646833, 6470.579412338183, 6474.223093228654, 6479.352064793671, 6135.7238924249405, 6250.312465628686, 6260.436560709376, 6266.905996410149, 6281.057841323838], "unit": "ms", "name": "prototype.html", "value": 4850.309003593361}, {"lowerIsBetter": false, "replicates": [865.8831057807196, 879.9032106468287, 920.6869664314132, 925.6158694141932, 928.3084102343755, 14082.788758168623, 14495.49265775698, 14496.347664355102, 14502.492412765541, 14506.564803055926, 13070.93464532676, 13161.934190329059, 13167.078304518687, 13170.01224908131, 13201.075924685276, 761.075293518375, 766.030970821908, 902.3908861518481, 904.1004200820194, 914.4970266353512, 918.2149262380668, 920.4661296448078, 928.0441145620022, 928.215657769184, 928.4058202750246, 944.6599224279254, 945.3524335829944, 947.606743201574, 952.057463111518, 954.298590535959, 785.5208322923013, 794.9523028618272, 947.9052094790535, 960.6061514778977, 962.5572236771023, 711.6655172069119, 713.7359177104453, 714.1002337055296, 714.2821464428268, 717.4224749076991, 13944.790828137586, 14152.36314365856, 14163.716725665532, 14189.148651080865, 14275.357608907623, 13218.86781132186, 13431.328433578283, 13485.865141348559, 13852.168869867739, 13967.161970281815, 10829.83755243672, 10876.0, 10956.178286628534, 11108.888911110866, 11159.0, 3687.3547129252274, 3789.905252368685, 3793.620637936212, 3816.446615240802, 3820.522434695663, 50966.49033509655, 53128.46871531274, 53513.0, 53707.73146134283, 53797.92404151934, 10431.113355364727, 10494.947525262478, 10571.20715946307, 10878.836817447745, 10975.50610222542, 19595.804041959396, 19607.705884411746, 19613.50966225856, 19615.509612259808, 19634.410967670992, 7728.149903510609, 7941.682332706627, 8006.559639219782, 8069.878951815727, 8659.350548708871, 4543.636509079266, 4590.8163673453355, 4675.602573781267, 4676.649251306166, 4680.555347242007, 3367.966320336814, 3377.712894403954, 3380.543626610376, 3387.6104248011793, 3389.5254664347012, 605.9727312270959, 621.586644881149, 627.9277883043417, 631.9936800632026, 633.240111865763, 706.4524993130365, 707.7416742888809, 710.4281053751677, 743.6170372258291, 776.4952780692595, 8379.162083791694, 8851.60167792451, 9060.773480663036, 9346.485943273185, 9736.269779766404, 646.0567571345794, 660.2108286543521, 699.40899939551, 736.4329466310911, 740.6629983357559, 4258.446401967724, 4432.401625780479, 4530.22986092365, 4561.429821272341, 4765.332853400527, 64252.678736606016, 64464.67767661226, 64508.35491645117, 64565.0, 64730.0, 59040.40959590435, 59614.403855961755, 59746.70126649426, 60291.39708602858, 61167.69416152891, 51494.0, 51677.48322516727, 51915.740421297654, 52133.478665213624, 52244.21633675498, 8958.641654334015, 9012.594433250651, 9174.495402752913, 9299.302552308469, 9385.0, 37719.245615087, 37926.62073379231, 38461.423078653286, 38927.6107238924, 38959.026024349616, 45973.77013115047, 49897.50102498929, 50485.0, 50583.49416505788, 50976.74511627418, 11619.419029048682, 11653.30080195191, 12055.15613907018, 12227.388630568614, 12458.937705311415, 13258.204507729568, 13534.932325338705, 13551.390187441786, 13993.230372329212, 14269.215193164475, 11924.0, 12275.508979641072, 12327.75344493123, 12691.492340306284, 12972.35138243103, 12301.138920275853, 12552.435140418886, 12710.110292279453, 12978.620816494808, 13224.537141200397, 11829.704257393634, 11906.107041971714, 11934.22427542207, 12544.0, 12588.244705317711, 10986.615468458565, 11026.117910567296, 11033.752534686651, 11275.436228188722, 11446.0, 10137.866590712512, 10545.10366618846, 10615.840762388416, 10654.520546575268, 10733.248672592843], "unit": "ms", "name": "yui.html", "value": 6897.619201074489}], "name": "dromaeo_css", "value": 7155.744930254321}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 104.0, 108.0, 111.0, 109.0, 99.0, 109.0, 108.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 143.0, 167.0, 123.0, 144.0, 150.0, 124.0, 165.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 159.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 71.0, 160.0, 71.0, 71.0, 71.0, 73.0, 145.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 139.0, 94.0, 94.0, 95.0, 137.0, 92.0, 94.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 59.0, 68.0, 58.0, 58.0, 58.0, 57.0, 56.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 81.0, 81.0, 80.0, 80.0, 80.0, 81.0, 81.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [111.0, 119.0, 119.0, 115.0, 111.0, 119.0, 111.0, 120.0, 118.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [136.0, 147.0, 152.0, 146.0, 148.0, 134.0, 143.0, 142.0, 146.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 65.0, 68.0, 66.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1482.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0982334489021], "unit": "score", "name": "Richards", "value": 213.824214}, {"lowerIsBetter": false, "replicates": [172.9804532087874], "unit": "score", "name": "DeltaBlue", "value": 382.22815800000006}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [954.1984732824427], "unit": "score", "name": "RayTrace", "value": 775.5084720000002}, {"lowerIsBetter": false, "replicates": [564.652738565782], "unit": "score", "name": "Earley", "value": 1180.3059730000004}, {"lowerIsBetter": false, "replicates": [11043.956043956045], "unit": "score", "name": "Boyer", "value": 60.346400995024844}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [527.9535864978903], "unit": "score", "name": "Splay", "value": 154.3525834165834}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22992.14907562575}]} 07:19:13 INFO - RETURN: dromaeo_css: 7155.75 07:19:13 INFO - RETURN: kraken: 1482.10 07:19:13 INFO - RETURN: v8_7: 22992.15 07:19:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22992.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1482.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7155.75"}}} 07:19:13 INFO - Return code: 0 07:19:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:19:13 INFO - # TBPL SUCCESS # 07:19:13 INFO - Running post-action listener: _resource_record_post_action 07:19:13 INFO - Running post-run listener: _resource_record_post_run 07:19:14 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520597504; Read time: 100; Write time: 771552 07:19:14 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 251412480; Read time: 0; Write time: 463916 07:19:14 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269185024; Read time: 100; Write time: 307636 07:19:14 INFO - Running post-run listener: _upload_blobber_files 07:19:14 INFO - Blob upload gear active. 07:19:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:19:14 INFO - Copying logs to upload dir... 07:19:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.884579 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-23 07:19:14.223229) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:14.226686) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 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.009898 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.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:14.277667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:14.277996) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453558032.344396-1087526325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 07:19:14.327143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 07:19:14.327466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 07:19:14.327778) ========= ========= Total master_lag: 0.31 =========