builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1457138962.66 results: success (0) buildid: 20160303095134 builduid: 9da4829620494fa0b71663f3e75660b6 revision: a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.663456) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.663992) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.664289) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.686946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.687298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.700687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.701105) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.870950) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.871247) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.871616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:22.871886) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 16:49:23-- 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% 46.6M=0s 2016-03-04 16:49:23 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.036027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.036351) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.085688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.086069) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 --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-beta --rev a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 --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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 16:49:23,474 truncating revision to first 12 chars 2016-03-04 16:49:23,474 Setting DEBUG logging. 2016-03-04 16:49:23,474 attempt 1/10 2016-03-04 16:49:23,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a39cbdebde6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 16:49:23,769 unpacking tar archive at: mozilla-beta-a39cbdebde6c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647080 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.746024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.746378) ========= echo a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a39cbdebde6ca741f236a8f35d4f9e1df22f4f22'] 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 program finished with exit code 0 elapsedTime=0.004354 script_repo_revision: 'a39cbdebde6ca741f236a8f35d4f9e1df22f4f22' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.796051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.796382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 16:49:23.812700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-04 16:49:23.813131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:24 INFO - MultiFileLogger online at 20160304 16:49:24 in /builds/slave/test-pgo 16:49:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:49:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:49:24 INFO - {'append_to_log': False, 16:49:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:49:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:49:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:49:24 INFO - 'branch': 'Mozilla-Beta', 16:49:24 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:24 INFO - 'config_files': ('talos/linux_config.py',), 16:49:24 INFO - 'default_actions': ('clobber', 16:49:24 INFO - 'read-buildbot-config', 16:49:24 INFO - 'download-and-extract', 16:49:24 INFO - 'populate-webroot', 16:49:24 INFO - 'create-virtualenv', 16:49:24 INFO - 'install', 16:49:24 INFO - 'run-tests'), 16:49:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:24 INFO - 'download_minidump_stackwalk': True, 16:49:24 INFO - 'download_symbols': 'ondemand', 16:49:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:24 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:24 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:24 INFO - 'installer_path': 'installer.exe', 16:49:24 INFO - 'log_level': 'info', 16:49:24 INFO - 'log_name': 'talos', 16:49:24 INFO - 'log_to_console': True, 16:49:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:24 INFO - 'opt_config_files': (), 16:49:24 INFO - 'pip_index': False, 16:49:24 INFO - 'sps_profile': False, 16:49:24 INFO - 'sps_profile_interval': 0, 16:49:24 INFO - 'suite': 'dromaeojs', 16:49:24 INFO - 'system_bits': '32', 16:49:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:24 INFO - 'title': 'talos-linux64-ix-039', 16:49:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:24 INFO - 'use_talos_json': True, 16:49:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:49:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:24 INFO - 'work_dir': 'build'} 16:49:24 INFO - ##### 16:49:24 INFO - ##### Running clobber step. 16:49:24 INFO - ##### 16:49:24 INFO - Running pre-action listener: _resource_record_pre_action 16:49:24 INFO - Running main action method: clobber 16:49:24 INFO - rmtree: /builds/slave/test-pgo/build 16:49:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:49:24 INFO - Running post-action listener: _resource_record_post_action 16:49:24 INFO - ##### 16:49:24 INFO - ##### Running read-buildbot-config step. 16:49:24 INFO - ##### 16:49:24 INFO - Running pre-action listener: _resource_record_pre_action 16:49:24 INFO - Running main action method: read_buildbot_config 16:49:24 INFO - Using buildbot properties: 16:49:24 INFO - { 16:49:24 INFO - "properties": { 16:49:24 INFO - "buildnumber": 127, 16:49:24 INFO - "product": "firefox", 16:49:24 INFO - "script_repo_revision": "production", 16:49:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:49:24 INFO - "repository": "", 16:49:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:49:24 INFO - "buildid": "20160303095134", 16:49:24 INFO - "slavename": "talos-linux64-ix-039", 16:49:24 INFO - "pgo_build": "True", 16:49:24 INFO - "basedir": "/builds/slave/test-pgo", 16:49:24 INFO - "project": "", 16:49:24 INFO - "platform": "ubuntu64_hw", 16:49:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:49:24 INFO - "slavebuilddir": "test", 16:49:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:49:24 INFO - "branch": "mozilla-beta", 16:49:24 INFO - "repo_path": "releases/mozilla-beta", 16:49:24 INFO - "stage_platform": "linux64-pgo", 16:49:24 INFO - "builduid": "9da4829620494fa0b71663f3e75660b6", 16:49:24 INFO - "revision": "a39cbdebde6ca741f236a8f35d4f9e1df22f4f22" 16:49:24 INFO - }, 16:49:24 INFO - "sourcestamp": { 16:49:24 INFO - "repository": "", 16:49:24 INFO - "hasPatch": false, 16:49:24 INFO - "project": "", 16:49:24 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 16:49:24 INFO - "changes": [ 16:49:24 INFO - { 16:49:24 INFO - "category": null, 16:49:24 INFO - "files": [ 16:49:24 INFO - { 16:49:24 INFO - "url": null, 16:49:24 INFO - "name": "https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2" 16:49:24 INFO - } 16:49:24 INFO - ], 16:49:24 INFO - "repository": "", 16:49:24 INFO - "rev": "a39cbdebde6ca741f236a8f35d4f9e1df22f4f22", 16:49:24 INFO - "who": "ryanvm@gmail.com", 16:49:24 INFO - "when": 1457138891, 16:49:24 INFO - "number": 7696567, 16:49:24 INFO - "comments": "Bug 1246956 - Add loadReplace to session history. r=yoric, r=mfinkle, a=sledru", 16:49:24 INFO - "project": "", 16:49:24 INFO - "at": "Fri 04 Mar 2016 16:48:11", 16:49:24 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 16:49:24 INFO - "revlink": "", 16:49:24 INFO - "properties": [ 16:49:24 INFO - [ 16:49:24 INFO - "buildid", 16:49:24 INFO - "20160303095134", 16:49:24 INFO - "Change" 16:49:24 INFO - ], 16:49:24 INFO - [ 16:49:24 INFO - "builduid", 16:49:24 INFO - "9da4829620494fa0b71663f3e75660b6", 16:49:24 INFO - "Change" 16:49:24 INFO - ], 16:49:24 INFO - [ 16:49:24 INFO - "pgo_build", 16:49:24 INFO - "True", 16:49:24 INFO - "Change" 16:49:24 INFO - ] 16:49:24 INFO - ], 16:49:24 INFO - "revision": "a39cbdebde6ca741f236a8f35d4f9e1df22f4f22" 16:49:24 INFO - } 16:49:24 INFO - ], 16:49:24 INFO - "revision": "a39cbdebde6ca741f236a8f35d4f9e1df22f4f22" 16:49:24 INFO - } 16:49:24 INFO - } 16:49:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2. 16:49:24 INFO - Running post-action listener: _resource_record_post_action 16:49:24 INFO - ##### 16:49:24 INFO - ##### Running download-and-extract step. 16:49:24 INFO - ##### 16:49:24 INFO - Running pre-action listener: _resource_record_pre_action 16:49:24 INFO - Running main action method: download_and_extract 16:49:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:49:24 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')]} 16:49:24 INFO - https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/test_packages.json 16:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/test_packages.json 16:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:49:25 INFO - Downloaded 1270 bytes. 16:49:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:49:25 INFO - Using the following test package requirements: 16:49:25 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:49:25 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:25 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'jsshell-linux-x86_64.zip'], 16:49:25 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:25 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:49:25 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 16:49:25 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 16:49:25 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:25 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:49:25 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:49:25 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:25 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:25 INFO - https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:27 INFO - Downloaded 21584162 bytes. 16:49:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:49:29 INFO - Return code: 0 16:49:29 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:49:29 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')]} 16:49:29 INFO - https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:30 INFO - Downloaded 21584162 bytes. 16:49:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:49:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:49:31 INFO - Return code: 0 16:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:31 INFO - https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:49:32 INFO - Downloaded 11132038 bytes. 16:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:49:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:49:32 INFO - Return code: 0 16:49: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')]} 16:49:32 INFO - https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:49:34 INFO - Downloaded 57952010 bytes. 16:49:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:49:34 INFO - mkdir: /builds/slave/test-pgo/properties 16:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:49:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:49:34 INFO - Contents: 16:49:34 INFO - build_url:https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:49:34 INFO - Running post-action listener: _resource_record_post_action 16:49:34 INFO - Running post-action listener: set_extra_try_arguments 16:49:34 INFO - ##### 16:49:34 INFO - ##### Running populate-webroot step. 16:49:34 INFO - ##### 16:49:34 INFO - Running pre-action listener: _resource_record_pre_action 16:49:34 INFO - Running main action method: populate_webroot 16:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:34 INFO - '--tppagecycles', 16:49:34 INFO - '7'], 16:49:34 INFO - 'tests': ['tsvgm']}}, 16:49:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'tests': ['damp', 'tps']}, 16:49:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['damp', 'tps']}, 16:49:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:34 INFO - 'other': {'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'other_l64': {'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:34 INFO - 'ts_paint', 16:49:34 INFO - 'tpaint', 16:49:34 INFO - 'sessionrestore', 16:49:34 INFO - 'sessionrestore_no_auto_restore']}, 16:49:34 INFO - 'svgr': {'tests': ['tsvgx', 16:49:34 INFO - 'tsvgr_opacity', 16:49:34 INFO - 'tart', 16:49:34 INFO - 'tscrollx', 16:49:34 INFO - 'cart']}, 16:49:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['tsvgx', 16:49:34 INFO - 'tsvgr_opacity', 16:49:34 INFO - 'tart', 16:49:34 INFO - 'tscrollx', 16:49:34 INFO - 'cart']}, 16:49:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'tests': ['tp5o']}, 16:49:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'talos_options': ['--e10s'], 16:49:34 INFO - 'tests': ['tp5o']}, 16:49:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'talos_options': ['--xperf_path', 16:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:34 INFO - 'tests': ['tp5n']}, 16:49:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:34 INFO - 'talos_options': ['--e10s', 16:49:34 INFO - '--xperf_path', 16:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:34 INFO - 'tests': ['tp5n']}}, 16:49:34 INFO - 'talos.zip': {'path': '', 16:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:34 INFO - Running post-action listener: _resource_record_post_action 16:49:34 INFO - ##### 16:49:34 INFO - ##### Running create-virtualenv step. 16:49:34 INFO - ##### 16:49:34 INFO - Running pre-action listener: _resource_record_pre_action 16:49:34 INFO - Running main action method: create_virtualenv 16:49:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:49:34 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 16:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:34 INFO - Using real prefix '/usr' 16:49:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:37 INFO - Installing pip.................done. 16:49:37 INFO - Return code: 0 16:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:37 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 16:49:37 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 16:49:37 INFO - Using env: {'DISPLAY': ':0', 16:49:37 INFO - 'HOME': '/home/cltbld', 16:49:37 INFO - 'LANG': 'en_US.UTF-8', 16:49:37 INFO - 'LANGUAGE': 'en_US:en', 16:49:37 INFO - 'LOGNAME': 'cltbld', 16:49:37 INFO - 'MAIL': '/var/mail/cltbld', 16:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:37 INFO - 'MOZ_NO_REMOTE': '1', 16:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:37 INFO - 'NO_EM_RESTART': '1', 16:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:37 INFO - 'SHELL': '/bin/bash', 16:49:37 INFO - 'SHLVL': '1', 16:49:37 INFO - 'TERM': 'linux', 16:49:37 INFO - 'TMOUT': '86400', 16:49:37 INFO - 'USER': 'cltbld', 16:49:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:37 INFO - '_': '/tools/buildbot/bin/python'} 16:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:37 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 16:49:37 INFO - Cleaning up... 16:49:37 INFO - Return code: 0 16:49:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:37 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:37 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 16:49:37 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 16:49:37 INFO - Using env: {'DISPLAY': ':0', 16:49:37 INFO - 'HOME': '/home/cltbld', 16:49:37 INFO - 'LANG': 'en_US.UTF-8', 16:49:37 INFO - 'LANGUAGE': 'en_US:en', 16:49:37 INFO - 'LOGNAME': 'cltbld', 16:49:37 INFO - 'MAIL': '/var/mail/cltbld', 16:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:37 INFO - 'MOZ_NO_REMOTE': '1', 16:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:37 INFO - 'NO_EM_RESTART': '1', 16:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:37 INFO - 'SHELL': '/bin/bash', 16:49:37 INFO - 'SHLVL': '1', 16:49:37 INFO - 'TERM': 'linux', 16:49:37 INFO - 'TMOUT': '86400', 16:49:37 INFO - 'USER': 'cltbld', 16:49:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:37 INFO - '_': '/tools/buildbot/bin/python'} 16:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:37 INFO - Downloading/unpacking psutil>=0.7.1 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:37 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 16:49:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:39 INFO - Installing collected packages: psutil 16:49:39 INFO - Running setup.py install for psutil 16:49:39 INFO - building 'psutil._psutil_linux' extension 16:49:39 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 16:49:39 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 16:49:39 INFO - building 'psutil._psutil_posix' extension 16:49:39 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 16:49:40 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 16:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:40 INFO - Successfully installed psutil 16:49:40 INFO - Cleaning up... 16:49:40 INFO - Return code: 0 16:49:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:49:40 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')]} 16:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:40 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')]} 16:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:40 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:40 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 16:49:40 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 16:49:40 INFO - Using env: {'DISPLAY': ':0', 16:49:40 INFO - 'HOME': '/home/cltbld', 16:49:40 INFO - 'LANG': 'en_US.UTF-8', 16:49:40 INFO - 'LANGUAGE': 'en_US:en', 16:49:40 INFO - 'LOGNAME': 'cltbld', 16:49:40 INFO - 'MAIL': '/var/mail/cltbld', 16:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:40 INFO - 'MOZ_NO_REMOTE': '1', 16:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:40 INFO - 'NO_EM_RESTART': '1', 16:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:40 INFO - 'SHELL': '/bin/bash', 16:49:40 INFO - 'SHLVL': '1', 16:49:40 INFO - 'TERM': 'linux', 16:49:40 INFO - 'TMOUT': '86400', 16:49:40 INFO - 'USER': 'cltbld', 16:49:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:40 INFO - '_': '/tools/buildbot/bin/python'} 16:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:42 INFO - Installing collected packages: mozsystemmonitor 16:49:42 INFO - Running setup.py install for mozsystemmonitor 16:49:42 INFO - Successfully installed mozsystemmonitor 16:49:42 INFO - Cleaning up... 16:49:42 INFO - Return code: 0 16:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:49: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')]} 16:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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', '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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:49: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 blobuploader==1.2.4 16:49:42 INFO - Using env: {'DISPLAY': ':0', 16:49:42 INFO - 'HOME': '/home/cltbld', 16:49:42 INFO - 'LANG': 'en_US.UTF-8', 16:49:42 INFO - 'LANGUAGE': 'en_US:en', 16:49:42 INFO - 'LOGNAME': 'cltbld', 16:49:42 INFO - 'MAIL': '/var/mail/cltbld', 16:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:42 INFO - 'MOZ_NO_REMOTE': '1', 16:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:42 INFO - 'NO_EM_RESTART': '1', 16:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:42 INFO - 'SHELL': '/bin/bash', 16:49:42 INFO - 'SHLVL': '1', 16:49:42 INFO - 'TERM': 'linux', 16:49:42 INFO - 'TMOUT': '86400', 16:49:42 INFO - 'USER': 'cltbld', 16:49:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:42 INFO - '_': '/tools/buildbot/bin/python'} 16:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:45 INFO - Downloading docopt-0.6.1.tar.gz 16:49:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:45 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:45 INFO - Running setup.py install for blobuploader 16:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:49:45 INFO - Running setup.py install for requests 16:49:45 INFO - Running setup.py install for docopt 16:49:45 INFO - Successfully installed blobuploader requests docopt 16:49:45 INFO - Cleaning up... 16:49:45 INFO - Return code: 0 16:49:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49: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')]} 16:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:45 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:45 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 16:49:45 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 16:49:45 INFO - Using env: {'DISPLAY': ':0', 16:49:45 INFO - 'HOME': '/home/cltbld', 16:49:45 INFO - 'LANG': 'en_US.UTF-8', 16:49:45 INFO - 'LANGUAGE': 'en_US:en', 16:49:45 INFO - 'LOGNAME': 'cltbld', 16:49:45 INFO - 'MAIL': '/var/mail/cltbld', 16:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:45 INFO - 'MOZ_NO_REMOTE': '1', 16:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:45 INFO - 'NO_EM_RESTART': '1', 16:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:45 INFO - 'SHELL': '/bin/bash', 16:49:45 INFO - 'SHLVL': '1', 16:49:45 INFO - 'TERM': 'linux', 16:49:45 INFO - 'TMOUT': '86400', 16:49:45 INFO - 'USER': 'cltbld', 16:49:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:45 INFO - '_': '/tools/buildbot/bin/python'} 16:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:46 INFO - Running setup.py (path:/tmp/pip-LDUZ2t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:46 INFO - Running setup.py (path:/tmp/pip-_ceIQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:46 INFO - Running setup.py (path:/tmp/pip-OHpGZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:46 INFO - Running setup.py (path:/tmp/pip-YclsFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:46 INFO - Running setup.py (path:/tmp/pip-8JnQht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:46 INFO - Running setup.py (path:/tmp/pip-G3yPz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:46 INFO - Running setup.py (path:/tmp/pip-qf1a8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:46 INFO - Running setup.py (path:/tmp/pip-aZw1tN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:46 INFO - Running setup.py (path:/tmp/pip-l7C142-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:46 INFO - Running setup.py (path:/tmp/pip-na2Sqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:46 INFO - Running setup.py (path:/tmp/pip-Qkrw3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:46 INFO - Running setup.py (path:/tmp/pip-hZK_EL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:46 INFO - Running setup.py (path:/tmp/pip-PyR_VQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:46 INFO - Running setup.py (path:/tmp/pip-hFsuYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:47 INFO - Running setup.py (path:/tmp/pip-wJ0YHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:47 INFO - Running setup.py (path:/tmp/pip-zH7Tmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:47 INFO - Running setup.py (path:/tmp/pip-owPLZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:47 INFO - Running setup.py install for manifestparser 16:49:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:49:47 INFO - Running setup.py install for mozcrash 16:49:47 INFO - Running setup.py install for mozdebug 16:49:47 INFO - Running setup.py install for mozdevice 16:49:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:49:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:49:47 INFO - Running setup.py install for mozfile 16:49:47 INFO - Running setup.py install for mozhttpd 16:49:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:49:47 INFO - Running setup.py install for mozinfo 16:49:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:49:47 INFO - Running setup.py install for mozInstall 16:49:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Running setup.py install for mozleak 16:49:48 INFO - Running setup.py install for mozlog 16:49:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Running setup.py install for moznetwork 16:49:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Running setup.py install for mozprocess 16:49:48 INFO - Running setup.py install for mozprofile 16:49:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Running setup.py install for mozrunner 16:49:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:49:48 INFO - Running setup.py install for mozscreenshot 16:49:48 INFO - Running setup.py install for moztest 16:49:48 INFO - Running setup.py install for mozversion 16:49:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:49:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:49 INFO - Cleaning up... 16:49:49 INFO - Return code: 0 16:49:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:49 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 16:49:49 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 16:49:49 INFO - Using env: {'DISPLAY': ':0', 16:49:49 INFO - 'HOME': '/home/cltbld', 16:49:49 INFO - 'LANG': 'en_US.UTF-8', 16:49:49 INFO - 'LANGUAGE': 'en_US:en', 16:49:49 INFO - 'LOGNAME': 'cltbld', 16:49:49 INFO - 'MAIL': '/var/mail/cltbld', 16:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:49 INFO - 'MOZ_NO_REMOTE': '1', 16:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:49 INFO - 'NO_EM_RESTART': '1', 16:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:49 INFO - 'SHELL': '/bin/bash', 16:49:49 INFO - 'SHLVL': '1', 16:49:49 INFO - 'TERM': 'linux', 16:49:49 INFO - 'TMOUT': '86400', 16:49:49 INFO - 'USER': 'cltbld', 16:49:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:49 INFO - '_': '/tools/buildbot/bin/python'} 16:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:49 INFO - Running setup.py (path:/tmp/pip-7J_8zB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:49 INFO - Running setup.py (path:/tmp/pip-tz3akJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:49 INFO - Running setup.py (path:/tmp/pip-YuyIJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:49 INFO - Running setup.py (path:/tmp/pip-sMjFUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:49 INFO - Running setup.py (path:/tmp/pip-qtKxqY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:49 INFO - Running setup.py (path:/tmp/pip-m4kb8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:49 INFO - Running setup.py (path:/tmp/pip-bVWg8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:49 INFO - Running setup.py (path:/tmp/pip-_2jbWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:49 INFO - Running setup.py (path:/tmp/pip-7uG4Cc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:49 INFO - Running setup.py (path:/tmp/pip-q3wLiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:49 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)) 16:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:49 INFO - Running setup.py (path:/tmp/pip-oEnnYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:50 INFO - Running setup.py (path:/tmp/pip-hkomQc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:50 INFO - Running setup.py (path:/tmp/pip-orLuKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:50 INFO - Running setup.py (path:/tmp/pip-oWuLLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:50 INFO - Running setup.py (path:/tmp/pip-1zJVE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:50 INFO - Running setup.py (path:/tmp/pip-ZA3cbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:50 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)) 16:49:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:50 INFO - Running setup.py (path:/tmp/pip-_wNxp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:50 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)) 16:49:50 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)) 16:49:50 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)) 16:49:50 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)) 16:49:50 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)) 16:49:50 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)) 16:49:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:50 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 16:49:52 INFO - Downloading blessings-1.6.tar.gz 16:49:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:52 INFO - Installing collected packages: blessings 16:49:52 INFO - Running setup.py install for blessings 16:49:52 INFO - Successfully installed blessings 16:49:52 INFO - Cleaning up... 16:49:52 INFO - Return code: 0 16:49:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:49:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:49:52 INFO - Reading from file tmpfile_stdout 16:49:52 INFO - Current package versions: 16:49:52 INFO - argparse == 1.2.1 16:49:52 INFO - blessings == 1.6 16:49:52 INFO - blobuploader == 1.2.4 16:49:52 INFO - docopt == 0.6.1 16:49:52 INFO - manifestparser == 1.1 16:49:52 INFO - mozInstall == 1.12 16:49:52 INFO - mozcrash == 0.16 16:49:52 INFO - mozdebug == 0.1 16:49:52 INFO - mozdevice == 0.47 16:49:52 INFO - mozfile == 1.2 16:49:52 INFO - mozhttpd == 0.7 16:49:52 INFO - mozinfo == 0.9 16:49:52 INFO - mozleak == 0.1 16:49:52 INFO - mozlog == 3.1 16:49:52 INFO - moznetwork == 0.27 16:49:52 INFO - mozprocess == 0.22 16:49:52 INFO - mozprofile == 0.27 16:49:52 INFO - mozrunner == 6.11 16:49:52 INFO - mozscreenshot == 0.1 16:49:52 INFO - mozsystemmonitor == 0.0 16:49:52 INFO - moztest == 0.7 16:49:52 INFO - mozversion == 1.4 16:49:52 INFO - psutil == 3.1.1 16:49:52 INFO - requests == 1.2.3 16:49:52 INFO - wsgiref == 0.1.2 16:49:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49:52 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')]} 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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')]} 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:52 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 16:49:52 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 16:49:52 INFO - Using env: {'DISPLAY': ':0', 16:49:52 INFO - 'HOME': '/home/cltbld', 16:49:52 INFO - 'LANG': 'en_US.UTF-8', 16:49:52 INFO - 'LANGUAGE': 'en_US:en', 16:49:52 INFO - 'LOGNAME': 'cltbld', 16:49:52 INFO - 'MAIL': '/var/mail/cltbld', 16:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:52 INFO - 'MOZ_NO_REMOTE': '1', 16:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:52 INFO - 'NO_EM_RESTART': '1', 16:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:52 INFO - 'SHELL': '/bin/bash', 16:49:52 INFO - 'SHLVL': '1', 16:49:52 INFO - 'TERM': 'linux', 16:49:52 INFO - 'TMOUT': '86400', 16:49:52 INFO - 'USER': 'cltbld', 16:49:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:52 INFO - '_': '/tools/buildbot/bin/python'} 16:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 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)) 16:49:52 INFO - Cleaning up... 16:49:52 INFO - Return code: 0 16:49:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:49:52 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')]} 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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')]} 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:52 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 16:49:52 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 16:49:52 INFO - Using env: {'DISPLAY': ':0', 16:49:52 INFO - 'HOME': '/home/cltbld', 16:49:52 INFO - 'LANG': 'en_US.UTF-8', 16:49:52 INFO - 'LANGUAGE': 'en_US:en', 16:49:52 INFO - 'LOGNAME': 'cltbld', 16:49:52 INFO - 'MAIL': '/var/mail/cltbld', 16:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:52 INFO - 'MOZ_NO_REMOTE': '1', 16:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:52 INFO - 'NO_EM_RESTART': '1', 16:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:52 INFO - 'SHELL': '/bin/bash', 16:49:52 INFO - 'SHLVL': '1', 16:49:52 INFO - 'TERM': 'linux', 16:49:52 INFO - 'TMOUT': '86400', 16:49:52 INFO - 'USER': 'cltbld', 16:49:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:52 INFO - '_': '/tools/buildbot/bin/python'} 16:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:53 INFO - Downloading/unpacking jsonschema 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:55 INFO - Downloading/unpacking functools32 (from jsonschema) 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:55 INFO - warning: no files found matching '*.txt' 16:49:55 INFO - no previously-included directories found matching 'build' 16:49:55 INFO - no previously-included directories found matching 'dist' 16:49:55 INFO - no previously-included directories found matching '.git*' 16:49:55 INFO - Installing collected packages: jsonschema, functools32 16:49:55 INFO - Running setup.py install for functools32 16:49:55 INFO - warning: no files found matching '*.txt' 16:49:55 INFO - no previously-included directories found matching 'build' 16:49:55 INFO - no previously-included directories found matching 'dist' 16:49:55 INFO - no previously-included directories found matching '.git*' 16:49:55 INFO - Successfully installed jsonschema functools32 16:49:55 INFO - Cleaning up... 16:49:55 INFO - Return code: 0 16:49:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:49:55 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')]} 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:55 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')]} 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:55 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 0x7fa85d7bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, '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-1457138962.203498-1760333907', '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 16:49:55 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 16:49:55 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 16:49:55 INFO - Using env: {'DISPLAY': ':0', 16:49:55 INFO - 'HOME': '/home/cltbld', 16:49:55 INFO - 'LANG': 'en_US.UTF-8', 16:49:55 INFO - 'LANGUAGE': 'en_US:en', 16:49:55 INFO - 'LOGNAME': 'cltbld', 16:49:55 INFO - 'MAIL': '/var/mail/cltbld', 16:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:55 INFO - 'MOZ_NO_REMOTE': '1', 16:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:55 INFO - 'NO_EM_RESTART': '1', 16:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:55 INFO - 'SHELL': '/bin/bash', 16:49:55 INFO - 'SHLVL': '1', 16:49:55 INFO - 'TERM': 'linux', 16:49:55 INFO - 'TMOUT': '86400', 16:49:55 INFO - 'USER': 'cltbld', 16:49:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:55 INFO - '_': '/tools/buildbot/bin/python'} 16:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:55 INFO - Downloading/unpacking flake8 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:49:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:49:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:49:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:58 INFO - no previously-included directories found matching 'docs/_build' 16:49:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:49:58 INFO - Running setup.py install for pep8 16:49:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:58 INFO - no previously-included directories found matching 'docs/_build' 16:49:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:49:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:49:58 INFO - Cleaning up... 16:49:58 INFO - Return code: 0 16:49:58 INFO - Running post-action listener: _resource_record_post_action 16:49:58 INFO - Running post-action listener: _start_resource_monitoring 16:49:58 INFO - Starting resource monitoring. 16:49:58 INFO - ##### 16:49:58 INFO - ##### Running install step. 16:49:58 INFO - ##### 16:49:58 INFO - Running pre-action listener: _resource_record_pre_action 16:49:58 INFO - Running main action method: install 16:49:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:49:58 INFO - Reading from file tmpfile_stdout 16:49:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:49:58 INFO - Reading from file tmpfile_stdout 16:49:58 INFO - Output received: 16:49:58 INFO - Usage: mozinstall [options] installer 16:49:58 INFO - Options: 16:49:58 INFO - -h, --help show this help message and exit 16:49:58 INFO - -d DEST, --destination=DEST 16:49:58 INFO - Directory to install application into. [default: 16:49:58 INFO - "/builds/slave/test-pgo"] 16:49:58 INFO - --app=APP Application being installed. [default: firefox] 16:49:58 INFO - mkdir: /builds/slave/test-pgo/build/application 16:49:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:50:13 INFO - Reading from file tmpfile_stdout 16:50:13 INFO - Output received: 16:50:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:50:13 INFO - Running post-action listener: _resource_record_post_action 16:50:13 INFO - ##### 16:50:13 INFO - ##### Running run-tests step. 16:50:13 INFO - ##### 16:50:13 INFO - Running pre-action listener: _resource_record_pre_action 16:50:13 INFO - Running main action method: run_tests 16:50:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:50:13 INFO - Python 2.7.3 16:50:13 INFO - Return code: 0 16:50:13 INFO - grabbing minidump binary from tooltool 16:50:13 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')]} 16:50:13 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 0x2b993b0>, '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 0x2b9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:50:13 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 16:50:13 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 16:50:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:13 INFO - Return code: 0 16:50:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:50:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:50:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:50:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:50:14 INFO - Return code: 0 16:50:14 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:50:14 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 16:50:14 INFO - Using env: {'DISPLAY': ':0', 16:50:14 INFO - 'HOME': '/home/cltbld', 16:50:14 INFO - 'LANG': 'en_US.UTF-8', 16:50:14 INFO - 'LANGUAGE': 'en_US:en', 16:50:14 INFO - 'LOGNAME': 'cltbld', 16:50:14 INFO - 'MAIL': '/var/mail/cltbld', 16:50:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:14 INFO - 'MOZ_NO_REMOTE': '1', 16:50:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:14 INFO - 'NO_EM_RESTART': '1', 16:50:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:50:14 INFO - 'SHELL': '/bin/bash', 16:50:14 INFO - 'SHLVL': '1', 16:50:14 INFO - 'TERM': 'linux', 16:50:14 INFO - 'TMOUT': '86400', 16:50:14 INFO - 'USER': 'cltbld', 16:50:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457138962.203498-1760333907', 16:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:14 INFO - '_': '/tools/buildbot/bin/python'} 16:50:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 16:50:14 INFO - mozversion INFO | application_buildid: 20160303095134 16:50:14 INFO - mozversion INFO | application_changeset: a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 16:50:14 INFO - mozversion INFO | application_display_name: Nightly 16:50:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:14 INFO - mozversion INFO | application_name: Firefox 16:50:14 INFO - mozversion INFO | application_remotingname: firefox 16:50:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:50:14 INFO - mozversion INFO | application_vendor: Mozilla 16:50:14 INFO - mozversion INFO | application_version: 45.0 16:50:14 INFO - mozversion INFO | platform_buildid: 20160303095134 16:50:14 INFO - mozversion INFO | platform_changeset: a39cbdebde6ca741f236a8f35d4f9e1df22f4f22 16:50:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:50:14 INFO - mozversion INFO | platform_version: 45.0 16:50:14 INFO - 2016-03-04 16:50:14,686 DEBUG : using testdate: 1457139014 16:50:14 INFO - 2016-03-04 16:50:14,686 DEBUG : actual date: 1457139014 16:50:14 INFO - 2016-03-04 16:50:14,694 INFO : starting webserver on 'localhost:47768' 16:50:14 INFO - 2016-03-04 16:50:14,695 INFO : Starting test suite talos-linux64-ix-039 16:50:14 INFO - 2016-03-04 16:50:14,695 INFO : Starting test dromaeo_css 16:50:14 INFO - 2016-03-04 16:50:14,696 DEBUG : operating with platform_type : linux_ 16:50:14 INFO - 2016-03-04 16:50:14,696 INFO : Initialising browser for dromaeo_css test... 16:50:14 INFO - 2016-03-04 16:50:14,713 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp104kY8/profile http://localhost:47768/getInfo.html 16:50:19 INFO - 2016-03-04 16:50:19,045 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:19 INFO - 2016-03-04 16:50:19,045 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:19 INFO - 2016-03-04 16:50:19,045 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:50:19 INFO - 2016-03-04 16:50:19,045 DEBUG : BROWSER_OUTPUT: __metrics 16:50:19 INFO - 2016-03-04 16:50:19,207 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] 16:50:20 INFO - 2016-03-04 16:50:20,047 INFO : Browser initialized. 16:50:20 INFO - 2016-03-04 16:50:20,048 INFO : Running cycle 1/1 for dromaeo_css test... 16:50:20 INFO - 2016-03-04 16:50:20,048 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp104kY8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:50:31 INFO - 2016-03-04 16:50:31,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 134332416 16:50:31 INFO - 2016-03-04 16:50:31,694 DEBUG : BROWSER_OUTPUT: 16:51:22 INFO - 2016-03-04 16:51:22,454 DEBUG : BROWSER_OUTPUT: 1457139082450 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] 16:53:30 INFO - 2016-03-04 16:53:30,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47768/tests/dromaeo/cssquery-ext.html) 16:53:32 INFO - 2016-03-04 16:53:32,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 244838400 16:53:32 INFO - 2016-03-04 16:53:32,054 DEBUG : BROWSER_OUTPUT: 16:56:34 INFO - 2016-03-04 16:56:34,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-ext.html (next: http://localhost:47768/tests/dromaeo/cssquery-jquery.html) 16:56:34 INFO - 2016-03-04 16:56:34,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 215355392 16:56:34 INFO - 2016-03-04 16:56:34,692 DEBUG : BROWSER_OUTPUT: 16:59:36 INFO - 2016-03-04 16:59:36,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47768/tests/dromaeo/cssquery-mootools.html) 16:59:37 INFO - 2016-03-04 16:59:37,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 212721664 16:59:37 INFO - 2016-03-04 16:59:37,036 DEBUG : BROWSER_OUTPUT: 17:02:38 INFO - 2016-03-04 17:02:38,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47768/tests/dromaeo/cssquery-prototype.html) 17:02:39 INFO - 2016-03-04 17:02:39,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 208703488 17:02:39 INFO - 2016-03-04 17:02:39,349 DEBUG : BROWSER_OUTPUT: 17:05:41 INFO - 2016-03-04 17:05:41,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47768/tests/dromaeo/cssquery-yui.html) 17:05:42 INFO - 2016-03-04 17:05:42,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 196317184 17:05:42 INFO - 2016-03-04 17:05:42,244 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/dromaeo/cssquery-yui.html (next: http://localhost:47768/tests/dromaeo/cssquery-dojo.html) 17:08:44 INFO - 2016-03-04 17:08:44,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 214360064 17:08:44 INFO - 2016-03-04 17:08:44,728 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,729 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:08:44 INFO - 2016-03-04 17:08:44,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:08:44 INFO - 2016-03-04 17:08:44,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:08:44 INFO - 2016-03-04 17:08:44,730 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:08:44 INFO - 2016-03-04 17:08:44,731 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3292.5719656444667;3384.035549868288;3414.6243913169565;3415.077928959181;3434.1929646533063;5667.773289068443;5670.829875103754;5673.092305231164;5708.257926469553;5719.170720245567;5695.629784064044;5733.541316694665;5748.19525266462;5749;5765.625234359763;4920.753962301888;5164.948350516484;5204.063268611649;5257.421683614799;5282.102042652739;5103.846884593449;5150;5194.870128246786;5232.16285394337;5233.86915327118;5132.794688212467;5145.6398052136365;5146.6140039497;5151.175811870102;5152.227165925104;4990.675606085629;5123.257127716498;5136.974315128437;5229.529342359206;5267.947320526803;4984.725840078794;5051.924221136685;5074.3657042869645;5079.492050794928;5087.389513258433;5443.918341224885;5469.07025805614;5479.4520547945285;5483.698396588186;5485.61600687952;6086.756529738849;6149.108379285023;6149.477294429978;6155.907661385083;6156.938430615682;5911.320198177222;5968.70156492178;5978.0435130379365;5981.342052374235;6056.636601803862;5654.180143879155;5665.603407761459;5666.603337766317;5670.404607516192;5674.2623458950075;6051.273847138372;6206.751729930752;6250.593711408744;6251.874962500725;6258.030005349178;5884.6469211847425;6031.788887388921;6049.3950604939155;6100.847478813065;6112.51099912006;6077.908831367533;6080.270367555921;6081.726322315506;6101.298350689639;6116.48009919153;5636.351819540723;5824.504917082011;6082.665453400105;6088.726007329681;6095.2685677718955;5991.610545314541;6031.969840150771;6048.6673232971725;6083.6349819011;6123.571350005546;4660.207764680013;4676.602488788491;4683.414573178353;4709.481956984729;4747.264174053027;4069.89825254371;4098.282800509958;4159.91680166395;4209.957900420956;4229.788510574521;5666.036773748473;5708.857278568069;5790.71046447676;5816.883662326814;5820.039693450618;6156.107364432221;6217.160683307786;6217.658028808369;6221.3156552779155;6223;5532.059549876531;5672.290963629546;5683.886322273532;5756.280464941882;5808.854778630483;5266.631335806457;5352.678839269656;5362.678239305654;5364.30264065669;5376.46235376467;6279.277883043508;6295.118683384329;6296.842578935563;6303.558750887486;6313.77901773445;5997.820065398045;6105.358937311518;6135.84660383494;6223.751049957951;6245.625262484084;6236.220472440945;6269.31037585856;6297.748090076529;6307.779227727007;6311.27420346666;5721.542276617944;6111.663858487826;6123.173371594956;6127.479164271087;6131.233595800525;6029.78895738647;6046.516278697605;6060.151578778887;6080.574359794949;6099.9390006099375;5880.470757631833;5880.911786323294;5885.94114058871;5891.293044834647;5998.430149135826;5799.507041901317;5882.176495290577;5885.911711324419;5886.323072846678;5900.586958912835;5739.598228123991;5818.127280907897;5833.941660583339;5845.532357411482;5863.442972917566;5854.94145058561;5908.113782932594;5913.733881975408;5934.673592952429;5936.851578710567;5744.080947048452;5800.796972105956;5814.215080964185;5825.0388685866355;5840.970795145997 17:08:44 INFO - 2016-03-04 17:08:44,733 DEBUG : BROWSER_OUTPUT: |1;ext.html;624.9500039996801;653.9803805885825;669.2237005074113;679.1307126877597;712.5119293284104;30733.84633076837;31355.843220783863;31357.843210783944;31429;31458.68541314586;34457.65542344576;41361.58638413615;42441;42481;42494.57505424945;9263.444193348403;9383.953080234623;9404.52977351133;9412.058794120567;9416.199623032051;8364.289035431995;8556.358273129541;9153.542322883863;9268.119528644802;9284.489353085577;8297.792555186108;8377.49735015898;8394.706185283516;8405.747827565152;11142.220044596881;10890.529778479922;11006;11015.724606884813;11019.614313499029;11029.227954043221;10820.350778953289;10902.563897444094;10953;10959.83560246597;10970.835437468444;43552.56447435517;43757.34363984511;43926.34110488345;43933.78033109846;43979;3545.4150065239205;3569;3864.555576108727;4075.3886916962397;4220.36694495825;33775.493367599505;34073.829630851935;34268.82865585681;34756.82621586901;34947.650523494696;3607.512985746917;3834.482344883461;3842.9423558646645;4375.453068366454;4464.486584042844;301012;301035;302052;302598.9999999978;304811;60083.699581501816;61334;72223;74831;75127;68773;68789.3121068793;68925.65537172282;69029;69146.30853691399;16769.916150419413;16778.832211677727;16897.57756056084;16943.406980755615;16944.15279236058;12618.116731828868;12792.74414511723;12809.679758005937;12860.614181574567;12865.099443039084;22759.658605120938;23129.421764456023;23198.53602927932;23261.651075233884;23291.534169316517;8440.324774018063;8730.257928076184;8763.167499087576;8839.513826739463;8846.115388461103;1033.8759348878182;1127.8495934147124;1208.8241165901518;1209.9637010889687;1220.993895030519;30459.390812183632;31069.203771660657;31115.377692446025;31272.21819454532;31476.213094672818;1087.1954753482366;1132.3036332655358;1152.6426807689643;1155.2202263472122;1199.016806218892;14887.553373398816;16366.754498682529;17184.570385740455;17895.73156402655;18437.1703273353;443258;447432;448770;449585;449791;60749.69625151846;61026;61268;61374;61388;1358.3004752552442;1360.2246719369864;1463.8682518573166;1488.5385530485585;1519.749241375183;30707.539386909662;30764;31000.534991974688;31539.52690709595;32087.037388878372;53974.19038714344;55131.72434137804;55209;55323.17015244694;55398;322816;323480;323680;324492;324605;47107.29339059985;47604.52395476001;47954.28068578905;48375.75812120917;48546.27180592223;50385;50414;50437.747811260706;50484.747576263355;50867;39605.80197099112;40882.59117408788;41378.379324310765;41587.7920610395;42741.572584275;42057.78971105125;42098.57901420946;42102.789486052374;43222;43288.13423731571;41234.79382603068;41770.79114604529;41788.582114179684;42657;42795.786021069696;36527.45208821923;39450.80274598609;40540;40684;41606.583934161485;26850.194494165207;27262.318442039108;27458.17625471239;27765.861170694017;28182.69970909636 17:08:44 INFO - 2016-03-04 17:08:44,734 DEBUG : BROWSER_OUTPUT: |2;jquery.html;369.79476390603213;375.36563208178194;377.6525596451265;383.6125513231637;384.6941681363314;14672.413103475848;17015.82984170158;17173.313067477287;18570.721439178407;18622.441326760203;11874.762504749922;12187.756244875098;12189.634310970663;19239;19545.12046957887;4026.838926442939;5048.040872234273;5155.664881782672;5156.432792392834;5157.097507936096;4108.465899433069;5596.636218645775;5738.340090889559;5751.396103409144;5752.741126649311;5581.7209139543065;5678.801241956532;5700.515456186229;5702.971485142569;5714.3999880012625;5635.380108188096;5670.829875103754;5684.63049901755;5696.971515142439;5699.658020518782;5358.839234822962;5466.890662186734;5480.945190548084;5492.340919089695;5568.415316391802;14148.504802331869;14272;14281.642958926006;18861.434156975312;21931.561368772695;2135.743710754704;2219.8113160381386;2285;2430.1858877276136;2461.729209786922;10457.68626941193;12012.759744805055;12818.423170957329;14279.286035698173;14412.13527188372;1854.8423384012376;1911.665458544749;1934.3906669399094;1939.9903000485049;1948.074664534349;66239;66790.3320966789;67323.9999999995;68226.317736823;68883;10584.947075264728;10923.180761442924;11083.445827708581;11106.833397499044;11137.777244455228;14491.130532168103;14731.779023314659;14748.262586870613;14754.852451475563;14771.704565908622;7882.605869706492;7901.051873775069;7944.165862584461;7987.760367188994;8013.278804907586;7680.731174408869;7691.769246922601;7725.343345815669;7726.575038372831;7812.648430820626;3987.182627561343;4604.217283061887;4678.508756580578;4690.226112691368;4714.858554243378;1730.7749992500894;1766.355280322673;1799.5770993816443;1832.193834712722;1859.312054539829;987.1066684650403;989.4904124375952;1008.2085562833288;1018.7198520406947;1064.9680509584725;14067.577972660836;16669.749953750703;16797.748033779502;17117.828821711624;17262.65474690499;952.4761381240429;966.2752935298527;1011.6155860772859;1059.5814653211937;1097.665212110298;9465.66870159541;9596.808063838684;9613.807723845484;9689.563969621384;9708.223342132613;664160;722404;723762;741224;752611;87995.56002220076;89065.55467222622;90742.99999999868;91766.54116729507;94397.52801236087;1227.9324637144864;1236.2891337480805;1244.9128561000643;1245.5453759377942;1248.6815861955324;15430.382784688487;15627.765583516484;15640.217989100272;15656.21718914027;15781.842181578037;20909.89545052265;34896.65103348934;35309.646903530636;36721.81639091788;36964.63035369612;47849.76075119602;48429.76774844308;49105.75447122742;49482;49805.75097124491;10386.272960892666;10433.739156521147;10435.37387756737;10646.574137034431;10671.679849604525;17778.5555361117;17997.370092046716;18182.27270909149;18309;18714.81285187185;15552;15764.669582916147;16126.193690315671;16148;16151.67696646037;15437.305321260346;15785.210739463211;15868;16084.115373654093;16306.67386652284;12241.571544995883;12612.684682883002;15218.771718424012;15397.230138493254;15580.766288505909;9906.801863962824;9907;9917.958614345389;10031.799364012533;10177.389356638625;11945.462454189756;15339.309731062353;15417.614559635651;15605.843941560894;16064.116473594064 17:08:44 INFO - 2016-03-04 17:08:44,737 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1537.2467490929441;1538.776877352784;1732.722764357703;1801.7657704498417;1836.384811088285;7272.0546328977225;7427.405807535398;7449.776506704808;7450.478466507347;7457.55254684718;6990.755323563676;7097.2902709729005;7498.737544185941;7679.232076792332;7785.221477852226;2359.032796553418;2374.097842819726;2395.4849707312924;2397.4845408237225;2400.0759707512557;2081.9375418737463;2354.117206047732;2383.392234980078;2401.987990060047;2403.4111642647576;2137.6366017777013;2261.231181398324;2353.0705371378294;2353.5410594933996;2353.894074766631;2289.8511596746243;2291.0721157931066;2297.632378819389;2340.403197184707;2342.121704360865;2334.1830359374253;2336.33414476875;2359.9646005309933;2369.3958040699686;2376.9881150594138;7764.30121289081;7848.921510784933;7850.960745196295;7858.410619203582;7861.4103942204565;4779.617630589544;4891.413030436335;4894.877628059327;4896;4901.436334821506;3072.846357682107;3075.6814921090377;3086.0279012111114;3108.4404807134706;3151.07043422191;996.4170959988415;1013.7060252526759;1018.1193267823279;1054.2304117993908;1054.520193312041;10685.519151638195;10809;10840.67477975662;10841.674749757442;10848.67453976374;4172.853950111731;4188.769617671057;4253.085586598834;4258.8296468140925;4270.466191726035;8684.652613895374;8688.087750786077;8699.43453675509;8704.608292626846;8708.564571771387;4774.4509381420885;4798.47216806151;4807.711537307773;4811.158047341702;4818.132736107535;4460.264056430718;4464.55354464551;4485.708428952108;4495.280755079171;4495.303227999665;3535.487354333607;3578.6958108561066;3579.46308053794;3602.8378722957004;3608.0979755061235;1041.8385150301565;1046.3042077018697;1096.0792933935372;1100.2243418390017;1189.6966273600176;1181.0492553494519;1218.9878101218874;1220.8840160184768;1492.4030387844948;1510.6903084867577;7406.925930740624;7526.5107767994905;7528.058992625922;7539.660715267826;7581.50720203185;1210.9878901211052;1211.7455334379704;1223.5472875036116;1226.1171956191529;1243.7823380908305;6055;6103.908441373383;6147;6161.969190154021;6165.445109940127;9229.861552076723;9433;9503.144716975366;9515.57179926905;9532.857007144898;9324.067593240621;9378.765530861647;9410.482423466776;9424.575894084783;9439.103285187895;7132.750353737594;7315.780526584211;7331.486795924234;7333.1200255969625;7351.632418379059;7449.366803821736;7524.134724506533;7536.623168841426;7579.962100189464;7581.696732130874;8426.662933482592;8442.071372148936;8533.445326053787;8588.184122508352;8598.183172598594;8572.185642363966;8639.308855291687;8744.606492707717;8747.081556436482;8770.56147192625;7110.146782386147;7171.533850299714;7173.46199035064;7191.42468602521;7192.928070719226;7356.448266379936;7373.741919032808;7417.443691723034;7419.629018549159;7565;6512.706928188338;7169.749058783126;7174.390176834819;7204.855902882018;7303.196648368569;6627.602343859191;7022.508424410242;7146.714131434893;7220.74727384539;7276.7089316428865;7249.347558719741;7269.418446524372;7289.781306560812;7294.270572942663;7294.452916031213;6796.66016699173;6822;6835.1114355135505;6845.965770171118;6854.520183587101;6740.056392105012;6768.08630834831;6785.626790526371;6795.524313298021;6817.93182068173 17:08:44 INFO - 2016-03-04 17:08:44,739 DEBUG : BROWSER_OUTPUT: |4;prototype.html;352.807719792713;356.7342329964177;358.7381211715448;359.40159634209044;363.66361115967726;6016.669083200422;6121.571489995702;6125.63246205228;6141.8157455276305;6195.132681424604;5828.446297601731;5912.231409916705;5978.491828194608;6053.213082299295;6063.393660633935;4703.694259873115;4726.503717109706;4743.739094349809;4746.264329029006;4750.524947505239;4722;4726.409198850144;4735.3133795599615;4735.715857048571;4735.763211839411;4487.057717879249;4570.223062079454;4594.839180628679;4654.557817007379;4682.625389968812;4658.97670511647;4668.6731928765;4673.135469938055;4674.69614475058;4678.157931572316;4147.04617937876;4150.086980864236;4152.647025002879;4155.688323375729;4157.210130075276;5732.770689172428;5794.159846822229;5806.912896306559;5811.6803575803315;5812.418758124196;5486.753096110685;5497;5503.3120859892515;5503.972480137573;5504.669719816824;6379.936200638027;6399.87200255997;6413.903791443132;6418.19772528434;6421.64680942548;4628.699134556243;4630.86107416778;4633.62930965522;4633.698809577367;4637.513061128567;6529.902051469232;6655.567388119805;6666.23338316095;6692.899606505906;6705.329467053304;4604.401427814362;4640.698354607007;4642.489326174118;4646.8141274348645;4647.233206520887;4695.460022097434;4699.483056863743;4701.3653156824075;4703.670743047954;4704.788284527204;5404.729763511808;5408.945910540844;5412.810551630752;5413.512783849473;5422.132458806651;6342.270638876496;6461.676916154173;6464.450521705614;6469.54713170083;6480.416762491398;1624.8781341399206;1633.2813562032668;1641.958951026234;1645.0129922046676;1647.8928869623676;1089.8310761831929;1104.3318792130806;1107.2526044919648;1123.3821398230941;1131.9490622921987;6275.874482510416;6286.49708023357;6297.874042519124;6298.275698294663;6299.338569450233;6673.232578253563;6679.76620818269;6690.0968369270495;6690.99635054736;6698.263191048981;6085.148079268906;6144.41628045335;6252.562320637512;6264.123022776815;6336.20797400325;3580.946285805715;3607.7294202934886;3612.3317186320614;3613.6205698401814;3618.3848745713294;6798.7280508779095;6807.842666746665;6818.931810681929;6819.761308354283;6823.215330236987;6674.83312917181;6842.213145488233;6845.212800528003;6845.53560718141;6849.349311815469;6808.829779255559;6820.35206655367;6820.727170913108;6823.317668233137;6823.522353435212;6577.276499585138;6674.733010679713;6677.165354330708;6690.732370705117;6692.397684208445;6578.144841170617;6605.768798092044;6610.140681711347;6623.966880165761;6627.6354800484505;6790.898136527857;6794.082798822294;6808.82977925536;6817.93182068173;6822.351876571718;4669.066186762593;4669.649776266726;4671.85984420468;4673.883152921204;4676.976615116902;6606.636634985122;6700.765473208415;6733.932660673527;6735.4611631070375;6739.157605299338;6512.3162067982175;6520.3805638466165;6534.411902928759;6540.8364790880605;6547.70535325902;6417.711202995783;6518.73925043012;6527.05357723137;6532.379423954717;6535.803925882231;6364.681765911779;6383.425491705769;6398.328175541687;6425.036244563166;6426.807195784134;6484.708188131451;6532.150820393318;6535.2811190768025;6548.1487406638735;6557.377049180321;6222.346653601488;6393.328700486568;6404.071409645482;6405.903911441425;6416.48668106541 17:08:44 INFO - 2016-03-04 17:08:44,740 DEBUG : BROWSER_OUTPUT: |5;yui.html;783.1307248953664;822.2846123872232;847.6058632735777;950.1780959470059;958.3531116496365;14878.404863805436;15077.170755608437;16960.999999999985;17216.913915430407;17368.47894563165;15905.602359941007;15938.920305398457;15987.280572374242;16021.599460013505;16023.198840058008;753.5403403923602;760.6691089376139;761.5506850957934;908.4821651658557;927.5501381829807;750.3996802557959;900.4642237868491;918.8805455290803;920.0201785098849;920.5535315372039;941.1952780372785;961.9807603847919;963.2246041936238;964.6382606522554;965.1072757699101;782.7690831204808;791.2680770287461;946.5172761891416;947.6067432015706;957.4877440569297;705.7741522712734;707.2785758526275;709.0746575718686;710.2471380336859;711.1714852197184;14468.855311446856;14486;14585;14586.270686465741;14615.196164210964;13031.348432578334;13290.401931913088;13355.399007044707;13453.39459724305;13657.931710341483;10148.594056237742;10961.56153753849;12091.939540302243;12369.443375048144;12472.376381180904;3950.8024598770235;3965.94051089231;4009.8596549120934;4014.3777714454304;4080.1227736036894;51558;51571.22643160356;51727.74136129295;51962.740186298826;52162.73918630421;11550.768984620428;11551.133664974992;11564.306141631529;11638.88361116378;11818.34999075042;20197.697034544493;20199.899000505196;20264.696029559567;20311.187552497733;20335.898320508302;7692.807679808049;7704.6532906019365;7754.612269386508;7841.333486653584;8027.719029833927;4741.715497070187;4757.714537127784;4767;4769.117713223065;4776.355192049098;3408.1309266136977;3455.740819438552;3460.1522626956557;3461.6019157796673;3533.9293214136087;623.8378021714296;632.2728861808956;639.68015992004;641.582971068809;641.9422251997249;646.5344951634816;684.1243208692881;698.1656919980676;714.9249328820399;718.7017387784011;8928.73213803587;9311.301652376098;9384.390014649027;9415.764605884908;9548.856767148498;512.6360284198187;597.6006334566719;632.949364050884;729.9927000729924;740.7925780781283;4327.437433133736;4347.413099231627;4385.342198670225;4441.378207051015;4471.083427897273;57647;58392.124118138265;58834.41165588375;58954;58966.41033589609;51866.22200666993;53069.73465132727;53813.192802108;54076;54117.72941135348;45858.312125318145;46491.76754116208;46868.5313146871;48155.5184448158;48320.51679483231;8621.137886211329;8647.524386158822;8709.869351959853;8869.201771840308;8955.149260820212;37483;38173.236535269694;38256.23487530289;38479.23041539209;39480.60519394769;44687;45716.314255285535;46129.30806037845;46837;47118.76440617775;11449.016100178718;11628.244164129304;11691.766164676828;11794.882051179378;11891;13188.868111319147;13226.07417480767;13378.197308161542;13757.862421375658;14047.789283160966;11519.94240028828;11675.766484670428;11756.23584467007;12022.699432514257;12232.204906681038;12104.636860894187;12223.93888030554;12541.811872821732;12609.621711348675;12855.807162892752;10429.53067111997;10663;10900.618478353219;12461.127721059438;12515.37423128858;7972;9930.354526956015;10502.894971050191;10576.524056417633;10787.352758834495;10006.69979900604;10277.075063244343;10433.895661043292;10528.842067369149;10634.946825265824 17:08:44 INFO - 2016-03-04 17:08:44,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:08:44 INFO - 2016-03-04 17:08:44,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:08:44 INFO - 2016-03-04 17:08:44,740 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,817 17:08:44 INFO - 2016-03-04 17:08:44,740 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1457140124728__endTimestamp 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5639.37 Median:5820.04 stddev:630.90 (10.8%) stddev-sans-first:605.38 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: Values: 3292.6 3384.0 3414.6 3415.1 3434.2 5667.8 5670.8 5673.1 5708.3 5719.2 5695.6 5733.5 5748.2 5749.0 5765.6 4920.8 5164.9 5204.1 5257.4 5282.1 5103.8 5150.0 5194.9 5232.2 5233.9 5132.8 5145.6 5146.6 5151.2 5152.2 4990.7 5123.3 5137.0 5229.5 5267.9 4984.7 5051.9 5074.4 5079.5 5087.4 5443.9 5469.1 5479.5 5483.7 5485.6 6086.8 6149.1 6149.5 6155.9 6156.9 5911.3 5968.7 5978.0 5981.3 6056.6 5654.2 5665.6 5666.6 5670.4 5674.3 6051.3 6206.8 6250.6 6251.9 6258.0 5884.6 6031.8 6049.4 6100.8 6112.5 6077.9 6080.3 6081.7 6101.3 6116.5 5636.4 5824.5 6082.7 6088.7 6095.3 5991.6 6032.0 6048.7 6083.6 6123.6 4660.2 4676.6 4683.4 4709.5 4747.3 4069.9 4098.3 4159.9 4210.0 4229.8 5666.0 5708.9 5790.7 5816.9 5820.0 6156.1 6217.2 6217.7 6221.3 6223.0 5532.1 5672.3 5683.9 5756.3 5808.9 5266.6 5352.7 5362.7 5364.3 5376.5 6279.3 6295.1 6296.8 6303.6 6313.8 5997.8 6105.4 6135.8 6223.8 6245.6 6236.2 6269.3 6297.7 6307.8 6311.3 5721.5 6111.7 6123.2 6127.5 6131.2 6029.8 6046.5 6060.2 6080.6 6099.9 5880.5 5880.9 5885.9 5891.3 5998.4 5799.5 5882.2 5885.9 5886.3 5900.6 5739.6 5818.1 5833.9 5845.5 5863.4 5854.9 5908.1 5913.7 5934.7 5936.9 5744.1 5800.8 5814.2 5825.0 5841.0 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54765.20 Median:40072.90 stddev:95584.83 (238.5%) stddev-sans-first:95766.53 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: Values: 625.0 654.0 669.2 679.1 712.5 30733.8 31355.8 31357.8 31429.0 31458.7 34457.7 41361.6 42441.0 42481.0 42494.6 9263.4 9384.0 9404.5 9412.1 9416.2 8364.3 8556.4 9153.5 9268.1 9284.5 8297.8 8377.5 8394.7 8405.7 11142.2 10890.5 11006.0 11015.7 11019.6 11029.2 10820.4 10902.6 10953.0 10959.8 10970.8 43552.6 43757.3 43926.3 43933.8 43979.0 3545.4 3569.0 3864.6 4075.4 4220.4 33775.5 34073.8 34268.8 34756.8 34947.7 3607.5 3834.5 3842.9 4375.5 4464.5 301012.0 301035.0 302052.0 302599.0 304811.0 60083.7 61334.0 72223.0 74831.0 75127.0 68773.0 68789.3 68925.7 69029.0 69146.3 16769.9 16778.8 16897.6 16943.4 16944.2 12618.1 12792.7 12809.7 12860.6 12865.1 22759.7 23129.4 23198.5 23261.7 23291.5 8440.3 8730.3 8763.2 8839.5 8846.1 1033.9 1127.8 1208.8 1210.0 1221.0 30459.4 31069.2 31115.4 31272.2 31476.2 1087.2 1132.3 1152.6 1155.2 1199.0 14887.6 16366.8 17184.6 17895.7 18437.2 443258.0 447432.0 448770.0 449585.0 449791.0 60749.7 61026.0 61268.0 61374.0 61388.0 1358.3 1360.2 1463.9 1488.5 1519.7 30707.5 30764.0 31000.5 31539.5 32087.0 53974.2 55131.7 55209.0 55323.2 55398.0 322816.0 323480.0 323680.0 324492.0 324605.0 47107.3 47604.5 47954.3 48375.8 48546.3 50385.0 50414.0 50437.7 50484.7 50867.0 39605.8 40882.6 41378.4 41587.8 42741.6 42057.8 42098.6 42102.8 43222.0 43288.1 41234.8 41770.8 41788.6 42657.0 42795.8 36527.5 39450.8 40540.0 40684.0 41606.6 26850.2 27262.3 27458.2 27765.9 28182.7 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,741 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34629.24 Median:10746.60 stddev:117872.09 (1096.8%) stddev-sans-first:118174.68 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: Values: 369.8 375.4 377.7 383.6 384.7 14672.4 17015.8 17173.3 18570.7 18622.4 11874.8 12187.8 12189.6 19239.0 19545.1 4026.8 5048.0 5155.7 5156.4 5157.1 4108.5 5596.6 5738.3 5751.4 5752.7 5581.7 5678.8 5700.5 5703.0 5714.4 5635.4 5670.8 5684.6 5697.0 5699.7 5358.8 5466.9 5480.9 5492.3 5568.4 14148.5 14272.0 14281.6 18861.4 21931.6 2135.7 2219.8 2285.0 2430.2 2461.7 10457.7 12012.8 12818.4 14279.3 14412.1 1854.8 1911.7 1934.4 1940.0 1948.1 66239.0 66790.3 67324.0 68226.3 68883.0 10584.9 10923.2 11083.4 11106.8 11137.8 14491.1 14731.8 14748.3 14754.9 14771.7 7882.6 7901.1 7944.2 7987.8 8013.3 7680.7 7691.8 7725.3 7726.6 7812.6 3987.2 4604.2 4678.5 4690.2 4714.9 1730.8 1766.4 1799.6 1832.2 1859.3 987.1 989.5 1008.2 1018.7 1065.0 14067.6 16669.7 16797.7 17117.8 17262.7 952.5 966.3 1011.6 1059.6 1097.7 9465.7 9596.8 9613.8 9689.6 9708.2 664160.0 722404.0 723762.0 741224.0 752611.0 87995.6 89065.6 90743.0 91766.5 94397.5 1227.9 1236.3 1244.9 1245.5 1248.7 15430.4 15627.8 15640.2 15656.2 15781.8 20909.9 34896.7 35309.6 36721.8 36964.6 47849.8 48429.8 49105.8 49482.0 49805.8 10386.3 10433.7 10435.4 10646.6 10671.7 17778.6 17997.4 18182.3 18309.0 18714.8 15552.0 15764.7 16126.2 16148.0 16151.7 15437.3 15785.2 15868.0 16084.1 16306.7 12241.6 12612.7 15218.8 15397.2 15580.8 9906.8 9907.0 9918.0 10031.8 10177.4 11945.5 15339.3 15417.6 15605.8 16064.1 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5538.68 Median:6683.83 stddev:2816.66 (42.1%) stddev-sans-first:2808.51 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: Values: 1537.2 1538.8 1732.7 1801.8 1836.4 7272.1 7427.4 7449.8 7450.5 7457.6 6990.8 7097.3 7498.7 7679.2 7785.2 2359.0 2374.1 2395.5 2397.5 2400.1 2081.9 2354.1 2383.4 2402.0 2403.4 2137.6 2261.2 2353.1 2353.5 2353.9 2289.9 2291.1 2297.6 2340.4 2342.1 2334.2 2336.3 2360.0 2369.4 2377.0 7764.3 7848.9 7851.0 7858.4 7861.4 4779.6 4891.4 4894.9 4896.0 4901.4 3072.8 3075.7 3086.0 3108.4 3151.1 996.4 1013.7 1018.1 1054.2 1054.5 10685.5 10809.0 10840.7 10841.7 10848.7 4172.9 4188.8 4253.1 4258.8 4270.5 8684.7 8688.1 8699.4 8704.6 8708.6 4774.5 4798.5 4807.7 4811.2 4818.1 4460.3 4464.6 4485.7 4495.3 4495.3 3535.5 3578.7 3579.5 3602.8 3608.1 1041.8 1046.3 1096.1 1100.2 1189.7 1181.0 1219.0 1220.9 1492.4 1510.7 7406.9 7526.5 7528.1 7539.7 7581.5 1211.0 1211.7 1223.5 1226.1 1243.8 6055.0 6103.9 6147.0 6162.0 6165.4 9229.9 9433.0 9503.1 9515.6 9532.9 9324.1 9378.8 9410.5 9424.6 9439.1 7132.8 7315.8 7331.5 7333.1 7351.6 7449.4 7524.1 7536.6 7580.0 7581.7 8426.7 8442.1 8533.4 8588.2 8598.2 8572.2 8639.3 8744.6 8747.1 8770.6 7110.1 7171.5 7173.5 7191.4 7192.9 7356.4 7373.7 7417.4 7419.6 7565.0 6512.7 7169.7 7174.4 7204.9 7303.2 6627.6 7022.5 7146.7 7220.7 7276.7 7249.3 7269.4 7289.8 7294.3 7294.5 6796.7 6822.0 6835.1 6846.0 6854.5 6740.1 6768.1 6785.6 6795.5 6817.9 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,743 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5424.78 Median:6169.77 stddev:1614.03 (26.2%) stddev-sans-first:1573.02 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: Values: 352.8 356.7 358.7 359.4 363.7 6016.7 6121.6 6125.6 6141.8 6195.1 5828.4 5912.2 5978.5 6053.2 6063.4 4703.7 4726.5 4743.7 4746.3 4750.5 4722.0 4726.4 4735.3 4735.7 4735.8 4487.1 4570.2 4594.8 4654.6 4682.6 4659.0 4668.7 4673.1 4674.7 4678.2 4147.0 4150.1 4152.6 4155.7 4157.2 5732.8 5794.2 5806.9 5811.7 5812.4 5486.8 5497.0 5503.3 5504.0 5504.7 6379.9 6399.9 6413.9 6418.2 6421.6 4628.7 4630.9 4633.6 4633.7 4637.5 6529.9 6655.6 6666.2 6692.9 6705.3 4604.4 4640.7 4642.5 4646.8 4647.2 4695.5 4699.5 4701.4 4703.7 4704.8 5404.7 5408.9 5412.8 5413.5 5422.1 6342.3 6461.7 6464.5 6469.5 6480.4 1624.9 1633.3 1642.0 1645.0 1647.9 1089.8 1104.3 1107.3 1123.4 1131.9 6275.9 6286.5 6297.9 6298.3 6299.3 6673.2 6679.8 6690.1 6691.0 6698.3 6085.1 6144.4 6252.6 6264.1 6336.2 3580.9 3607.7 3612.3 3613.6 3618.4 6798.7 6807.8 6818.9 6819.8 6823.2 6674.8 6842.2 6845.2 6845.5 6849.3 6808.8 6820.4 6820.7 6823.3 6823.5 6577.3 6674.7 6677.2 6690.7 6692.4 6578.1 6605.8 6610.1 6624.0 6627.6 6790.9 6794.1 6808.8 6817.9 6822.4 4669.1 4669.6 4671.9 4673.9 4677.0 6606.6 6700.8 6733.9 6735.5 6739.2 6512.3 6520.4 6534.4 6540.8 6547.7 6417.7 6518.7 6527.1 6532.4 6535.8 6364.7 6383.4 6398.3 6425.0 6426.8 6484.7 6532.2 6535.3 6548.1 6557.4 6222.3 6393.3 6404.1 6405.9 6416.5 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14719.00 Median:45993.81 stddev:16573.42 (36.0%) stddev-sans-first:16586.87 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: Values: 783.1 822.3 847.6 950.2 958.4 14878.4 15077.2 16961.0 17216.9 17368.5 15905.6 15938.9 15987.3 16021.6 16023.2 753.5 760.7 761.6 908.5 927.6 750.4 900.5 918.9 920.0 920.6 941.2 962.0 963.2 964.6 965.1 782.8 791.3 946.5 947.6 957.5 705.8 707.3 709.1 710.2 711.2 14468.9 14486.0 14585.0 14586.3 14615.2 13031.3 13290.4 13355.4 13453.4 13657.9 10148.6 10961.6 12091.9 12369.4 12472.4 3950.8 3965.9 4009.9 4014.4 4080.1 51558.0 51571.2 51727.7 51962.7 52162.7 11550.8 11551.1 11564.3 11638.9 11818.3 20197.7 20199.9 20264.7 20311.2 20335.9 7692.8 7704.7 7754.6 7841.3 8027.7 4741.7 4757.7 4767.0 4769.1 4776.4 3408.1 3455.7 3460.2 3461.6 3533.9 623.8 632.3 639.7 641.6 641.9 646.5 684.1 698.2 714.9 718.7 8928.7 9311.3 9384.4 9415.8 9548.9 512.6 597.6 632.9 730.0 740.8 4327.4 4347.4 4385.3 4441.4 4471.1 57647.0 58392.1 58834.4 58954.0 58966.4 51866.2 53069.7 53813.2 54076.0 54117.7 45858.3 46491.8 46868.5 48155.5 48320.5 8621.1 8647.5 8709.9 8869.2 8955.1 37483.0 38173.2 38256.2 38479.2 39480.6 44687.0 45716.3 46129.3 46837.0 47118.8 11449.0 11628.2 11691.8 11794.9 11891.0 13188.9 13226.1 13378.2 13757.9 14047.8 11519.9 11675.8 11756.2 12022.7 12232.2 12104.6 12223.9 12541.8 12609.6 12855.8 10429.5 10663.0 10900.6 12461.1 12515.4 7972.0 9930.4 10502.9 10576.5 10787.4 10006.7 10277.1 10433.9 10528.8 10634.9 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:08:44 INFO - 2016-03-04 17:08:44,745 DEBUG : BROWSER_OUTPUT: 17:08:45 INFO - 2016-03-04 17:08:45,288 INFO : Browser exited with error code: 0 17:08:45 INFO - 2016-03-04 17:08:45,308 INFO : Completed test dromaeo_css (00:18:30) 17:08:45 INFO - 2016-03-04 17:08:45,308 INFO : Starting test kraken 17:08:45 INFO - 2016-03-04 17:08:45,308 DEBUG : operating with platform_type : linux_ 17:08:45 INFO - 2016-03-04 17:08:45,309 INFO : Initialising browser for kraken test... 17:08:45 INFO - 2016-03-04 17:08:45,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbf_t2z/profile http://localhost:47768/getInfo.html 17:08:49 INFO - 2016-03-04 17:08:49,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:08:49 INFO - 2016-03-04 17:08:49,092 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:08:49 INFO - 2016-03-04 17:08:49,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:08:49 INFO - 2016-03-04 17:08:49,092 DEBUG : BROWSER_OUTPUT: __metrics 17:08:49 INFO - 2016-03-04 17:08:49,274 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] 17:08:50 INFO - 2016-03-04 17:08:50,483 INFO : Browser initialized. 17:08:50 INFO - 2016-03-04 17:08:50,484 INFO : Running cycle 1/1 for kraken test... 17:08:50 INFO - 2016-03-04 17:08:50,484 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbf_t2z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:09:02 INFO - 2016-03-04 17:09:02,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 131944448 17:09:02 INFO - 2016-03-04 17:09:02,163 DEBUG : BROWSER_OUTPUT: 17:09:04 INFO - 2016-03-04 17:09:04,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47768/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:05 INFO - 2016-03-04 17:09:05,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 165613568 17:09:05 INFO - 2016-03-04 17:09:05,194 DEBUG : BROWSER_OUTPUT: 17:09:07 INFO - 2016-03-04 17:09:07,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47768/tests/kraken/driver.html?testName=audio-dft) 17:09:08 INFO - 2016-03-04 17:09:08,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 162979840 17:09:08 INFO - 2016-03-04 17:09:08,338 DEBUG : BROWSER_OUTPUT: 17:09:11 INFO - 2016-03-04 17:09:11,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47768/tests/kraken/driver.html?testName=audio-fft) 17:09:11 INFO - 2016-03-04 17:09:11,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 162402304 17:09:11 INFO - 2016-03-04 17:09:11,684 DEBUG : BROWSER_OUTPUT: 17:09:13 INFO - 2016-03-04 17:09:13,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47768/tests/kraken/driver.html?testName=audio-oscillator) 17:09:14 INFO - 2016-03-04 17:09:14,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 160149504 17:09:14 INFO - 2016-03-04 17:09:14,215 DEBUG : BROWSER_OUTPUT: 17:09:16 INFO - 2016-03-04 17:09:16,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:16 INFO - 2016-03-04 17:09:16,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 158670848 17:09:16 INFO - 2016-03-04 17:09:16,935 DEBUG : BROWSER_OUTPUT: 17:09:19 INFO - 2016-03-04 17:09:19,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47768/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:20 INFO - 2016-03-04 17:09:20,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 159645696 17:09:20 INFO - 2016-03-04 17:09:20,342 DEBUG : BROWSER_OUTPUT: 17:09:23 INFO - 2016-03-04 17:09:23,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47768/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:24 INFO - 2016-03-04 17:09:24,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 159535104 17:09:24 INFO - 2016-03-04 17:09:24,255 DEBUG : BROWSER_OUTPUT: 17:09:26 INFO - 2016-03-04 17:09:26,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47768/tests/kraken/driver.html?testName=json-parse-financial) 17:09:27 INFO - 2016-03-04 17:09:27,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 161255424 17:09:27 INFO - 2016-03-04 17:09:27,540 DEBUG : BROWSER_OUTPUT: 17:09:29 INFO - 2016-03-04 17:09:29,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:29 INFO - 2016-03-04 17:09:29,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 168026112 17:09:29 INFO - 2016-03-04 17:09:29,642 DEBUG : BROWSER_OUTPUT: 17:09:31 INFO - 2016-03-04 17:09:31,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:31 INFO - 2016-03-04 17:09:31,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 164126720 17:09:31 INFO - 2016-03-04 17:09:31,978 DEBUG : BROWSER_OUTPUT: 17:09:33 INFO - 2016-03-04 17:09:33,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:34 INFO - 2016-03-04 17:09:34,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 173604864 17:09:34 INFO - 2016-03-04 17:09:34,532 DEBUG : BROWSER_OUTPUT: 17:09:36 INFO - 2016-03-04 17:09:36,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:37 INFO - 2016-03-04 17:09:37,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 178200576 17:09:37 INFO - 2016-03-04 17:09:37,461 DEBUG : BROWSER_OUTPUT: 17:09:39 INFO - 2016-03-04 17:09:39,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:40 INFO - 2016-03-04 17:09:40,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 176041984 17:09:40 INFO - 2016-03-04 17:09:40,505 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47768/tests/kraken/driver.html?testName=ai-astar) 17:09:42 INFO - 2016-03-04 17:09:42,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 234663936 17:09:42 INFO - 2016-03-04 17:09:42,399 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,401 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:09:42 INFO - 2016-03-04 17:09:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:09:42 INFO - 2016-03-04 17:09:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:09:42 INFO - 2016-03-04 17:09:42,402 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:09:42 INFO - 2016-03-04 17:09:42,402 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;109;110;110;100;110;110;111 17:09:42 INFO - 2016-03-04 17:09:42,402 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;144;160;134;152;143;122;160;121 17:09:42 INFO - 2016-03-04 17:09:42,402 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;163;161;159;159;160;162;161;160 17:09:42 INFO - 2016-03-04 17:09:42,402 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;73;72;149;70;70;70;72;154;72 17:09:42 INFO - 2016-03-04 17:09:42,403 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;135;92;93;92;135;92;92;140 17:09:42 INFO - 2016-03-04 17:09:42,403 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;108;109;110;110;109 17:09:42 INFO - 2016-03-04 17:09:42,403 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;147;146;145;146;145;146;145;146 17:09:42 INFO - 2016-03-04 17:09:42,404 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 17:09:42 INFO - 2016-03-04 17:09:42,404 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;57;57;58;58;57;55;56 17:09:42 INFO - 2016-03-04 17:09:42,404 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;66;65;65;65;64;64;65;65 17:09:42 INFO - 2016-03-04 17:09:42,404 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;77;77;83;77;79;78;80;77 17:09:42 INFO - 2016-03-04 17:09:42,405 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;117;119;117;110;127;122;120;113;114 17:09:42 INFO - 2016-03-04 17:09:42,405 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;141;144;142;152;133;135;141;141;140 17:09:42 INFO - 2016-03-04 17:09:42,405 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;66;64;63;64;64;65;64;65 17:09:42 INFO - 2016-03-04 17:09:42,406 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:09:42 INFO - 2016-03-04 17:09:42,406 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:09:42 INFO - 2016-03-04 17:09:42,406 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 17:09:42 INFO - 2016-03-04 17:09:42,406 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:09:42 INFO - 2016-03-04 17:09:42,407 DEBUG : BROWSER_OUTPUT: __startTimestamp1457140182400__endTimestamp 17:09:42 INFO - 2016-03-04 17:09:42,407 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,408 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:09:42 INFO - 2016-03-04 17:09:42,409 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:09:42 INFO - 2016-03-04 17:09:42,409 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,409 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.49 (3.2%) stddev-sans-first:3.70 17:09:42 INFO - 2016-03-04 17:09:42,409 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 109.0 110.0 110.0 100.0 110.0 110.0 111.0 17:09:42 INFO - 2016-03-04 17:09:42,410 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,410 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.90 Median:146.50 stddev:14.98 (10.2%) stddev-sans-first:15.60 17:09:42 INFO - 2016-03-04 17:09:42,410 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 144.0 160.0 134.0 152.0 143.0 122.0 160.0 121.0 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.33 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 163.0 161.0 159.0 159.0 160.0 162.0 161.0 160.0 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.20 Median:71.00 stddev:33.93 (47.8%) stddev-sans-first:35.41 17:09:42 INFO - 2016-03-04 17:09:42,411 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 72.0 149.0 70.0 70.0 70.0 72.0 154.0 72.0 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:21.48 (23.4%) stddev-sans-first:22.22 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 135.0 92.0 93.0 92.0 135.0 92.0 92.0 140.0 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 108.0 109.0 110.0 110.0 109.0 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,412 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 147.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:0.99 (1.7%) stddev-sans-first:1.00 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 57.0 57.0 58.0 58.0 57.0 55.0 56.0 17:09:42 INFO - 2016-03-04 17:09:42,413 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 66.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:2.08 (2.7%) stddev-sans-first:2.06 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 77.0 77.0 83.0 77.0 79.0 78.0 80.0 77.0 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.00 stddev:4.81 (4.1%) stddev-sans-first:5.10 17:09:42 INFO - 2016-03-04 17:09:42,414 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 119.0 117.0 110.0 127.0 122.0 120.0 113.0 114.0 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:141.00 stddev:5.08 (3.6%) stddev-sans-first:5.39 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 144.0 142.0 152.0 133.0 135.0 141.0 141.0 140.0 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 66.0 64.0 63.0 64.0 64.0 65.0 64.0 65.0 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:09:42 INFO - 2016-03-04 17:09:42,415 DEBUG : BROWSER_OUTPUT: 17:09:43 INFO - 2016-03-04 17:09:43,099 INFO : Browser exited with error code: 0 17:09:43 INFO - 2016-03-04 17:09:43,148 INFO : Completed test kraken (00:00:57) 17:09:43 INFO - 2016-03-04 17:09:43,148 INFO : Starting test v8_7 17:09:43 INFO - 2016-03-04 17:09:43,148 DEBUG : operating with platform_type : linux_ 17:09:43 INFO - 2016-03-04 17:09:43,148 INFO : Initialising browser for v8_7 test... 17:09:43 INFO - 2016-03-04 17:09:43,155 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTho6qe/profile http://localhost:47768/getInfo.html 17:09:47 INFO - 2016-03-04 17:09:47,172 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:09:47 INFO - 2016-03-04 17:09:47,173 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:09:47 INFO - 2016-03-04 17:09:47,173 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:09:47 INFO - 2016-03-04 17:09:47,173 DEBUG : BROWSER_OUTPUT: __metrics 17:09:47 INFO - 2016-03-04 17:09:47,350 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] 17:09:48 INFO - 2016-03-04 17:09:48,239 INFO : Browser initialized. 17:09:48 INFO - 2016-03-04 17:09:48,240 INFO : Running cycle 1/1 for v8_7 test... 17:09:48 INFO - 2016-03-04 17:09:48,240 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTho6qe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:09:59 INFO - 2016-03-04 17:09:59,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 134729728 17:09:59 INFO - 2016-03-04 17:09:59,919 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47768/tests/v8_7/run.html (next: http://localhost:47768/tests/v8_7/run.html) 17:10:21 INFO - 2016-03-04 17:10:21,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 422629376 17:10:21 INFO - 2016-03-04 17:10:21,493 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: |0;Richards;172.41379310344828 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.69038208168644 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 17:10:21 INFO - 2016-03-04 17:10:21,494 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 17:10:21 INFO - 2016-03-04 17:10:21,495 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: |5;Earley;550.9641873278237 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: |6;Boyer;10652.631578947368 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: |7;RegExp;24119.04761904762 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: |8;Splay;524.9343832020998 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: __startTimestamp1457140221493__endTimestamp 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:10:21 INFO - 2016-03-04 17:10:21,496 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.41 Median:172.41 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: Values: 172.4 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.69 Median:164.69 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: Values: 164.7 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: Values: 278.8 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: Values: 5181.3 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,497 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: Values: 943.4 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.96 Median:550.96 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: Values: 551.0 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10652.63 Median:10652.63 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: Values: 10652.6 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24119.05 Median:24119.05 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: Values: 24119.0 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.93 Median:524.93 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: Values: 524.9 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: 17:10:21 INFO - 2016-03-04 17:10:21,498 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 17:10:21 INFO - 2016-03-04 17:10:21,499 DEBUG : BROWSER_OUTPUT: Values: 4822.1 17:10:21 INFO - 2016-03-04 17:10:21,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:10:21 INFO - 2016-03-04 17:10:21,499 DEBUG : BROWSER_OUTPUT: 17:10:22 INFO - 2016-03-04 17:10:22,207 INFO : Browser exited with error code: 0 17:10:22 INFO - 2016-03-04 17:10:22,219 INFO : Completed test v8_7 (00:00:39) 17:10:22 INFO - 2016-03-04 17:10:22,546 INFO : Completed test suite (00:20:07) 17:10:22 INFO - 2016-03-04 17:10:22,546 DEBUG : Working with test: dromaeo_css 17:10:22 INFO - 2016-03-04 17:10:22,546 DEBUG : Generating results file: dromaeo_css 17:10:22 INFO - 2016-03-04 17:10:22,548 DEBUG : Working with test: kraken 17:10:22 INFO - 2016-03-04 17:10:22,548 DEBUG : Generating results file: kraken 17:10:22 INFO - 2016-03-04 17:10:22,548 INFO : javascript benchmark 17:10:22 INFO - 2016-03-04 17:10:22,548 DEBUG : Working with test: v8_7 17:10:22 INFO - 2016-03-04 17:10:22,548 DEBUG : Generating results file: v8_7 17:10:22 INFO - 2016-03-04 17:10:22,549 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:22 INFO - 2016-03-04 17:10:22,686 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 17:10:22 INFO - 2016-03-04 17:10:22,686 DEBUG : process_Request line: dromaeo_css 7422.10 graph.html#tests=[[72,53,35]] 17:10:22 INFO - 2016-03-04 17:10:22,686 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:22 INFO - 2016-03-04 17:10:22,715 DEBUG : process_Request line: kraken 1475.40 graph.html#tests=[[232,53,35]] 17:10:22 INFO - 2016-03-04 17:10:22,715 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:22 INFO - 2016-03-04 17:10:22,810 DEBUG : process_Request line: v8_7 23184.91 graph.html#tests=[[230,53,35]] 17:10:22 INFO - 2016-03-04 17:10:22,812 INFO : javascript benchmark 17:10:22 INFO - 2016-03-04 17:10:22,815 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.5719656444667, 3384.035549868288, 3414.6243913169565, 3415.077928959181, 3434.1929646533063, 5667.773289068443, 5670.829875103754, 5673.092305231164, 5708.257926469553, 5719.170720245567, 5695.629784064044, 5733.541316694665, 5748.19525266462, 5749.0, 5765.625234359763, 4920.753962301888, 5164.948350516484, 5204.063268611649, 5257.421683614799, 5282.102042652739, 5103.846884593449, 5150.0, 5194.870128246786, 5232.16285394337, 5233.86915327118, 5132.794688212467, 5145.6398052136365, 5146.6140039497, 5151.175811870102, 5152.227165925104, 4990.675606085629, 5123.257127716498, 5136.974315128437, 5229.529342359206, 5267.947320526803, 4984.725840078794, 5051.924221136685, 5074.3657042869645, 5079.492050794928, 5087.389513258433, 5443.918341224885, 5469.07025805614, 5479.4520547945285, 5483.698396588186, 5485.61600687952, 6086.756529738849, 6149.108379285023, 6149.477294429978, 6155.907661385083, 6156.938430615682, 5911.320198177222, 5968.70156492178, 5978.0435130379365, 5981.342052374235, 6056.636601803862, 5654.180143879155, 5665.603407761459, 5666.603337766317, 5670.404607516192, 5674.2623458950075, 6051.273847138372, 6206.751729930752, 6250.593711408744, 6251.874962500725, 6258.030005349178, 5884.6469211847425, 6031.788887388921, 6049.3950604939155, 6100.847478813065, 6112.51099912006, 6077.908831367533, 6080.270367555921, 6081.726322315506, 6101.298350689639, 6116.48009919153, 5636.351819540723, 5824.504917082011, 6082.665453400105, 6088.726007329681, 6095.2685677718955, 5991.610545314541, 6031.969840150771, 6048.6673232971725, 6083.6349819011, 6123.571350005546, 4660.207764680013, 4676.602488788491, 4683.414573178353, 4709.481956984729, 4747.264174053027, 4069.89825254371, 4098.282800509958, 4159.91680166395, 4209.957900420956, 4229.788510574521, 5666.036773748473, 5708.857278568069, 5790.71046447676, 5816.883662326814, 5820.039693450618, 6156.107364432221, 6217.160683307786, 6217.658028808369, 6221.3156552779155, 6223.0, 5532.059549876531, 5672.290963629546, 5683.886322273532, 5756.280464941882, 5808.854778630483, 5266.631335806457, 5352.678839269656, 5362.678239305654, 5364.30264065669, 5376.46235376467, 6279.277883043508, 6295.118683384329, 6296.842578935563, 6303.558750887486, 6313.77901773445, 5997.820065398045, 6105.358937311518, 6135.84660383494, 6223.751049957951, 6245.625262484084, 6236.220472440945, 6269.31037585856, 6297.748090076529, 6307.779227727007, 6311.27420346666, 5721.542276617944, 6111.663858487826, 6123.173371594956, 6127.479164271087, 6131.233595800525, 6029.78895738647, 6046.516278697605, 6060.151578778887, 6080.574359794949, 6099.9390006099375, 5880.470757631833, 5880.911786323294, 5885.94114058871, 5891.293044834647, 5998.430149135826, 5799.507041901317, 5882.176495290577, 5885.911711324419, 5886.323072846678, 5900.586958912835, 5739.598228123991, 5818.127280907897, 5833.941660583339, 5845.532357411482, 5863.442972917566, 5854.94145058561, 5908.113782932594, 5913.733881975408, 5934.673592952429, 5936.851578710567, 5744.080947048452, 5800.796972105956, 5814.215080964185, 5825.0388685866355, 5840.970795145997], "unit": "ms", "name": "dojo.html", "value": 5598.274672707322}, {"lowerIsBetter": false, "replicates": [624.9500039996801, 653.9803805885825, 669.2237005074113, 679.1307126877597, 712.5119293284104, 30733.84633076837, 31355.843220783863, 31357.843210783944, 31429.0, 31458.68541314586, 34457.65542344576, 41361.58638413615, 42441.0, 42481.0, 42494.57505424945, 9263.444193348403, 9383.953080234623, 9404.52977351133, 9412.058794120567, 9416.199623032051, 8364.289035431995, 8556.358273129541, 9153.542322883863, 9268.119528644802, 9284.489353085577, 8297.792555186108, 8377.49735015898, 8394.706185283516, 8405.747827565152, 11142.220044596881, 10890.529778479922, 11006.0, 11015.724606884813, 11019.614313499029, 11029.227954043221, 10820.350778953289, 10902.563897444094, 10953.0, 10959.83560246597, 10970.835437468444, 43552.56447435517, 43757.34363984511, 43926.34110488345, 43933.78033109846, 43979.0, 3545.4150065239205, 3569.0, 3864.555576108727, 4075.3886916962397, 4220.36694495825, 33775.493367599505, 34073.829630851935, 34268.82865585681, 34756.82621586901, 34947.650523494696, 3607.512985746917, 3834.482344883461, 3842.9423558646645, 4375.453068366454, 4464.486584042844, 301012.0, 301035.0, 302052.0, 302598.9999999978, 304811.0, 60083.699581501816, 61334.0, 72223.0, 74831.0, 75127.0, 68773.0, 68789.3121068793, 68925.65537172282, 69029.0, 69146.30853691399, 16769.916150419413, 16778.832211677727, 16897.57756056084, 16943.406980755615, 16944.15279236058, 12618.116731828868, 12792.74414511723, 12809.679758005937, 12860.614181574567, 12865.099443039084, 22759.658605120938, 23129.421764456023, 23198.53602927932, 23261.651075233884, 23291.534169316517, 8440.324774018063, 8730.257928076184, 8763.167499087576, 8839.513826739463, 8846.115388461103, 1033.8759348878182, 1127.8495934147124, 1208.8241165901518, 1209.9637010889687, 1220.993895030519, 30459.390812183632, 31069.203771660657, 31115.377692446025, 31272.21819454532, 31476.213094672818, 1087.1954753482366, 1132.3036332655358, 1152.6426807689643, 1155.2202263472122, 1199.016806218892, 14887.553373398816, 16366.754498682529, 17184.570385740455, 17895.73156402655, 18437.1703273353, 443258.0, 447432.0, 448770.0, 449585.0, 449791.0, 60749.69625151846, 61026.0, 61268.0, 61374.0, 61388.0, 1358.3004752552442, 1360.2246719369864, 1463.8682518573166, 1488.5385530485585, 1519.749241375183, 30707.539386909662, 30764.0, 31000.534991974688, 31539.52690709595, 32087.037388878372, 53974.19038714344, 55131.72434137804, 55209.0, 55323.17015244694, 55398.0, 322816.0, 323480.0, 323680.0, 324492.0, 324605.0, 47107.29339059985, 47604.52395476001, 47954.28068578905, 48375.75812120917, 48546.27180592223, 50385.0, 50414.0, 50437.747811260706, 50484.747576263355, 50867.0, 39605.80197099112, 40882.59117408788, 41378.379324310765, 41587.7920610395, 42741.572584275, 42057.78971105125, 42098.57901420946, 42102.789486052374, 43222.0, 43288.13423731571, 41234.79382603068, 41770.79114604529, 41788.582114179684, 42657.0, 42795.786021069696, 36527.45208821923, 39450.80274598609, 40540.0, 40684.0, 41606.583934161485, 26850.194494165207, 27262.318442039108, 27458.17625471239, 27765.861170694017, 28182.69970909636], "unit": "ms", "name": "ext.html", "value": 20896.952825719203}, {"lowerIsBetter": false, "replicates": [369.79476390603213, 375.36563208178194, 377.6525596451265, 383.6125513231637, 384.6941681363314, 14672.413103475848, 17015.82984170158, 17173.313067477287, 18570.721439178407, 18622.441326760203, 11874.762504749922, 12187.756244875098, 12189.634310970663, 19239.0, 19545.12046957887, 4026.838926442939, 5048.040872234273, 5155.664881782672, 5156.432792392834, 5157.097507936096, 4108.465899433069, 5596.636218645775, 5738.340090889559, 5751.396103409144, 5752.741126649311, 5581.7209139543065, 5678.801241956532, 5700.515456186229, 5702.971485142569, 5714.3999880012625, 5635.380108188096, 5670.829875103754, 5684.63049901755, 5696.971515142439, 5699.658020518782, 5358.839234822962, 5466.890662186734, 5480.945190548084, 5492.340919089695, 5568.415316391802, 14148.504802331869, 14272.0, 14281.642958926006, 18861.434156975312, 21931.561368772695, 2135.743710754704, 2219.8113160381386, 2285.0, 2430.1858877276136, 2461.729209786922, 10457.68626941193, 12012.759744805055, 12818.423170957329, 14279.286035698173, 14412.13527188372, 1854.8423384012376, 1911.665458544749, 1934.3906669399094, 1939.9903000485049, 1948.074664534349, 66239.0, 66790.3320966789, 67323.9999999995, 68226.317736823, 68883.0, 10584.947075264728, 10923.180761442924, 11083.445827708581, 11106.833397499044, 11137.777244455228, 14491.130532168103, 14731.779023314659, 14748.262586870613, 14754.852451475563, 14771.704565908622, 7882.605869706492, 7901.051873775069, 7944.165862584461, 7987.760367188994, 8013.278804907586, 7680.731174408869, 7691.769246922601, 7725.343345815669, 7726.575038372831, 7812.648430820626, 3987.182627561343, 4604.217283061887, 4678.508756580578, 4690.226112691368, 4714.858554243378, 1730.7749992500894, 1766.355280322673, 1799.5770993816443, 1832.193834712722, 1859.312054539829, 987.1066684650403, 989.4904124375952, 1008.2085562833288, 1018.7198520406947, 1064.9680509584725, 14067.577972660836, 16669.749953750703, 16797.748033779502, 17117.828821711624, 17262.65474690499, 952.4761381240429, 966.2752935298527, 1011.6155860772859, 1059.5814653211937, 1097.665212110298, 9465.66870159541, 9596.808063838684, 9613.807723845484, 9689.563969621384, 9708.223342132613, 664160.0, 722404.0, 723762.0, 741224.0, 752611.0, 87995.56002220076, 89065.55467222622, 90742.99999999868, 91766.54116729507, 94397.52801236087, 1227.9324637144864, 1236.2891337480805, 1244.9128561000643, 1245.5453759377942, 1248.6815861955324, 15430.382784688487, 15627.765583516484, 15640.217989100272, 15656.21718914027, 15781.842181578037, 20909.89545052265, 34896.65103348934, 35309.646903530636, 36721.81639091788, 36964.63035369612, 47849.76075119602, 48429.76774844308, 49105.75447122742, 49482.0, 49805.75097124491, 10386.272960892666, 10433.739156521147, 10435.37387756737, 10646.574137034431, 10671.679849604525, 17778.5555361117, 17997.370092046716, 18182.27270909149, 18309.0, 18714.81285187185, 15552.0, 15764.669582916147, 16126.193690315671, 16148.0, 16151.67696646037, 15437.305321260346, 15785.210739463211, 15868.0, 16084.115373654093, 16306.67386652284, 12241.571544995883, 12612.684682883002, 15218.771718424012, 15397.230138493254, 15580.766288505909, 9906.801863962824, 9907.0, 9917.958614345389, 10031.799364012533, 10177.389356638625, 11945.462454189756, 15339.309731062353, 15417.614559635651, 15605.843941560894, 16064.116473594064], "unit": "ms", "name": "jquery.html", "value": 9323.644595077476}, {"lowerIsBetter": false, "replicates": [1537.2467490929441, 1538.776877352784, 1732.722764357703, 1801.7657704498417, 1836.384811088285, 7272.0546328977225, 7427.405807535398, 7449.776506704808, 7450.478466507347, 7457.55254684718, 6990.755323563676, 7097.2902709729005, 7498.737544185941, 7679.232076792332, 7785.221477852226, 2359.032796553418, 2374.097842819726, 2395.4849707312924, 2397.4845408237225, 2400.0759707512557, 2081.9375418737463, 2354.117206047732, 2383.392234980078, 2401.987990060047, 2403.4111642647576, 2137.6366017777013, 2261.231181398324, 2353.0705371378294, 2353.5410594933996, 2353.894074766631, 2289.8511596746243, 2291.0721157931066, 2297.632378819389, 2340.403197184707, 2342.121704360865, 2334.1830359374253, 2336.33414476875, 2359.9646005309933, 2369.3958040699686, 2376.9881150594138, 7764.30121289081, 7848.921510784933, 7850.960745196295, 7858.410619203582, 7861.4103942204565, 4779.617630589544, 4891.413030436335, 4894.877628059327, 4896.0, 4901.436334821506, 3072.846357682107, 3075.6814921090377, 3086.0279012111114, 3108.4404807134706, 3151.07043422191, 996.4170959988415, 1013.7060252526759, 1018.1193267823279, 1054.2304117993908, 1054.520193312041, 10685.519151638195, 10809.0, 10840.67477975662, 10841.674749757442, 10848.67453976374, 4172.853950111731, 4188.769617671057, 4253.085586598834, 4258.8296468140925, 4270.466191726035, 8684.652613895374, 8688.087750786077, 8699.43453675509, 8704.608292626846, 8708.564571771387, 4774.4509381420885, 4798.47216806151, 4807.711537307773, 4811.158047341702, 4818.132736107535, 4460.264056430718, 4464.55354464551, 4485.708428952108, 4495.280755079171, 4495.303227999665, 3535.487354333607, 3578.6958108561066, 3579.46308053794, 3602.8378722957004, 3608.0979755061235, 1041.8385150301565, 1046.3042077018697, 1096.0792933935372, 1100.2243418390017, 1189.6966273600176, 1181.0492553494519, 1218.9878101218874, 1220.8840160184768, 1492.4030387844948, 1510.6903084867577, 7406.925930740624, 7526.5107767994905, 7528.058992625922, 7539.660715267826, 7581.50720203185, 1210.9878901211052, 1211.7455334379704, 1223.5472875036116, 1226.1171956191529, 1243.7823380908305, 6055.0, 6103.908441373383, 6147.0, 6161.969190154021, 6165.445109940127, 9229.861552076723, 9433.0, 9503.144716975366, 9515.57179926905, 9532.857007144898, 9324.067593240621, 9378.765530861647, 9410.482423466776, 9424.575894084783, 9439.103285187895, 7132.750353737594, 7315.780526584211, 7331.486795924234, 7333.1200255969625, 7351.632418379059, 7449.366803821736, 7524.134724506533, 7536.623168841426, 7579.962100189464, 7581.696732130874, 8426.662933482592, 8442.071372148936, 8533.445326053787, 8588.184122508352, 8598.183172598594, 8572.185642363966, 8639.308855291687, 8744.606492707717, 8747.081556436482, 8770.56147192625, 7110.146782386147, 7171.533850299714, 7173.46199035064, 7191.42468602521, 7192.928070719226, 7356.448266379936, 7373.741919032808, 7417.443691723034, 7419.629018549159, 7565.0, 6512.706928188338, 7169.749058783126, 7174.390176834819, 7204.855902882018, 7303.196648368569, 6627.602343859191, 7022.508424410242, 7146.714131434893, 7220.74727384539, 7276.7089316428865, 7249.347558719741, 7269.418446524372, 7289.781306560812, 7294.270572942663, 7294.452916031213, 6796.66016699173, 6822.0, 6835.1114355135505, 6845.965770171118, 6854.520183587101, 6740.056392105012, 6768.08630834831, 6785.626790526371, 6795.524313298021, 6817.93182068173], "unit": "ms", "name": "mootools.html", "value": 4583.09501162565}, {"lowerIsBetter": false, "replicates": [352.807719792713, 356.7342329964177, 358.7381211715448, 359.40159634209044, 363.66361115967726, 6016.669083200422, 6121.571489995702, 6125.63246205228, 6141.8157455276305, 6195.132681424604, 5828.446297601731, 5912.231409916705, 5978.491828194608, 6053.213082299295, 6063.393660633935, 4703.694259873115, 4726.503717109706, 4743.739094349809, 4746.264329029006, 4750.524947505239, 4722.0, 4726.409198850144, 4735.3133795599615, 4735.715857048571, 4735.763211839411, 4487.057717879249, 4570.223062079454, 4594.839180628679, 4654.557817007379, 4682.625389968812, 4658.97670511647, 4668.6731928765, 4673.135469938055, 4674.69614475058, 4678.157931572316, 4147.04617937876, 4150.086980864236, 4152.647025002879, 4155.688323375729, 4157.210130075276, 5732.770689172428, 5794.159846822229, 5806.912896306559, 5811.6803575803315, 5812.418758124196, 5486.753096110685, 5497.0, 5503.3120859892515, 5503.972480137573, 5504.669719816824, 6379.936200638027, 6399.87200255997, 6413.903791443132, 6418.19772528434, 6421.64680942548, 4628.699134556243, 4630.86107416778, 4633.62930965522, 4633.698809577367, 4637.513061128567, 6529.902051469232, 6655.567388119805, 6666.23338316095, 6692.899606505906, 6705.329467053304, 4604.401427814362, 4640.698354607007, 4642.489326174118, 4646.8141274348645, 4647.233206520887, 4695.460022097434, 4699.483056863743, 4701.3653156824075, 4703.670743047954, 4704.788284527204, 5404.729763511808, 5408.945910540844, 5412.810551630752, 5413.512783849473, 5422.132458806651, 6342.270638876496, 6461.676916154173, 6464.450521705614, 6469.54713170083, 6480.416762491398, 1624.8781341399206, 1633.2813562032668, 1641.958951026234, 1645.0129922046676, 1647.8928869623676, 1089.8310761831929, 1104.3318792130806, 1107.2526044919648, 1123.3821398230941, 1131.9490622921987, 6275.874482510416, 6286.49708023357, 6297.874042519124, 6298.275698294663, 6299.338569450233, 6673.232578253563, 6679.76620818269, 6690.0968369270495, 6690.99635054736, 6698.263191048981, 6085.148079268906, 6144.41628045335, 6252.562320637512, 6264.123022776815, 6336.20797400325, 3580.946285805715, 3607.7294202934886, 3612.3317186320614, 3613.6205698401814, 3618.3848745713294, 6798.7280508779095, 6807.842666746665, 6818.931810681929, 6819.761308354283, 6823.215330236987, 6674.83312917181, 6842.213145488233, 6845.212800528003, 6845.53560718141, 6849.349311815469, 6808.829779255559, 6820.35206655367, 6820.727170913108, 6823.317668233137, 6823.522353435212, 6577.276499585138, 6674.733010679713, 6677.165354330708, 6690.732370705117, 6692.397684208445, 6578.144841170617, 6605.768798092044, 6610.140681711347, 6623.966880165761, 6627.6354800484505, 6790.898136527857, 6794.082798822294, 6808.82977925536, 6817.93182068173, 6822.351876571718, 4669.066186762593, 4669.649776266726, 4671.85984420468, 4673.883152921204, 4676.976615116902, 6606.636634985122, 6700.765473208415, 6733.932660673527, 6735.4611631070375, 6739.157605299338, 6512.3162067982175, 6520.3805638466165, 6534.411902928759, 6540.8364790880605, 6547.70535325902, 6417.711202995783, 6518.73925043012, 6527.05357723137, 6532.379423954717, 6535.803925882231, 6364.681765911779, 6383.425491705769, 6398.328175541687, 6425.036244563166, 6426.807195784134, 6484.708188131451, 6532.150820393318, 6535.2811190768025, 6548.1487406638735, 6557.377049180321, 6222.346653601488, 6393.328700486568, 6404.071409645482, 6405.903911441425, 6416.48668106541], "unit": "ms", "name": "prototype.html", "value": 4903.757630459239}, {"lowerIsBetter": false, "replicates": [783.1307248953664, 822.2846123872232, 847.6058632735777, 950.1780959470059, 958.3531116496365, 14878.404863805436, 15077.170755608437, 16960.999999999985, 17216.913915430407, 17368.47894563165, 15905.602359941007, 15938.920305398457, 15987.280572374242, 16021.599460013505, 16023.198840058008, 753.5403403923602, 760.6691089376139, 761.5506850957934, 908.4821651658557, 927.5501381829807, 750.3996802557959, 900.4642237868491, 918.8805455290803, 920.0201785098849, 920.5535315372039, 941.1952780372785, 961.9807603847919, 963.2246041936238, 964.6382606522554, 965.1072757699101, 782.7690831204808, 791.2680770287461, 946.5172761891416, 947.6067432015706, 957.4877440569297, 705.7741522712734, 707.2785758526275, 709.0746575718686, 710.2471380336859, 711.1714852197184, 14468.855311446856, 14486.0, 14585.0, 14586.270686465741, 14615.196164210964, 13031.348432578334, 13290.401931913088, 13355.399007044707, 13453.39459724305, 13657.931710341483, 10148.594056237742, 10961.56153753849, 12091.939540302243, 12369.443375048144, 12472.376381180904, 3950.8024598770235, 3965.94051089231, 4009.8596549120934, 4014.3777714454304, 4080.1227736036894, 51558.0, 51571.22643160356, 51727.74136129295, 51962.740186298826, 52162.73918630421, 11550.768984620428, 11551.133664974992, 11564.306141631529, 11638.88361116378, 11818.34999075042, 20197.697034544493, 20199.899000505196, 20264.696029559567, 20311.187552497733, 20335.898320508302, 7692.807679808049, 7704.6532906019365, 7754.612269386508, 7841.333486653584, 8027.719029833927, 4741.715497070187, 4757.714537127784, 4767.0, 4769.117713223065, 4776.355192049098, 3408.1309266136977, 3455.740819438552, 3460.1522626956557, 3461.6019157796673, 3533.9293214136087, 623.8378021714296, 632.2728861808956, 639.68015992004, 641.582971068809, 641.9422251997249, 646.5344951634816, 684.1243208692881, 698.1656919980676, 714.9249328820399, 718.7017387784011, 8928.73213803587, 9311.301652376098, 9384.390014649027, 9415.764605884908, 9548.856767148498, 512.6360284198187, 597.6006334566719, 632.949364050884, 729.9927000729924, 740.7925780781283, 4327.437433133736, 4347.413099231627, 4385.342198670225, 4441.378207051015, 4471.083427897273, 57647.0, 58392.124118138265, 58834.41165588375, 58954.0, 58966.41033589609, 51866.22200666993, 53069.73465132727, 53813.192802108, 54076.0, 54117.72941135348, 45858.312125318145, 46491.76754116208, 46868.5313146871, 48155.5184448158, 48320.51679483231, 8621.137886211329, 8647.524386158822, 8709.869351959853, 8869.201771840308, 8955.149260820212, 37483.0, 38173.236535269694, 38256.23487530289, 38479.23041539209, 39480.60519394769, 44687.0, 45716.314255285535, 46129.30806037845, 46837.0, 47118.76440617775, 11449.016100178718, 11628.244164129304, 11691.766164676828, 11794.882051179378, 11891.0, 13188.868111319147, 13226.07417480767, 13378.197308161542, 13757.862421375658, 14047.789283160966, 11519.94240028828, 11675.766484670428, 11756.23584467007, 12022.699432514257, 12232.204906681038, 12104.636860894187, 12223.93888030554, 12541.811872821732, 12609.621711348675, 12855.807162892752, 10429.53067111997, 10663.0, 10900.618478353219, 12461.127721059438, 12515.37423128858, 7972.0, 9930.354526956015, 10502.894971050191, 10576.524056417633, 10787.352758834495, 10006.69979900604, 10277.075063244343, 10433.895661043292, 10528.842067369149, 10634.946825265824], "unit": "ms", "name": "yui.html", "value": 6818.815683302558}], "name": "dromaeo_css", "value": 7422.09925032354}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 109.0, 110.0, 110.0, 100.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 144.0, 160.0, 134.0, 152.0, 143.0, 122.0, 160.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 163.0, 161.0, 159.0, 159.0, 160.0, 162.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 72.0, 149.0, 70.0, 70.0, 70.0, 72.0, 154.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 135.0, 92.0, 93.0, 92.0, 135.0, 92.0, 92.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 108.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 57.0, 57.0, 58.0, 58.0, 57.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 77.0, 77.0, 83.0, 77.0, 79.0, 78.0, 80.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 119.0, 117.0, 110.0, 127.0, 122.0, 120.0, 113.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 144.0, 142.0, 152.0, 133.0, 135.0, 141.0, 141.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1475.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.41379310344828], "unit": "score", "name": "Richards", "value": 204.75160000000005}, {"lowerIsBetter": false, "replicates": [164.69038208168644], "unit": "score", "name": "DeltaBlue", "value": 401.4684960000001}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [550.9641873278237], "unit": "score", "name": "Earley", "value": 1209.6303449999996}, {"lowerIsBetter": false, "replicates": [10652.631578947368], "unit": "score", "name": "Boyer", "value": 62.56322628458496}, {"lowerIsBetter": false, "replicates": [24119.04761904762], "unit": "score", "name": "RegExp", "value": 37.77035538005923}, {"lowerIsBetter": false, "replicates": [524.9343832020998], "unit": "score", "name": "Splay", "value": 155.24035499999994}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23184.907695201866}]} 17:10:22 INFO - RETURN: dromaeo_css: 7422.10 17:10:22 INFO - RETURN: kraken: 1475.40 17:10:22 INFO - RETURN: v8_7: 23184.91 17:10:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23184.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7422.10"}}} 17:10:22 INFO - Return code: 0 17:10:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:22 INFO - # TBPL SUCCESS # 17:10:22 INFO - Running post-action listener: _resource_record_post_action 17:10:22 INFO - Running post-run listener: _resource_record_post_run 17:10:24 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 401408; Write bytes: 499412992; Read time: 380; Write time: 675540 17:10:24 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235651072; Read time: 0; Write time: 419132 17:10:24 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 401408; Write bytes: 263585792; Read time: 380; Write time: 256352 17:10:24 INFO - Running post-run listener: _upload_blobber_files 17:10:24 INFO - Blob upload gear active. 17:10:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:10:24 INFO - Copying logs to upload dir... 17:10:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.902414 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-04 17:10:23.729713) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-03-04 17:10:23.733351) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009879 build_url: 'https://queue.taskcluster.net/v1/task/O42fDJKdQw2_LOY-bCj2Tw/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-03-04 17:10:23.785328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:10:23.785662) ========= 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-1457138962.203498-1760333907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:10:23.834753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 17:10:23.835064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 17:10:23.835344) ========= ========= Total master_lag: 0.38 =========