builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1455098294.52 results: success (0) buildid: 20160209233531 builduid: a4f171d96d0940789733d59b71cf51cf revision: a39ff3e4af74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.519062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.519776) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.520298) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.544619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.544930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.569189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.569545) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.621693) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.622478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.623542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.624305) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 01:58:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-02-10 01:58:14 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.800656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.801445) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016410 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.855883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:14.856628) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a39ff3e4af74 --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 a39ff3e4af74 --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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 01:58:15,032 Setting DEBUG logging. 2016-02-10 01:58:15,032 attempt 1/10 2016-02-10 01:58:15,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a39ff3e4af74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 01:58:15,471 unpacking tar archive at: mozilla-beta-a39ff3e4af74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740339 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:15.615883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:15.616319) ========= echo a39ff3e4af74 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a39ff3e4af74'] 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a39ff3e4af74 program finished with exit code 0 elapsedTime=0.004579 script_repo_revision: 'a39ff3e4af74' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:15.670039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:15.670377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 01:58:15.680936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-10 01:58:15.681401) ========= /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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:58:15 INFO - MultiFileLogger online at 20160210 01:58:15 in /builds/slave/test-pgo 01:58:15 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 01:58:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:58:15 INFO - {'append_to_log': False, 01:58:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:58:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:58:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:58:15 INFO - 'branch': 'Mozilla-Beta', 01:58:15 INFO - 'buildbot_json_path': 'buildprops.json', 01:58:15 INFO - 'config_files': ('talos/linux_config.py',), 01:58:15 INFO - 'default_actions': ('clobber', 01:58:15 INFO - 'read-buildbot-config', 01:58:15 INFO - 'download-and-extract', 01:58:15 INFO - 'populate-webroot', 01:58:15 INFO - 'create-virtualenv', 01:58:15 INFO - 'install', 01:58:15 INFO - 'run-tests'), 01:58:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:58:15 INFO - 'download_minidump_stackwalk': True, 01:58:15 INFO - 'download_symbols': 'ondemand', 01:58:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:58:15 INFO - 'tooltool.py': '/tools/tooltool.py', 01:58:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:58:15 INFO - '/tools/misc-python/virtualenv.py')}, 01:58:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:58:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:58:15 INFO - 'installer_path': 'installer.exe', 01:58:15 INFO - 'log_level': 'info', 01:58:15 INFO - 'log_name': 'talos', 01:58:15 INFO - 'log_to_console': True, 01:58:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:58:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:58:15 INFO - 'opt_config_files': (), 01:58:15 INFO - 'pip_index': False, 01:58:15 INFO - 'sps_profile': False, 01:58:15 INFO - 'sps_profile_interval': 0, 01:58:15 INFO - 'suite': 'dromaeojs', 01:58:15 INFO - 'system_bits': '32', 01:58:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:58:15 INFO - 'title': 'talos-linux64-ix-004', 01:58:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:58:15 INFO - 'use_talos_json': True, 01:58:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:58:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:58:15 INFO - 'work_dir': 'build'} 01:58:15 INFO - ##### 01:58:15 INFO - ##### Running clobber step. 01:58:15 INFO - ##### 01:58:15 INFO - Running pre-action listener: _resource_record_pre_action 01:58:15 INFO - Running main action method: clobber 01:58:15 INFO - rmtree: /builds/slave/test-pgo/build 01:58:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:58:16 INFO - Running post-action listener: _resource_record_post_action 01:58:16 INFO - ##### 01:58:16 INFO - ##### Running read-buildbot-config step. 01:58:16 INFO - ##### 01:58:16 INFO - Running pre-action listener: _resource_record_pre_action 01:58:16 INFO - Running main action method: read_buildbot_config 01:58:16 INFO - Using buildbot properties: 01:58:16 INFO - { 01:58:16 INFO - "properties": { 01:58:16 INFO - "buildnumber": 76, 01:58:16 INFO - "product": "firefox", 01:58:16 INFO - "script_repo_revision": "production", 01:58:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:58:16 INFO - "repository": "", 01:58:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:58:16 INFO - "buildid": "20160209233531", 01:58:16 INFO - "slavename": "talos-linux64-ix-004", 01:58:16 INFO - "pgo_build": "True", 01:58:16 INFO - "basedir": "/builds/slave/test-pgo", 01:58:16 INFO - "project": "", 01:58:16 INFO - "platform": "ubuntu64_hw", 01:58:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:58:16 INFO - "slavebuilddir": "test", 01:58:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:58:16 INFO - "branch": "mozilla-beta", 01:58:16 INFO - "repo_path": "releases/mozilla-beta", 01:58:16 INFO - "stage_platform": "linux64-pgo", 01:58:16 INFO - "builduid": "a4f171d96d0940789733d59b71cf51cf", 01:58:16 INFO - "revision": "a39ff3e4af74" 01:58:16 INFO - }, 01:58:16 INFO - "sourcestamp": { 01:58:16 INFO - "repository": "", 01:58:16 INFO - "hasPatch": false, 01:58:16 INFO - "project": "", 01:58:16 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:58:16 INFO - "changes": [ 01:58:16 INFO - { 01:58:16 INFO - "category": null, 01:58:16 INFO - "files": [ 01:58:16 INFO - { 01:58:16 INFO - "url": null, 01:58:16 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2" 01:58:16 INFO - } 01:58:16 INFO - ], 01:58:16 INFO - "repository": "", 01:58:16 INFO - "rev": "a39ff3e4af74", 01:58:16 INFO - "who": "sendchange", 01:58:16 INFO - "when": 1455098271, 01:58:16 INFO - "number": 7587148, 01:58:16 INFO - "comments": "Bug 1243843 - Pull latest bugfixes from upstream graphite2 (now at e569e28d83491fedb31b9220493f3c07f6ec6d80). r=jdaggett a=abillings", 01:58:16 INFO - "project": "", 01:58:16 INFO - "at": "Wed 10 Feb 2016 01:57:51", 01:58:16 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:58:16 INFO - "revlink": "", 01:58:16 INFO - "properties": [ 01:58:16 INFO - [ 01:58:16 INFO - "buildid", 01:58:16 INFO - "20160209233531", 01:58:16 INFO - "Change" 01:58:16 INFO - ], 01:58:16 INFO - [ 01:58:16 INFO - "builduid", 01:58:16 INFO - "a4f171d96d0940789733d59b71cf51cf", 01:58:16 INFO - "Change" 01:58:16 INFO - ], 01:58:16 INFO - [ 01:58:16 INFO - "pgo_build", 01:58:16 INFO - "True", 01:58:16 INFO - "Change" 01:58:16 INFO - ] 01:58:16 INFO - ], 01:58:16 INFO - "revision": "a39ff3e4af74" 01:58:16 INFO - } 01:58:16 INFO - ], 01:58:16 INFO - "revision": "a39ff3e4af74" 01:58:16 INFO - } 01:58:16 INFO - } 01:58:16 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2. 01:58:16 INFO - Running post-action listener: _resource_record_post_action 01:58:16 INFO - ##### 01:58:16 INFO - ##### Running download-and-extract step. 01:58:16 INFO - ##### 01:58:16 INFO - Running pre-action listener: _resource_record_pre_action 01:58:16 INFO - Running main action method: download_and_extract 01:58:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/test_packages.json 01:58:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:58:16 INFO - Downloaded 1270 bytes. 01:58:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:58:16 INFO - Using the following test package requirements: 01:58:16 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:58:16 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:58:16 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'jsshell-linux-x86_64.zip'], 01:58:16 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:58:16 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:58:16 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 01:58:16 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 01:58:16 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:58:16 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:58:16 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:58:16 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:58:16 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:58:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:20 INFO - Downloaded 21582080 bytes. 01:58:20 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 01:58:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:58:20 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 01:58:22 INFO - Return code: 0 01:58:22 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 01:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:58:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:22 INFO - Downloaded 21582080 bytes. 01:58:22 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 01:58:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:58:22 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 01:58:23 INFO - Return code: 0 01:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:58:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:28 INFO - Downloaded 11132038 bytes. 01:58:28 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 01:58:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:58:28 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 01:58:28 INFO - Return code: 0 01:58:28 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')]} 01:58:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:58:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/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 01:58:37 INFO - Downloaded 57944251 bytes. 01:58:37 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:58:37 INFO - mkdir: /builds/slave/test-pgo/properties 01:58:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:58:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:58:37 INFO - Contents: 01:58:37 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:58:37 INFO - Running post-action listener: _resource_record_post_action 01:58:37 INFO - Running post-action listener: set_extra_try_arguments 01:58:37 INFO - ##### 01:58:37 INFO - ##### Running populate-webroot step. 01:58:37 INFO - ##### 01:58:37 INFO - Running pre-action listener: _resource_record_pre_action 01:58:37 INFO - Running main action method: populate_webroot 01:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:58:37 INFO - '--tppagecycles', 01:58:37 INFO - '7'], 01:58:37 INFO - 'tests': ['tsvgm']}}, 01:58:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:58:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:58:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:58:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:58:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'tests': ['damp', 'tps']}, 01:58:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['damp', 'tps']}, 01:58:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:58:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:58:37 INFO - 'other': {'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'other_l64': {'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'other_nol64': {'tests': ['a11yr', 01:58:37 INFO - 'ts_paint', 01:58:37 INFO - 'tpaint', 01:58:37 INFO - 'sessionrestore', 01:58:37 INFO - 'sessionrestore_no_auto_restore']}, 01:58:37 INFO - 'svgr': {'tests': ['tsvgx', 01:58:37 INFO - 'tsvgr_opacity', 01:58:37 INFO - 'tart', 01:58:37 INFO - 'tscrollx', 01:58:37 INFO - 'cart']}, 01:58:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['tsvgx', 01:58:37 INFO - 'tsvgr_opacity', 01:58:37 INFO - 'tart', 01:58:37 INFO - 'tscrollx', 01:58:37 INFO - 'cart']}, 01:58:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'tests': ['tp5o']}, 01:58:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'talos_options': ['--e10s'], 01:58:37 INFO - 'tests': ['tp5o']}, 01:58:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'talos_options': ['--xperf_path', 01:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:37 INFO - 'tests': ['tp5n']}, 01:58:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:37 INFO - 'talos_options': ['--e10s', 01:58:37 INFO - '--xperf_path', 01:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:37 INFO - 'tests': ['tp5n']}}, 01:58:37 INFO - 'talos.zip': {'path': '', 01:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:58:37 INFO - Running post-action listener: _resource_record_post_action 01:58:37 INFO - ##### 01:58:37 INFO - ##### Running create-virtualenv step. 01:58:37 INFO - ##### 01:58:37 INFO - Running pre-action listener: _resource_record_pre_action 01:58:37 INFO - Running main action method: create_virtualenv 01:58:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:58:37 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 01:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:58:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:58:37 INFO - Using real prefix '/usr' 01:58:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:58:37 INFO - Installing distribute.............................................................................................................................................................................................done. 01:58:39 INFO - Installing pip.................done. 01:58:39 INFO - Return code: 0 01:58:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:58:39 INFO - Using env: {'DISPLAY': ':0', 01:58:39 INFO - 'HOME': '/home/cltbld', 01:58:39 INFO - 'LANG': 'en_US.UTF-8', 01:58:39 INFO - 'LANGUAGE': 'en_US:en', 01:58:39 INFO - 'LOGNAME': 'cltbld', 01:58:39 INFO - 'MAIL': '/var/mail/cltbld', 01:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:39 INFO - 'MOZ_NO_REMOTE': '1', 01:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:39 INFO - 'NO_EM_RESTART': '1', 01:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:39 INFO - 'SHELL': '/bin/bash', 01:58:39 INFO - 'SHLVL': '1', 01:58:39 INFO - 'TERM': 'linux', 01:58:39 INFO - 'TMOUT': '86400', 01:58:39 INFO - 'USER': 'cltbld', 01:58:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:39 INFO - '_': '/tools/buildbot/bin/python'} 01:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:39 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 01:58:39 INFO - Cleaning up... 01:58:39 INFO - Return code: 0 01:58:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:58:39 INFO - Using env: {'DISPLAY': ':0', 01:58:39 INFO - 'HOME': '/home/cltbld', 01:58:39 INFO - 'LANG': 'en_US.UTF-8', 01:58:39 INFO - 'LANGUAGE': 'en_US:en', 01:58:39 INFO - 'LOGNAME': 'cltbld', 01:58:39 INFO - 'MAIL': '/var/mail/cltbld', 01:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:39 INFO - 'MOZ_NO_REMOTE': '1', 01:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:39 INFO - 'NO_EM_RESTART': '1', 01:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:39 INFO - 'SHELL': '/bin/bash', 01:58:39 INFO - 'SHLVL': '1', 01:58:39 INFO - 'TERM': 'linux', 01:58:39 INFO - 'TMOUT': '86400', 01:58:39 INFO - 'USER': 'cltbld', 01:58:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:39 INFO - '_': '/tools/buildbot/bin/python'} 01:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:40 INFO - Downloading/unpacking psutil>=0.7.1 01:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:41 INFO - Installing collected packages: psutil 01:58:41 INFO - Running setup.py install for psutil 01:58:42 INFO - building 'psutil._psutil_linux' extension 01:58:42 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 01:58:42 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 01:58:42 INFO - building 'psutil._psutil_posix' extension 01:58:42 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 01:58:42 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 01:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:42 INFO - Successfully installed psutil 01:58:42 INFO - Cleaning up... 01:58:42 INFO - Return code: 0 01:58:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:58:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:58:42 INFO - Using env: {'DISPLAY': ':0', 01:58:42 INFO - 'HOME': '/home/cltbld', 01:58:42 INFO - 'LANG': 'en_US.UTF-8', 01:58:42 INFO - 'LANGUAGE': 'en_US:en', 01:58:42 INFO - 'LOGNAME': 'cltbld', 01:58:42 INFO - 'MAIL': '/var/mail/cltbld', 01:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:42 INFO - 'MOZ_NO_REMOTE': '1', 01:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:42 INFO - 'NO_EM_RESTART': '1', 01:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:42 INFO - 'SHELL': '/bin/bash', 01:58:42 INFO - 'SHLVL': '1', 01:58:42 INFO - 'TERM': 'linux', 01:58:42 INFO - 'TMOUT': '86400', 01:58:42 INFO - 'USER': 'cltbld', 01:58:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:42 INFO - '_': '/tools/buildbot/bin/python'} 01:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:58:44 INFO - Installing collected packages: mozsystemmonitor 01:58:44 INFO - Running setup.py install for mozsystemmonitor 01:58:44 INFO - Successfully installed mozsystemmonitor 01:58:44 INFO - Cleaning up... 01:58:44 INFO - Return code: 0 01:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:58:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:58:44 INFO - Using env: {'DISPLAY': ':0', 01:58:44 INFO - 'HOME': '/home/cltbld', 01:58:44 INFO - 'LANG': 'en_US.UTF-8', 01:58:44 INFO - 'LANGUAGE': 'en_US:en', 01:58:44 INFO - 'LOGNAME': 'cltbld', 01:58:44 INFO - 'MAIL': '/var/mail/cltbld', 01:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:44 INFO - 'MOZ_NO_REMOTE': '1', 01:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:44 INFO - 'NO_EM_RESTART': '1', 01:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:44 INFO - 'SHELL': '/bin/bash', 01:58:44 INFO - 'SHLVL': '1', 01:58:44 INFO - 'TERM': 'linux', 01:58:44 INFO - 'TMOUT': '86400', 01:58:44 INFO - 'USER': 'cltbld', 01:58:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:44 INFO - '_': '/tools/buildbot/bin/python'} 01:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 01:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - Downloading docopt-0.6.1.tar.gz 01:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 01:58:47 INFO - Running setup.py install for blobuploader 01:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:58:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:58:47 INFO - Running setup.py install for requests 01:58:47 INFO - Running setup.py install for docopt 01:58:47 INFO - Successfully installed blobuploader requests docopt 01:58:47 INFO - Cleaning up... 01:58:48 INFO - Return code: 0 01:58:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:58:48 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')]} 01:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:48 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')]} 01:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:48 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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:48 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 01:58:48 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 01:58:48 INFO - Using env: {'DISPLAY': ':0', 01:58:48 INFO - 'HOME': '/home/cltbld', 01:58:48 INFO - 'LANG': 'en_US.UTF-8', 01:58:48 INFO - 'LANGUAGE': 'en_US:en', 01:58:48 INFO - 'LOGNAME': 'cltbld', 01:58:48 INFO - 'MAIL': '/var/mail/cltbld', 01:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:48 INFO - 'MOZ_NO_REMOTE': '1', 01:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:48 INFO - 'NO_EM_RESTART': '1', 01:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:48 INFO - 'SHELL': '/bin/bash', 01:58:48 INFO - 'SHLVL': '1', 01:58:48 INFO - 'TERM': 'linux', 01:58:48 INFO - 'TMOUT': '86400', 01:58:48 INFO - 'USER': 'cltbld', 01:58:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:48 INFO - '_': '/tools/buildbot/bin/python'} 01:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:58:48 INFO - Running setup.py (path:/tmp/pip-L6AwCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:58:48 INFO - Running setup.py (path:/tmp/pip-Q3SlyO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:58:48 INFO - Running setup.py (path:/tmp/pip-aSmWez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:58:48 INFO - Running setup.py (path:/tmp/pip-hmB5B5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:58:48 INFO - Running setup.py (path:/tmp/pip-yinEPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:58:48 INFO - Running setup.py (path:/tmp/pip-hGdQW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:58:48 INFO - Running setup.py (path:/tmp/pip-oi3ovP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:58:48 INFO - Running setup.py (path:/tmp/pip-9qPcyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:58:48 INFO - Running setup.py (path:/tmp/pip-pVEEru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:58:48 INFO - Running setup.py (path:/tmp/pip-sMKY2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:58:48 INFO - Running setup.py (path:/tmp/pip-nAswcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:58:49 INFO - Running setup.py (path:/tmp/pip-pbb5I2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:58:49 INFO - Running setup.py (path:/tmp/pip-k_GesE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:58:49 INFO - Running setup.py (path:/tmp/pip-lZ0_ZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:58:49 INFO - Running setup.py (path:/tmp/pip-x4rFCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:58:49 INFO - Running setup.py (path:/tmp/pip-BnGX6U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:58:49 INFO - Running setup.py (path:/tmp/pip-WWA8J_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:49 INFO - Running setup.py install for manifestparser 01:58:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:58:49 INFO - Running setup.py install for mozcrash 01:58:49 INFO - Running setup.py install for mozdebug 01:58:49 INFO - Running setup.py install for mozdevice 01:58:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:58:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:58:49 INFO - Running setup.py install for mozfile 01:58:49 INFO - Running setup.py install for mozhttpd 01:58:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozinfo 01:58:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozInstall 01:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozleak 01:58:50 INFO - Running setup.py install for mozlog 01:58:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for moznetwork 01:58:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozprocess 01:58:50 INFO - Running setup.py install for mozprofile 01:58:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozrunner 01:58:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:58:50 INFO - Running setup.py install for mozscreenshot 01:58:51 INFO - Running setup.py install for moztest 01:58:51 INFO - Running setup.py install for mozversion 01:58:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:51 INFO - Cleaning up... 01:58:51 INFO - Return code: 0 01:58:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:51 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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:51 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 01:58:51 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 01:58:51 INFO - Using env: {'DISPLAY': ':0', 01:58:51 INFO - 'HOME': '/home/cltbld', 01:58:51 INFO - 'LANG': 'en_US.UTF-8', 01:58:51 INFO - 'LANGUAGE': 'en_US:en', 01:58:51 INFO - 'LOGNAME': 'cltbld', 01:58:51 INFO - 'MAIL': '/var/mail/cltbld', 01:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:51 INFO - 'MOZ_NO_REMOTE': '1', 01:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:51 INFO - 'NO_EM_RESTART': '1', 01:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:51 INFO - 'SHELL': '/bin/bash', 01:58:51 INFO - 'SHLVL': '1', 01:58:51 INFO - 'TERM': 'linux', 01:58:51 INFO - 'TMOUT': '86400', 01:58:51 INFO - 'USER': 'cltbld', 01:58:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:51 INFO - '_': '/tools/buildbot/bin/python'} 01:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:58:51 INFO - Running setup.py (path:/tmp/pip-TxEqzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:58:51 INFO - Running setup.py (path:/tmp/pip-JTeBuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:58:51 INFO - Running setup.py (path:/tmp/pip-yiWzXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:58:51 INFO - Running setup.py (path:/tmp/pip-yQSVKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:58:51 INFO - Running setup.py (path:/tmp/pip-WT7IX2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:58:51 INFO - Running setup.py (path:/tmp/pip-z7HQKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:58:51 INFO - Running setup.py (path:/tmp/pip-ATm26g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:58:51 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)) 01:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:58:51 INFO - Running setup.py (path:/tmp/pip-U5rxuH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:58:52 INFO - Running setup.py (path:/tmp/pip-Q1VMgS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:58:52 INFO - Running setup.py (path:/tmp/pip-NtiHY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:58:52 INFO - Running setup.py (path:/tmp/pip-X7c6xM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:58:52 INFO - Running setup.py (path:/tmp/pip-ZPZ4mF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:58:52 INFO - Running setup.py (path:/tmp/pip-Gyf8OQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:58:52 INFO - Running setup.py (path:/tmp/pip-28_nzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:58:52 INFO - Running setup.py (path:/tmp/pip-SNIbMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:58:52 INFO - Running setup.py (path:/tmp/pip-FvjqTk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:58:52 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)) 01:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:58:52 INFO - Running setup.py (path:/tmp/pip-BwONMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:58:52 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)) 01:58:52 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)) 01:58: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:58:52 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)) 01:58: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:58:52 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)) 01:58:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:58:52 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 01:58:52 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 01:58:52 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 01:58:52 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 01:58:52 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 01:58:52 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 01:58:54 INFO - Downloading blessings-1.6.tar.gz 01:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:54 INFO - Installing collected packages: blessings 01:58:54 INFO - Running setup.py install for blessings 01:58:54 INFO - Successfully installed blessings 01:58:54 INFO - Cleaning up... 01:58:54 INFO - Return code: 0 01:58:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:58:54 INFO - Reading from file tmpfile_stdout 01:58:54 INFO - Current package versions: 01:58:54 INFO - argparse == 1.2.1 01:58:54 INFO - blessings == 1.6 01:58:54 INFO - blobuploader == 1.2.4 01:58:54 INFO - docopt == 0.6.1 01:58:54 INFO - manifestparser == 1.1 01:58:54 INFO - mozInstall == 1.12 01:58:54 INFO - mozcrash == 0.16 01:58:54 INFO - mozdebug == 0.1 01:58:54 INFO - mozdevice == 0.47 01:58:54 INFO - mozfile == 1.2 01:58:54 INFO - mozhttpd == 0.7 01:58:54 INFO - mozinfo == 0.9 01:58:54 INFO - mozleak == 0.1 01:58:54 INFO - mozlog == 3.1 01:58:54 INFO - moznetwork == 0.27 01:58:54 INFO - mozprocess == 0.22 01:58:54 INFO - mozprofile == 0.27 01:58:54 INFO - mozrunner == 6.11 01:58:54 INFO - mozscreenshot == 0.1 01:58:54 INFO - mozsystemmonitor == 0.0 01:58:54 INFO - moztest == 0.7 01:58:54 INFO - mozversion == 1.4 01:58:54 INFO - psutil == 3.1.1 01:58:54 INFO - requests == 1.2.3 01:58:54 INFO - wsgiref == 0.1.2 01:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:54 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 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:54 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 01:58:54 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 01:58:54 INFO - Using env: {'DISPLAY': ':0', 01:58:54 INFO - 'HOME': '/home/cltbld', 01:58:54 INFO - 'LANG': 'en_US.UTF-8', 01:58:54 INFO - 'LANGUAGE': 'en_US:en', 01:58:54 INFO - 'LOGNAME': 'cltbld', 01:58:54 INFO - 'MAIL': '/var/mail/cltbld', 01:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:54 INFO - 'MOZ_NO_REMOTE': '1', 01:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:54 INFO - 'NO_EM_RESTART': '1', 01:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:54 INFO - 'SHELL': '/bin/bash', 01:58:54 INFO - 'SHLVL': '1', 01:58:54 INFO - 'TERM': 'linux', 01:58:54 INFO - 'TMOUT': '86400', 01:58:54 INFO - 'USER': 'cltbld', 01:58:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:54 INFO - '_': '/tools/buildbot/bin/python'} 01:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 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)) 01:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:58:55 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)) 01:58:55 INFO - Cleaning up... 01:58:55 INFO - Return code: 0 01:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:58: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')]} 01:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58: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', 'jsonschema'] in /builds/slave/test-pgo/build 01:58: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 jsonschema 01:58:55 INFO - Using env: {'DISPLAY': ':0', 01:58:55 INFO - 'HOME': '/home/cltbld', 01:58:55 INFO - 'LANG': 'en_US.UTF-8', 01:58:55 INFO - 'LANGUAGE': 'en_US:en', 01:58:55 INFO - 'LOGNAME': 'cltbld', 01:58:55 INFO - 'MAIL': '/var/mail/cltbld', 01:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:55 INFO - 'MOZ_NO_REMOTE': '1', 01:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:55 INFO - 'NO_EM_RESTART': '1', 01:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:55 INFO - 'SHELL': '/bin/bash', 01:58:55 INFO - 'SHLVL': '1', 01:58:55 INFO - 'TERM': 'linux', 01:58:55 INFO - 'TMOUT': '86400', 01:58:55 INFO - 'USER': 'cltbld', 01:58:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:55 INFO - '_': '/tools/buildbot/bin/python'} 01:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:55 INFO - Downloading/unpacking jsonschema 01:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:57 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:57 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:57 INFO - warning: no files found matching '*.txt' 01:58:57 INFO - no previously-included directories found matching 'build' 01:58:57 INFO - no previously-included directories found matching 'dist' 01:58:57 INFO - no previously-included directories found matching '.git*' 01:58:57 INFO - Installing collected packages: jsonschema, functools32 01:58:57 INFO - Running setup.py install for functools32 01:58:57 INFO - warning: no files found matching '*.txt' 01:58:57 INFO - no previously-included directories found matching 'build' 01:58:57 INFO - no previously-included directories found matching 'dist' 01:58:57 INFO - no previously-included directories found matching '.git*' 01:58:57 INFO - Successfully installed jsonschema functools32 01:58:57 INFO - Cleaning up... 01:58:57 INFO - Return code: 0 01:58:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef2265f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', '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 01:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:58:57 INFO - Using env: {'DISPLAY': ':0', 01:58:57 INFO - 'HOME': '/home/cltbld', 01:58:57 INFO - 'LANG': 'en_US.UTF-8', 01:58:57 INFO - 'LANGUAGE': 'en_US:en', 01:58:57 INFO - 'LOGNAME': 'cltbld', 01:58:57 INFO - 'MAIL': '/var/mail/cltbld', 01:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:57 INFO - 'MOZ_NO_REMOTE': '1', 01:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:57 INFO - 'NO_EM_RESTART': '1', 01:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:58:57 INFO - 'SHELL': '/bin/bash', 01:58:57 INFO - 'SHLVL': '1', 01:58:57 INFO - 'TERM': 'linux', 01:58:57 INFO - 'TMOUT': '86400', 01:58:57 INFO - 'USER': 'cltbld', 01:58:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:57 INFO - '_': '/tools/buildbot/bin/python'} 01:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:57 INFO - Downloading/unpacking flake8 01:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:00 INFO - no previously-included directories found matching 'docs/_build' 01:59:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:59:00 INFO - Running setup.py install for pep8 01:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:00 INFO - no previously-included directories found matching 'docs/_build' 01:59:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:59:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:59:00 INFO - Cleaning up... 01:59:00 INFO - Return code: 0 01:59:00 INFO - Running post-action listener: _resource_record_post_action 01:59:00 INFO - Running post-action listener: _start_resource_monitoring 01:59:00 INFO - Starting resource monitoring. 01:59:00 INFO - ##### 01:59:00 INFO - ##### Running install step. 01:59:00 INFO - ##### 01:59:00 INFO - Running pre-action listener: _resource_record_pre_action 01:59:00 INFO - Running main action method: install 01:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:59:00 INFO - Reading from file tmpfile_stdout 01:59:00 INFO - Detecting whether we're running mozinstall >=1.0... 01:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:59:00 INFO - Reading from file tmpfile_stdout 01:59:00 INFO - Output received: 01:59:00 INFO - Usage: mozinstall [options] installer 01:59:00 INFO - Options: 01:59:00 INFO - -h, --help show this help message and exit 01:59:00 INFO - -d DEST, --destination=DEST 01:59:00 INFO - Directory to install application into. [default: 01:59:00 INFO - "/builds/slave/test-pgo"] 01:59:00 INFO - --app=APP Application being installed. [default: firefox] 01:59:00 INFO - mkdir: /builds/slave/test-pgo/build/application 01:59:00 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'] 01:59:00 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 01:59:15 INFO - Reading from file tmpfile_stdout 01:59:15 INFO - Output received: 01:59:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:59:15 INFO - Running post-action listener: _resource_record_post_action 01:59:15 INFO - ##### 01:59:15 INFO - ##### Running run-tests step. 01:59:15 INFO - ##### 01:59:15 INFO - Running pre-action listener: _resource_record_pre_action 01:59:15 INFO - Running main action method: run_tests 01:59:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:59:15 INFO - Python 2.7.3 01:59:15 INFO - Return code: 0 01:59:15 INFO - grabbing minidump binary from tooltool 01:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:15 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 0x1f46350>, '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 0x1f47250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f476e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:59:15 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 01:59:15 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 01:59:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:59:15 INFO - Return code: 0 01:59:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:59:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:59:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:59:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:59:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:59:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:59:16 INFO - Return code: 0 01:59:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:59:16 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 01:59:16 INFO - Using env: {'DISPLAY': ':0', 01:59:16 INFO - 'HOME': '/home/cltbld', 01:59:16 INFO - 'LANG': 'en_US.UTF-8', 01:59:16 INFO - 'LANGUAGE': 'en_US:en', 01:59:16 INFO - 'LOGNAME': 'cltbld', 01:59:16 INFO - 'MAIL': '/var/mail/cltbld', 01:59:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:59:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:16 INFO - 'MOZ_NO_REMOTE': '1', 01:59:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:16 INFO - 'NO_EM_RESTART': '1', 01:59:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:59:16 INFO - 'SHELL': '/bin/bash', 01:59:16 INFO - 'SHLVL': '1', 01:59:16 INFO - 'TERM': 'linux', 01:59:16 INFO - 'TMOUT': '86400', 01:59:16 INFO - 'USER': 'cltbld', 01:59:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198', 01:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:16 INFO - '_': '/tools/buildbot/bin/python'} 01:59:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 01:59:16 INFO - mozversion INFO | application_buildid: 20160209233531 01:59:16 INFO - mozversion INFO | application_changeset: a39ff3e4af74acf0a19af0eedfde637b5188b28f 01:59:16 INFO - mozversion INFO | application_display_name: Nightly 01:59:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:59:16 INFO - mozversion INFO | application_name: Firefox 01:59:16 INFO - mozversion INFO | application_remotingname: firefox 01:59:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:59:16 INFO - mozversion INFO | application_vendor: Mozilla 01:59:16 INFO - mozversion INFO | application_version: 45.0 01:59:16 INFO - mozversion INFO | platform_buildid: 20160209233531 01:59:16 INFO - mozversion INFO | platform_changeset: a39ff3e4af74acf0a19af0eedfde637b5188b28f 01:59:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:59:16 INFO - mozversion INFO | platform_version: 45.0 01:59:16 INFO - 2016-02-10 01:59:16,686 DEBUG : using testdate: 1455098356 01:59:16 INFO - 2016-02-10 01:59:16,686 DEBUG : actual date: 1455098356 01:59:16 INFO - 2016-02-10 01:59:16,695 INFO : starting webserver on 'localhost:57265' 01:59:16 INFO - 2016-02-10 01:59:16,696 INFO : Starting test suite talos-linux64-ix-004 01:59:16 INFO - 2016-02-10 01:59:16,696 INFO : Starting test dromaeo_css 01:59:16 INFO - 2016-02-10 01:59:16,696 DEBUG : operating with platform_type : linux_ 01:59:16 INFO - 2016-02-10 01:59:16,697 INFO : Initialising browser for dromaeo_css test... 01:59:16 INFO - 2016-02-10 01:59:16,713 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp13UayX/profile http://localhost:57265/getInfo.html 01:59:20 INFO - 2016-02-10 01:59:20,859 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:59:20 INFO - 2016-02-10 01:59:20,860 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:59:20 INFO - 2016-02-10 01:59:20,860 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:59:20 INFO - 2016-02-10 01:59:20,860 DEBUG : BROWSER_OUTPUT: __metrics 01:59:20 INFO - 2016-02-10 01:59:20,976 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] 01:59:21 INFO - 2016-02-10 01:59:21,854 INFO : Browser initialized. 01:59:21 INFO - 2016-02-10 01:59:21,854 INFO : Running cycle 1/1 for dromaeo_css test... 01:59:21 INFO - 2016-02-10 01:59:21,855 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp13UayX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:59:33 INFO - 2016-02-10 01:59:33,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 133996544 01:59:33 INFO - 2016-02-10 01:59:33,522 DEBUG : BROWSER_OUTPUT: 02:00:24 INFO - 2016-02-10 02:00:24,230 DEBUG : BROWSER_OUTPUT: 1455098424229 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] 02:02:32 INFO - 2016-02-10 02:02:32,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57265/tests/dromaeo/cssquery-ext.html) 02:02:33 INFO - 2016-02-10 02:02:33,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 229326848 02:02:33 INFO - 2016-02-10 02:02:33,585 DEBUG : BROWSER_OUTPUT: 02:05:35 INFO - 2016-02-10 02:05:35,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-ext.html (next: http://localhost:57265/tests/dromaeo/cssquery-jquery.html) 02:05:36 INFO - 2016-02-10 02:05:36,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 219422720 02:05:36 INFO - 2016-02-10 02:05:36,254 DEBUG : BROWSER_OUTPUT: 02:08:38 INFO - 2016-02-10 02:08:38,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57265/tests/dromaeo/cssquery-mootools.html) 02:08:38 INFO - 2016-02-10 02:08:38,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 206983168 02:08:38 INFO - 2016-02-10 02:08:38,587 DEBUG : BROWSER_OUTPUT: 02:11:40 INFO - 2016-02-10 02:11:40,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57265/tests/dromaeo/cssquery-prototype.html) 02:11:40 INFO - 2016-02-10 02:11:40,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 195493888 02:11:40 INFO - 2016-02-10 02:11:40,834 DEBUG : BROWSER_OUTPUT: 02:14:43 INFO - 2016-02-10 02:14:43,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57265/tests/dromaeo/cssquery-yui.html) 02:14:43 INFO - 2016-02-10 02:14:43,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 202260480 02:14:43 INFO - 2016-02-10 02:14:43,749 DEBUG : BROWSER_OUTPUT: 02:17:45 INFO - 2016-02-10 02:17:45,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/dromaeo/cssquery-yui.html (next: http://localhost:57265/tests/dromaeo/cssquery-dojo.html) 02:17:46 INFO - 2016-02-10 02:17:46,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 238985216 02:17:46 INFO - 2016-02-10 02:17:46,082 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,083 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:17:46 INFO - 2016-02-10 02:17:46,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:17:46 INFO - 2016-02-10 02:17:46,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:17:46 INFO - 2016-02-10 02:17:46,084 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:17:46 INFO - 2016-02-10 02:17:46,084 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3278.6229583597888;3315.4860996545544;3334.0164651427826;3337.699607035366;3365.1418888183516;5433.239346491489;5494.203340515623;5494.36814766302;5496.203050557677;5510.724463776815;5484.506394424501;5502.449755024496;5519.337679478458;5523.972380138093;5528.281323427958;4940.333055037578;4991.475895031024;5014.398272207322;5024;5039.118154322979;4993.500649935014;5015.498450154992;5067.138586440314;5109.872253193681;5132.538071573557;4961.677490963094;5041.672291301072;5046.142155833517;5050.964552266795;5053.469385714502;5059.772310246048;5119.283300337956;5127.051495473331;5130.410002849682;5157.974210128944;4876.390451193601;4919.77860996256;4965.950340496585;5022.146235140035;5036.823711170092;5335.946640533583;5360.678359298455;5375.43557926416;5376.596755243333;5381.7578208980685;5960;5962.07587823888;5966.134910438005;5969.910451343233;5977.551683623702;5732.942670573324;5802.274715660543;5823.56323275756;5874.588778785486;5886.087656413263;5625.409332020161;5630.774769009235;5632.267805185382;5652.09566469367;5652.321721393377;5838.12428135783;6114.2357205349335;6119.143319935212;6119.84700382494;6124.265088189446;5667.093265077568;5768.077107662753;5810.477057064884;5856.824295271149;5869.383714709979;5859.531237501075;5917.142014407887;5917.260342457193;5922.8815423691285;5926.614770039933;5706.743196556165;5791.362950075489;5861.70691465425;5865.061590145556;5866.589338746332;5775.768969241268;5843.444872737083;5850.9414905851245;5855.355910849803;5858.619189752652;4598.609118224988;4600.056988317387;4629.3518907353;4634.073185362941;4648.628109751212;3999.2601368746873;4065.9796701016307;4153.7300075494995;4164.979175104105;4184.707070505096;5560.054790685593;5634.239377684042;5641.097424412074;5643.943560564424;5676.772929082873;6038.486728628028;6073.848153796102;6076.270847498328;6080.695965201722;6081.483073938764;5395.163749618815;5493.368262649767;5548.0845660465575;5664.631798933056;5671.404502527258;5161.303224064778;5201.115810312256;5211.062008838369;5217.765200565907;5218.269442278084;6178.104174894615;6185.041318595625;6199.194104766351;6214.036824292242;6226.315105338409;5776.653400795965;5825.446582574648;5917.082852157922;5924.9703751480965;6039.184710064085;6116.320830008016;6126.131514934082;6129.969350153221;6131.785387511416;6136.386361363828;5827.970860145672;5883.588148829541;5887.852803679943;5898.9115163273445;5925.111233315038;5723.627964182315;5824.271966004249;5896.7936122235515;5968.194293770285;5971.044632858721;5821.970890145522;5869.530437564899;5915.674637894957;5921.319048309328;5922.200502932049;5866.765329386777;5890.322612899571;5904.527637789052;5909.438603332676;5910.261217347832;5463.617546771688;5552.972235138798;5586.748596313095;5651.773929042956;5819.94180058194;5731.455511726379;5836.037053886062;5852;5862.472377486047;5864.208331875142;5697.23087383198;5705.429457054427;5708.372079071216;5713.171590119493;5723.599348045597 02:17:46 INFO - 2016-02-10 02:17:46,087 DEBUG : BROWSER_OUTPUT: |1;ext.html;595.5295316699808;620.3269452643881;637.1398611873974;640.7020735358058;688.0985908459915;33013;33412.331753364946;37470;37883;37953.24093518128;44806.77596612021;45215;45333;45440;45473.090538189215;8204.671813127468;8983.371164018537;9152.405093668924;9153;9157.633694652206;8358.289545388649;10746.194035447374;10880.238383313172;10970.122390208804;10970.232083754141;10706.732331691692;10821.080208182313;10878.184136189779;10881.510332035077;10883.346999180074;10722.303050301705;10760.78478430435;10829.187810914174;10829.458527073615;10833.729156771065;10481.842772358421;10624.415657138854;10655.360678359324;10672.786544269149;10675.519601617945;42092.368614470804;42520.574794251974;42568.78715606433;42621.57378426207;42712.145757084996;3719.107414220595;3723.2925744108534;3819.2743378757946;3855.267499175148;3955.584663610337;31365.52951705726;31477.055688329387;31557.684423155933;31609;32171.19572010695;4237.894052648709;4251.4685664291965;4306.913861722779;4353.36876152956;4396.1427521633295;287301;289378;290111;290411;291806;58124.4187558119;66358.33641663521;66780.33219667838;66846;66857.6657116721;57625;77930;78320;78494.21505784869;78673;17643.823561764217;17782;17846;17910.10449477521;17931;12374.071944604191;12387.504499820086;12392.070594705434;12395;12417.254964702146;21750.45623859416;21820.345389638336;22090.116395344005;22129.33611991643;22161.889190554266;8211.671533138728;8548.230659240699;8618.913810861937;8624.137586241326;8694.434861733967;1040.3081950502983;1079.7030816525519;1155.78040172367;1160.7272291011604;1164.441068287227;30085;30428;31377.215569610944;31430.685693143234;31585;1120.2270433400927;1136.1138312116561;1145.4902568357002;1157.5311998640564;1241.1498123785236;14188;14813.555593332218;15114.244287785566;15538.766918496232;16122.838771612134;452949;457727;461811;463482;465440;57077;57153;57191.71404142953;57668.71165644145;57685.423145768844;1308.2281453942219;1398.1960372785486;1408.485902645527;1479.4821812365801;1490.2846633615925;29831;29908.700912990593;33925.49111763375;34648;35179.824100879334;47203.76398117987;55913;56494.435055648915;56537.434625653215;56597.71701141468;312449;322017;325734;326616;327350;44389.556104439835;45050;45307;45598;46537.30194047024;48735.75632121817;48756.268655970896;49139.754301229696;49587.50412495829;50252.49747502478;40261.39607905942;41483.585164147975;41538;42042.1591568173;42448.15103697847;41280;42205.78897105495;42231.366529502695;45473.317900232185;45635.77182114068;39022.41466378063;39756.2048759029;39810.601893981846;40028.399574006995;40260;34860;35008.824955875054;35296.647033529334;35744.64255357517;35834.28331433409;26522.60216096799;27431.039913602926;27462.862685686443;27464.588031179148;27716.858384394876 02:17:46 INFO - 2016-02-10 02:17:46,089 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.1470258136925;360.3225935241745;361.52459515736786;363.95632524097107;367.1152522420966;15263.389464421438;16242.18789060548;17263.741043884336;18305.72541411878;19793.60412791743;17433.21550530226;17505.124743762826;17555.2100155493;17892.910535447303;18040.54898627535;5433.945660543393;5559.666420014792;5560.555155587544;5581.944180558204;5588.077967135418;4309.6336811371075;4466.039801442689;5528.281323427948;5893.351731309553;6175.969120154393;6095.573309868311;6164.29110652274;6192.504599632019;6194.349593292707;6209.937900621004;6092.786752463665;6099.298580663236;6124.112003759475;6128.172696685935;6147.231596050494;5201.063808514466;5260.395054568736;5280.551153151987;5283.313169288006;5295.920561191585;21322.78677213239;21338;21491.67762483564;22233.555328893493;22344.55310893773;2343.94140146496;2364.609839376501;2370.9425833766654;2381.226101517014;2473.517664055492;13730.382132804049;13856.376463059187;14164.150150990974;14366.35351409189;14390.928045359811;1901.1634880652468;1912.8182822631827;1931.198552600669;1947.6883698608156;1954.9668344921265;59982;62030.37969620336;62898.37101628971;63579.68210158966;64252.3574764251;9533.952330238442;9607.51962401877;9634.614615415445;9675.225981921429;9744.46405447693;12725.172863763826;12732.363381830872;12734.172278801849;12736.6815829605;12739.745205095845;7887.881681774778;8126.634301456449;8200.548969806718;8210.712625058095;8274.379421543408;8085.272325490617;8085.555294458862;8155.918440815634;8171.060328062349;8348.499090054616;6045.818625441244;6048.697565121726;6070.969645151746;6075.1191077294425;6079.878402432015;1581.612504936298;1649.6205872649357;1671.4651311580178;1734.4709863491503;1744.8691348148939;1045.843123531461;1049.569676432659;1054.456954668331;1066.3282132256784;1200.2558413783336;17746.649148486467;17817.376391826485;18022.36921707734;18258.269669213347;18463.446096617125;995.2828777437636;1076.0638244726981;1084.9240553161203;1090.820014697566;1093.94530273486;5771.451712087345;5928.8814223716145;5942.197803296586;5995.52035837132;9381.061893810564;437947;438986;519110;583971;616019;70175.64912175406;80167;85935;88317.55841220752;92068.53965730262;448.74645825108706;452.5293694557689;452.87319550526564;453.09833431471134;455.257929574791;10145.188384929335;10152.238582106223;10211.234157438073;10283.33158344735;10309.278350515691;37383.626163738016;37436.625633743315;38011.42982855204;38516.6148338513;38535.229295414494;47354.52645473639;47607;49287;50643.49356506388;53469.7326513365;9209.493477858781;9577.425354478753;9592.328537002622;9627.470489123165;9667.371620844622;11244.493997770283;11655;14817.555473335817;17467.12664366751;19151.61696766029;15082.24588770535;15134.924325378302;15374.077555346716;15392.615184620474;15672.373105076125;14051.297435128407;14725.410983560538;15375.923120384326;15400.768988465406;15572.143532105843;14595.854041459874;14740.11559306445;15101;15389.153596551849;15535.766963495782;9919.553620086968;9969.601215951281;9970.252231082553;10128.544215510467;10365.326253793479;15154.3180556873;15159;15648.687026259639;15843.366265349257;16306.510804675878 02:17:46 INFO - 2016-02-10 02:17:46,090 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1550.1629120275045;1560.2822701557284;1779.6351747891683;1814.0929535232383;1845.483264685888;7581.317681408672;7931.563763992978;7940.602969851513;7945.205479452059;7954.92045079549;7676.961615191916;7744.728934487294;7753.224677532244;7760.301572858441;7766.495177813452;2235.35174799308;2271.954560908785;2310.3992961829963;2311.0178174275948;2312.9537409251807;2292.8509646872985;2311.087120587367;2312.3409828198965;2313.1903833658253;2313.35226136682;2017.778044415113;2077.7610574783866;2228.6545585434283;2230.2528652901215;2308.549832782608;2243.4839986803045;2261.050358849287;2279.8290128240446;2281.3384118605586;2281.8744969026698;2240.3614969733712;2274.636058230675;2278.5101203241384;2279.4415368234722;2280.863148211096;6718.361755633207;6779.389854913082;7492.737754178577;7624.847503049908;7633.198514155989;4675.111728771557;4728.69263497875;4734.597559207437;4737.407824021997;4739.170645137122;3012.578239046535;3018.3661431099495;3046.5277881928337;3048.4665183592783;3090.6600273969843;1005.0903931941605;1033.2354057997104;1033.2612182289624;1078.229066217658;1083.9810578056602;10471.424071676054;10510.684679459628;10531.789364212673;10537.841932371097;10553.472326383728;4198.6431153352305;4210.115875666083;4273.444452221192;4282.464691913511;4293.97853010733;8993.55032248385;8998.910010899937;9004.324675649352;9011.053839346774;9019.32355073359;4787.281907713871;4788.233882578771;4792.113459010095;4796.5203479651755;4802.6638135330195;4395.450568678915;4397.076613911115;4397.406350142754;4406.383106365111;4408.338749187647;3560.786352818839;3628.9455658165148;3633.8728144515344;3640.199156185635;3678;1103.4979084516526;1109.7503061811028;1113.6492005018392;1115.642994241851;1128.514738662383;1162.0993729859426;1174.7944109780753;1186.1815347410432;1187.8752730963297;1209.4013463335705;7394.334509894135;7405.481616286808;7439.776806695808;7488.775336739906;7507.5870827103945;1220.9572664956684;1227.8403807505147;1233.8210959410835;1239.305988646361;1249.375312343828;5652.208690783294;5782.306123265235;5831.300243970751;5832.066869300891;5839.2992840858515;8391.202835730595;9154.496502692416;9196.586153623102;9221.49281789508;9248.630054797868;8807.823843523094;9095.045020272775;9128.543572821332;9136.269098472107;9138.54307284633;7283.308085731847;7375.4099672026105;7442.925570744332;7448.217937116525;7461.552306861606;7200.639968001684;7270.272972702687;7298.598577078312;7322.487425880137;7328.303811137934;7932.920670793218;8207.71273005442;8249.876251856347;8253.587320633824;8270.25567698886;8169.795755105933;8260.917390826015;8384.664613415394;8418.87371689413;8547.74356769298;6972.26791186918;7044.718211271696;7045.682944267418;7060;7065.894011589933;7538.585377804054;7611.467197296358;7619.847603048019;7665.463417560717;7682.769516914502;7207.891881621885;7212.783616491513;7237.855242895218;7288.12542494904;7336.082989626297;7061.788146355618;7152.356287934111;7166.462515311268;7217.7112915484895;7246.058012458347;7152.463565232732;7225;7227;7232.602206878461;7234.059572255573;6390.041493775971;6492.480601551959;6550.639714815731;6556.901646475402;6561.704723287559;6623.735050597922;6644.33556644351;6655.467562594884;6660.167479065117;6665.566738162004 02:17:46 INFO - 2016-02-10 02:17:46,090 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.6985173640251;330.5851156798218;330.7403688104838;332.28558599012126;332.89347408829167;5983.790567330134;6047.274327080751;6057.848553786158;6066.666333351669;6129.81610551683;5906.852328691785;5992.700364981744;5995.9700201499045;5999.880002399949;6004.3395226525045;4592.196365636017;4599.816007359702;4602.700824446417;4610.907781844361;4616.007558374957;4418.82324707013;4494.280915053592;4528.660350473711;4538.954610453903;4605.37827393301;4515.05183911379;4519.615832654228;4522.525134860842;4525.660575456837;4532.252178390561;4535.047639995605;4535.7278563286145;4536.977315113403;4541.477730061052;4547.954520454819;3969.7419667721792;3970.086880017612;3972.6623237024887;3974.046228905071;3976.5824588418377;5617.185508101344;5730.283714535683;5751.194832723422;5772.191893134965;5778.942210577925;5334.813281535166;5358.892822143574;5362.705051222181;5367.543758780508;5378.865528361783;6133.049377346519;6402.423781859655;6412.807615771534;6415.358464153594;6420.646864422455;4351.630111440531;4384.342348647697;4393.384926110347;4443.244648409745;4458.621017213541;6512.283648798629;6614.107095542088;6614.173228346457;6615.669216539202;6615.974523948747;4529.501754806968;4533.297338912474;4535.183666939916;4536.296873984537;4550.294704320836;4519.706219095814;4604.217283061887;4609.861704148881;4611.077784443125;4627.930581041287;5318.946810531923;5322.3879253885525;5323.866903327448;5327.706976116351;5336.119540275811;6382.489400847921;6427.55007149495;6427.710753016032;6434.099226108348;6439.227292724903;1604.8395160483858;1630.9429169978994;1632.9183540822912;1633.3711521064238;1634.9673006539801;1080.5839751695653;1093.2347356850237;1094.682542062793;1097.4512743628186;1125.1954852280658;6183.227096612924;6186.350433204539;6188.2883468400805;6194.5044396448175;6201.441870231701;6636.435902948304;6640.966795165993;6641.269460359356;6650.235222949326;6653.4677225821815;6016.939830601638;6170.753169873245;6171.938280617226;6178.69106544671;6185.319614842364;3562.287542491512;3586.300671369058;3587.551556055493;3587.695045921126;3589.138606734365;6829.180498340231;6842.4183944364295;6844.760433384808;6851.760188393382;6860.622665753332;6643.833904152339;6782.93217067823;6783.18601767791;6783.389494945479;6784.457243420515;6837.145356830396;6839.965800170968;6843.8973415398805;6844.247132815386;6850.897236541456;6420.967895160495;6583.0454584086;6611.33886611335;6621.304763000008;6627.50293727982;6445.097686324012;6592.340765923369;6612.305707900601;6614.933850661624;6615.768448104293;6830.453563714792;6864.965675171792;6869.519133660596;6874.450043996569;6901.309869013058;4450.755208463565;4551.47658019332;4557.156925968707;4558.908821823611;4560.315952607136;6641;6676.866462670817;6680.5991640501725;6681.933180668131;6687.465002799667;6496.090547323473;6507.609543427409;6508.576942498722;6508.804735857742;6510.674466276762;6370.8088757337355;6413;6460.192475940507;6473.287938326875;6487.22153341602;6385.169927909342;6392.0411938209645;6395.360463953567;6400.295967443671;6401.29585745577;6496.447801936888;6510.641914694737;6512.5766825156215;6513.1532900722605;6514;6179.567430279837;6298.559100863079;6345.302016778059;6358.77744278948;6359.300476947625 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: |5;yui.html;921.2952091649888;930.2743859789365;944.1078181118837;945.7777422305757;977.7751117243039;13951.302434878253;14395.856041439583;14427.134371937678;15062.096274223555;15109;13676.3161841908;13758.449662013532;13762.036657433984;13763;13777.311134443287;747.6560782040241;765.5291995422803;867.600903584352;896.9775755606097;900.4507250577143;910.5856835139996;914.2183433164648;914.5838643417229;916.7753900294438;921.741912264567;760.52467207995;938.0572524612754;952.9523523823816;955.2167222877209;956.0964888180672;771.1709911844762;773.6943907156669;775.3022279948035;914.739299299703;951.1914872358509;708.348319546019;708.5500707051008;708.6492186367781;708.6669265445232;708.8192510909737;13123.081384303103;13373.197608143446;13386.062975591713;13386.598402047954;13395.665108372272;12877.935610321982;13496.527621533298;13625.454981800716;13835.79246311306;13919.512817051354;11011.28426652265;11077.224594278403;11137.498812553455;11162.832557511643;11442.14183936208;3776.376897811858;3849.826757795906;3863.208042351311;3865.729398942075;3876.3022655921923;48807.26789098131;49090.7545462274;50244.49755502471;50469.24296135561;50689.49310506885;10807.78384432307;10833.67498975032;10959.342439453658;11060.336379817236;11150.163737719542;20291;20317.695234571493;20335.694964575545;20352.491187720425;20375.694364584542;7563.092428908456;7666.65500052499;7687.577183254974;7762.456628036096;7871.48835325702;4171.666266698718;4312.288472402081;4315.4605674290715;4346.869593912188;4366.759828209479;3232.095013396253;3243.9675603244136;3262.200760813616;3267.019894031781;3267.836608169582;553.7369749369018;562.5049956038741;591.618406128045;593.0481577068829;599.283855792324;642.8084560158741;676.1413005483009;708.1749761527763;734.3468178304578;736.2306389822648;8858.911410885938;9049.864252036225;9135.314851386172;9151;9329.58016889228;593.6097906041467;611.0406661541426;632.3076231526471;654.8068319845657;710.0237173885907;4336.479622445264;4458.4426946631675;4479.55204479556;4522.479914809774;4535.591796738309;60992.39007609867;64130.0380494293;65053.67473162604;65187.67406162939;67955.66022169858;50251.74874125606;50551.7472412643;50850.49149508531;52411;53287.20069198965;48845.26732099021;49147.262791057445;49594;50145;50161.36651831195;9411.152996230372;9575.281853860848;9616.567254473426;9811.264155188532;9835.901640983784;37172.44241336328;37790.43314350342;38079;38150.23699526049;38441.4233786499;43044;44710;46985.29522057103;47437.288440672724;47532.7623361881;11900.285982841056;11981.520739170335;12104.334261615695;12199.451024703732;12290.81563776562;13328.200307981551;13377.464901404224;13501.72996540044;13524.459021639417;14088.436462541384;12265.448054837732;12364.938175309426;12571.811422828849;13012.479500819862;13074.28091454979;12178.451969661564;12660.11379203447;12669.74660506803;12913;12918.160319579198;9396.342256042011;11783.76432471363;12007.339596322287;12191.939040304742;12648.873511265137;10318.43248621333;10492.79014419692;10901.509432075418;10916.607583307497;10953.56185752561;10268.743281418025;10314.793704126025;10317.17462602975;10360.222983276133;10711.89288107109 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,772 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: __startTimestamp1455099466082__endTimestamp 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,092 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5510.33 Median:5706.74 stddev:604.53 (10.6%) stddev-sans-first:580.48 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: Values: 3278.6 3315.5 3334.0 3337.7 3365.1 5433.2 5494.2 5494.4 5496.2 5510.7 5484.5 5502.4 5519.3 5524.0 5528.3 4940.3 4991.5 5014.4 5024.0 5039.1 4993.5 5015.5 5067.1 5109.9 5132.5 4961.7 5041.7 5046.1 5051.0 5053.5 5059.8 5119.3 5127.1 5130.4 5158.0 4876.4 4919.8 4966.0 5022.1 5036.8 5335.9 5360.7 5375.4 5376.6 5381.8 5960.0 5962.1 5966.1 5969.9 5977.6 5732.9 5802.3 5823.6 5874.6 5886.1 5625.4 5630.8 5632.3 5652.1 5652.3 5838.1 6114.2 6119.1 6119.8 6124.3 5667.1 5768.1 5810.5 5856.8 5869.4 5859.5 5917.1 5917.3 5922.9 5926.6 5706.7 5791.4 5861.7 5865.1 5866.6 5775.8 5843.4 5850.9 5855.4 5858.6 4598.6 4600.1 4629.4 4634.1 4648.6 3999.3 4066.0 4153.7 4165.0 4184.7 5560.1 5634.2 5641.1 5643.9 5676.8 6038.5 6073.8 6076.3 6080.7 6081.5 5395.2 5493.4 5548.1 5664.6 5671.4 5161.3 5201.1 5211.1 5217.8 5218.3 6178.1 6185.0 6199.2 6214.0 6226.3 5776.7 5825.4 5917.1 5925.0 6039.2 6116.3 6126.1 6130.0 6131.8 6136.4 5828.0 5883.6 5887.9 5898.9 5925.1 5723.6 5824.3 5896.8 5968.2 5971.0 5822.0 5869.5 5915.7 5921.3 5922.2 5866.8 5890.3 5904.5 5909.4 5910.3 5463.6 5553.0 5586.7 5651.8 5819.9 5731.5 5836.0 5852.0 5862.5 5864.2 5697.2 5705.4 5708.4 5713.2 5723.6 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54583.36 Median:19776.70 stddev:96104.37 (485.9%) stddev-sans-first:96288.48 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: Values: 595.5 620.3 637.1 640.7 688.1 33013.0 33412.3 37470.0 37883.0 37953.2 44806.8 45215.0 45333.0 45440.0 45473.1 8204.7 8983.4 9152.4 9153.0 9157.6 8358.3 10746.2 10880.2 10970.1 10970.2 10706.7 10821.1 10878.2 10881.5 10883.3 10722.3 10760.8 10829.2 10829.5 10833.7 10481.8 10624.4 10655.4 10672.8 10675.5 42092.4 42520.6 42568.8 42621.6 42712.1 3719.1 3723.3 3819.3 3855.3 3955.6 31365.5 31477.1 31557.7 31609.0 32171.2 4237.9 4251.5 4306.9 4353.4 4396.1 287301.0 289378.0 290111.0 290411.0 291806.0 58124.4 66358.3 66780.3 66846.0 66857.7 57625.0 77930.0 78320.0 78494.2 78673.0 17643.8 17782.0 17846.0 17910.1 17931.0 12374.1 12387.5 12392.1 12395.0 12417.3 21750.5 21820.3 22090.1 22129.3 22161.9 8211.7 8548.2 8618.9 8624.1 8694.4 1040.3 1079.7 1155.8 1160.7 1164.4 30085.0 30428.0 31377.2 31430.7 31585.0 1120.2 1136.1 1145.5 1157.5 1241.1 14188.0 14813.6 15114.2 15538.8 16122.8 452949.0 457727.0 461811.0 463482.0 465440.0 57077.0 57153.0 57191.7 57668.7 57685.4 1308.2 1398.2 1408.5 1479.5 1490.3 29831.0 29908.7 33925.5 34648.0 35179.8 47203.8 55913.0 56494.4 56537.4 56597.7 312449.0 322017.0 325734.0 326616.0 327350.0 44389.6 45050.0 45307.0 45598.0 46537.3 48735.8 48756.3 49139.8 49587.5 50252.5 40261.4 41483.6 41538.0 42042.2 42448.2 41280.0 42205.8 42231.4 45473.3 45635.8 39022.4 39756.2 39810.6 40028.4 40260.0 34860.0 35008.8 35296.6 35744.6 35834.3 26522.6 27431.0 27462.9 27464.6 27716.9 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28781.45 Median:18875.37 stddev:85813.66 (454.6%) stddev-sans-first:86027.85 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: Values: 359.1 360.3 361.5 364.0 367.1 15263.4 16242.2 17263.7 18305.7 19793.6 17433.2 17505.1 17555.2 17892.9 18040.5 5433.9 5559.7 5560.6 5581.9 5588.1 4309.6 4466.0 5528.3 5893.4 6176.0 6095.6 6164.3 6192.5 6194.3 6209.9 6092.8 6099.3 6124.1 6128.2 6147.2 5201.1 5260.4 5280.6 5283.3 5295.9 21322.8 21338.0 21491.7 22233.6 22344.6 2343.9 2364.6 2370.9 2381.2 2473.5 13730.4 13856.4 14164.2 14366.4 14390.9 1901.2 1912.8 1931.2 1947.7 1955.0 59982.0 62030.4 62898.4 63579.7 64252.4 9534.0 9607.5 9634.6 9675.2 9744.5 12725.2 12732.4 12734.2 12736.7 12739.7 7887.9 8126.6 8200.5 8210.7 8274.4 8085.3 8085.6 8155.9 8171.1 8348.5 6045.8 6048.7 6071.0 6075.1 6079.9 1581.6 1649.6 1671.5 1734.5 1744.9 1045.8 1049.6 1054.5 1066.3 1200.3 17746.6 17817.4 18022.4 18258.3 18463.4 995.3 1076.1 1084.9 1090.8 1093.9 5771.5 5928.9 5942.2 5995.5 9381.1 437947.0 438986.0 519110.0 583971.0 616019.0 70175.6 80167.0 85935.0 88317.6 92068.5 448.7 452.5 452.9 453.1 455.3 10145.2 10152.2 10211.2 10283.3 10309.3 37383.6 37436.6 38011.4 38516.6 38535.2 47354.5 47607.0 49287.0 50643.5 53469.7 9209.5 9577.4 9592.3 9627.5 9667.4 11244.5 11655.0 14817.6 17467.1 19151.6 15082.2 15134.9 15374.1 15392.6 15672.4 14051.3 14725.4 15375.9 15400.8 15572.1 14595.9 14740.1 15101.0 15389.2 15535.8 9919.6 9969.6 9970.3 10128.5 10365.3 15154.3 15159.0 15648.7 15843.4 16306.5 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,094 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5468.11 Median:6441.26 stddev:2781.45 (43.2%) stddev-sans-first:2773.66 02:17:46 INFO - 2016-02-10 02:17:46,095 DEBUG : BROWSER_OUTPUT: Values: 1550.2 1560.3 1779.6 1814.1 1845.5 7581.3 7931.6 7940.6 7945.2 7954.9 7677.0 7744.7 7753.2 7760.3 7766.5 2235.4 2272.0 2310.4 2311.0 2313.0 2292.9 2311.1 2312.3 2313.2 2313.4 2017.8 2077.8 2228.7 2230.3 2308.5 2243.5 2261.1 2279.8 2281.3 2281.9 2240.4 2274.6 2278.5 2279.4 2280.9 6718.4 6779.4 7492.7 7624.8 7633.2 4675.1 4728.7 4734.6 4737.4 4739.2 3012.6 3018.4 3046.5 3048.5 3090.7 1005.1 1033.2 1033.3 1078.2 1084.0 10471.4 10510.7 10531.8 10537.8 10553.5 4198.6 4210.1 4273.4 4282.5 4294.0 8993.6 8998.9 9004.3 9011.1 9019.3 4787.3 4788.2 4792.1 4796.5 4802.7 4395.5 4397.1 4397.4 4406.4 4408.3 3560.8 3628.9 3633.9 3640.2 3678.0 1103.5 1109.8 1113.6 1115.6 1128.5 1162.1 1174.8 1186.2 1187.9 1209.4 7394.3 7405.5 7439.8 7488.8 7507.6 1221.0 1227.8 1233.8 1239.3 1249.4 5652.2 5782.3 5831.3 5832.1 5839.3 8391.2 9154.5 9196.6 9221.5 9248.6 8807.8 9095.0 9128.5 9136.3 9138.5 7283.3 7375.4 7442.9 7448.2 7461.6 7200.6 7270.3 7298.6 7322.5 7328.3 7932.9 8207.7 8249.9 8253.6 8270.3 8169.8 8260.9 8384.7 8418.9 8547.7 6972.3 7044.7 7045.7 7060.0 7065.9 7538.6 7611.5 7619.8 7665.5 7682.8 7207.9 7212.8 7237.9 7288.1 7336.1 7061.8 7152.4 7166.5 7217.7 7246.1 7152.5 7225.0 7227.0 7232.6 7234.1 6390.0 6492.5 6550.6 6556.9 6561.7 6623.7 6644.3 6655.5 6660.2 6665.6 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5360.30 Median:6131.43 stddev:1626.63 (26.5%) stddev-sans-first:1586.73 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: Values: 327.7 330.6 330.7 332.3 332.9 5983.8 6047.3 6057.8 6066.7 6129.8 5906.9 5992.7 5996.0 5999.9 6004.3 4592.2 4599.8 4602.7 4610.9 4616.0 4418.8 4494.3 4528.7 4539.0 4605.4 4515.1 4519.6 4522.5 4525.7 4532.3 4535.0 4535.7 4537.0 4541.5 4548.0 3969.7 3970.1 3972.7 3974.0 3976.6 5617.2 5730.3 5751.2 5772.2 5778.9 5334.8 5358.9 5362.7 5367.5 5378.9 6133.0 6402.4 6412.8 6415.4 6420.6 4351.6 4384.3 4393.4 4443.2 4458.6 6512.3 6614.1 6614.2 6615.7 6616.0 4529.5 4533.3 4535.2 4536.3 4550.3 4519.7 4604.2 4609.9 4611.1 4627.9 5318.9 5322.4 5323.9 5327.7 5336.1 6382.5 6427.6 6427.7 6434.1 6439.2 1604.8 1630.9 1632.9 1633.4 1635.0 1080.6 1093.2 1094.7 1097.5 1125.2 6183.2 6186.4 6188.3 6194.5 6201.4 6636.4 6641.0 6641.3 6650.2 6653.5 6016.9 6170.8 6171.9 6178.7 6185.3 3562.3 3586.3 3587.6 3587.7 3589.1 6829.2 6842.4 6844.8 6851.8 6860.6 6643.8 6782.9 6783.2 6783.4 6784.5 6837.1 6840.0 6843.9 6844.2 6850.9 6421.0 6583.0 6611.3 6621.3 6627.5 6445.1 6592.3 6612.3 6614.9 6615.8 6830.5 6865.0 6869.5 6874.5 6901.3 4450.8 4551.5 4557.2 4558.9 4560.3 6641.0 6676.9 6680.6 6681.9 6687.5 6496.1 6507.6 6508.6 6508.8 6510.7 6370.8 6413.0 6460.2 6473.3 6487.2 6385.2 6392.0 6395.4 6400.3 6401.3 6496.4 6510.6 6512.6 6513.2 6514.0 6179.6 6298.6 6345.3 6358.8 6359.3 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14728.77 Median:4412.60 stddev:16930.65 (383.7%) stddev-sans-first:16946.39 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: Values: 921.3 930.3 944.1 945.8 977.8 13951.3 14395.9 14427.1 15062.1 15109.0 13676.3 13758.4 13762.0 13763.0 13777.3 747.7 765.5 867.6 897.0 900.5 910.6 914.2 914.6 916.8 921.7 760.5 938.1 953.0 955.2 956.1 771.2 773.7 775.3 914.7 951.2 708.3 708.6 708.6 708.7 708.8 13123.1 13373.2 13386.1 13386.6 13395.7 12877.9 13496.5 13625.5 13835.8 13919.5 11011.3 11077.2 11137.5 11162.8 11442.1 3776.4 3849.8 3863.2 3865.7 3876.3 48807.3 49090.8 50244.5 50469.2 50689.5 10807.8 10833.7 10959.3 11060.3 11150.2 20291.0 20317.7 20335.7 20352.5 20375.7 7563.1 7666.7 7687.6 7762.5 7871.5 4171.7 4312.3 4315.5 4346.9 4366.8 3232.1 3244.0 3262.2 3267.0 3267.8 553.7 562.5 591.6 593.0 599.3 642.8 676.1 708.2 734.3 736.2 8858.9 9049.9 9135.3 9151.0 9329.6 593.6 611.0 632.3 654.8 710.0 4336.5 4458.4 4479.6 4522.5 4535.6 60992.4 64130.0 65053.7 65187.7 67955.7 50251.7 50551.7 50850.5 52411.0 53287.2 48845.3 49147.3 49594.0 50145.0 50161.4 9411.2 9575.3 9616.6 9811.3 9835.9 37172.4 37790.4 38079.0 38150.2 38441.4 43044.0 44710.0 46985.3 47437.3 47532.8 11900.3 11981.5 12104.3 12199.5 12290.8 13328.2 13377.5 13501.7 13524.5 14088.4 12265.4 12364.9 12571.8 13012.5 13074.3 12178.5 12660.1 12669.7 12913.0 12918.2 9396.3 11783.8 12007.3 12191.9 12648.9 10318.4 10492.8 10901.5 10916.6 10953.6 10268.7 10314.8 10317.2 10360.2 10711.9 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:17:46 INFO - 2016-02-10 02:17:46,096 DEBUG : BROWSER_OUTPUT: 02:17:46 INFO - 2016-02-10 02:17:46,702 INFO : Browser exited with error code: 0 02:17:46 INFO - 2016-02-10 02:17:46,720 INFO : Completed test dromaeo_css (00:18:30) 02:17:46 INFO - 2016-02-10 02:17:46,720 INFO : Starting test kraken 02:17:46 INFO - 2016-02-10 02:17:46,720 DEBUG : operating with platform_type : linux_ 02:17:46 INFO - 2016-02-10 02:17:46,720 INFO : Initialising browser for kraken test... 02:17:46 INFO - 2016-02-10 02:17:46,727 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzti_0t/profile http://localhost:57265/getInfo.html 02:17:50 INFO - 2016-02-10 02:17:50,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:17:50 INFO - 2016-02-10 02:17:50,685 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:17:50 INFO - 2016-02-10 02:17:50,685 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:17:50 INFO - 2016-02-10 02:17:50,685 DEBUG : BROWSER_OUTPUT: __metrics 02:17:50 INFO - 2016-02-10 02:17:50,882 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:17:51 INFO - 2016-02-10 02:17:51,730 INFO : Browser initialized. 02:17:51 INFO - 2016-02-10 02:17:51,730 INFO : Running cycle 1/1 for kraken test... 02:17:51 INFO - 2016-02-10 02:17:51,731 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzti_0t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:18:03 INFO - 2016-02-10 02:18:03,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 132444160 02:18:03 INFO - 2016-02-10 02:18:03,401 DEBUG : BROWSER_OUTPUT: 02:18:05 INFO - 2016-02-10 02:18:05,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57265/tests/kraken/driver.html?testName=audio-beat-detection) 02:18:06 INFO - 2016-02-10 02:18:06,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 02:18:06 INFO - 2016-02-10 02:18:06,443 DEBUG : BROWSER_OUTPUT: 02:18:09 INFO - 2016-02-10 02:18:09,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57265/tests/kraken/driver.html?testName=audio-dft) 02:18:09 INFO - 2016-02-10 02:18:09,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 163033088 02:18:09 INFO - 2016-02-10 02:18:09,591 DEBUG : BROWSER_OUTPUT: 02:18:12 INFO - 2016-02-10 02:18:12,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57265/tests/kraken/driver.html?testName=audio-fft) 02:18:12 INFO - 2016-02-10 02:18:12,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 159809536 02:18:12 INFO - 2016-02-10 02:18:12,935 DEBUG : BROWSER_OUTPUT: 02:18:14 INFO - 2016-02-10 02:18:14,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57265/tests/kraken/driver.html?testName=audio-oscillator) 02:18:15 INFO - 2016-02-10 02:18:15,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 160620544 02:18:15 INFO - 2016-02-10 02:18:15,471 DEBUG : BROWSER_OUTPUT: 02:18:17 INFO - 2016-02-10 02:18:17,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:18:18 INFO - 2016-02-10 02:18:18,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 159215616 02:18:18 INFO - 2016-02-10 02:18:18,219 DEBUG : BROWSER_OUTPUT: 02:18:21 INFO - 2016-02-10 02:18:21,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57265/tests/kraken/driver.html?testName=imaging-darkroom) 02:18:21 INFO - 2016-02-10 02:18:21,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 158392320 02:18:21 INFO - 2016-02-10 02:18:21,678 DEBUG : BROWSER_OUTPUT: 02:18:25 INFO - 2016-02-10 02:18:25,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57265/tests/kraken/driver.html?testName=imaging-desaturate) 02:18:25 INFO - 2016-02-10 02:18:25,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 158699520 02:18:25 INFO - 2016-02-10 02:18:25,584 DEBUG : BROWSER_OUTPUT: 02:18:28 INFO - 2016-02-10 02:18:28,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57265/tests/kraken/driver.html?testName=json-parse-financial) 02:18:28 INFO - 2016-02-10 02:18:28,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 160067584 02:18:28 INFO - 2016-02-10 02:18:28,856 DEBUG : BROWSER_OUTPUT: 02:18:30 INFO - 2016-02-10 02:18:30,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:18:30 INFO - 2016-02-10 02:18:30,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 168132608 02:18:30 INFO - 2016-02-10 02:18:30,959 DEBUG : BROWSER_OUTPUT: 02:18:32 INFO - 2016-02-10 02:18:32,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:18:33 INFO - 2016-02-10 02:18:33,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 165441536 02:18:33 INFO - 2016-02-10 02:18:33,324 DEBUG : BROWSER_OUTPUT: 02:18:35 INFO - 2016-02-10 02:18:35,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:18:35 INFO - 2016-02-10 02:18:35,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 171343872 02:18:35 INFO - 2016-02-10 02:18:35,864 DEBUG : BROWSER_OUTPUT: 02:18:38 INFO - 2016-02-10 02:18:38,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:18:38 INFO - 2016-02-10 02:18:38,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 175489024 02:18:38 INFO - 2016-02-10 02:18:38,767 DEBUG : BROWSER_OUTPUT: 02:18:41 INFO - 2016-02-10 02:18:41,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:18:41 INFO - 2016-02-10 02:18:41,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 174501888 02:18:41 INFO - 2016-02-10 02:18:41,814 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57265/tests/kraken/driver.html?testName=ai-astar) 02:18:43 INFO - 2016-02-10 02:18:43,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 231555072 02:18:43 INFO - 2016-02-10 02:18:43,726 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,730 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:18:43 INFO - 2016-02-10 02:18:43,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:18:43 INFO - 2016-02-10 02:18:43,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:18:43 INFO - 2016-02-10 02:18:43,730 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:18:43 INFO - 2016-02-10 02:18:43,730 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;109;111;109;99;109;109;110 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;156;161;123;159;144;128;163;121 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;161;160;159;164;160;162;161;160 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;76;71;150;71;73;72;71;155;71 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;134;92;92;93;136;92;92;133 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;108;110;109;109;109;109;111;109;109 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;146;147;145;145;145;145 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;95;96;96;96;96 02:18:43 INFO - 2016-02-10 02:18:43,731 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;58;57;56;56;57;56;54;56 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;65;65;64;65;65;65;65 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;76;79;78;78;78;78;78;79;78 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;115;113;119;113;118;114;111;117;110 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;129;143;139;139;142;142;161;144;145;128 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;67;65;62;63;62;63;62;62 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:18:43 INFO - 2016-02-10 02:18:43,732 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:18:43 INFO - 2016-02-10 02:18:43,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 02:18:43 INFO - 2016-02-10 02:18:43,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:18:43 INFO - 2016-02-10 02:18:43,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1455099523727__endTimestamp 02:18:43 INFO - 2016-02-10 02:18:43,733 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,736 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:18:43 INFO - 2016-02-10 02:18:43,736 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:3.58 (3.3%) stddev-sans-first:3.77 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 109.0 111.0 109.0 99.0 109.0 109.0 110.0 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:152.50 stddev:17.56 (11.5%) stddev-sans-first:18.47 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 156.0 161.0 123.0 159.0 144.0 128.0 163.0 121.0 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.58 (1.0%) stddev-sans-first:1.58 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 161.0 160.0 159.0 164.0 160.0 162.0 161.0 160.0 02:18:43 INFO - 2016-02-10 02:18:43,737 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.10 Median:71.00 stddev:34.00 (47.9%) stddev-sans-first:35.49 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: Values: 71.0 76.0 71.0 150.0 71.0 73.0 72.0 71.0 155.0 71.0 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:20.33 (22.1%) stddev-sans-first:21.02 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 134.0 92.0 92.0 93.0 136.0 92.0 92.0 133.0 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 110.0 109.0 109.0 109.0 109.0 111.0 109.0 109.0 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 146.0 147.0 145.0 145.0 145.0 145.0 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,738 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 58.0 57.0 56.0 56.0 57.0 56.0 54.0 56.0 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:1.51 (1.9%) stddev-sans-first:0.87 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 82.0 76.0 79.0 78.0 78.0 78.0 78.0 78.0 79.0 78.0 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.50 stddev:3.01 (2.6%) stddev-sans-first:3.09 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 113.0 119.0 113.0 118.0 114.0 111.0 117.0 110.0 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:142.50 stddev:9.14 (6.4%) stddev-sans-first:8.56 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 129.0 143.0 139.0 139.0 142.0 142.0 161.0 144.0 145.0 128.0 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.78 (2.8%) stddev-sans-first:1.81 02:18:43 INFO - 2016-02-10 02:18:43,739 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 65.0 62.0 63.0 62.0 63.0 62.0 62.0 02:18:43 INFO - 2016-02-10 02:18:43,740 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:18:43 INFO - 2016-02-10 02:18:43,740 DEBUG : BROWSER_OUTPUT: 02:18:44 INFO - 2016-02-10 02:18:44,441 INFO : Browser exited with error code: 0 02:18:44 INFO - 2016-02-10 02:18:44,495 INFO : Completed test kraken (00:00:57) 02:18:44 INFO - 2016-02-10 02:18:44,495 INFO : Starting test v8_7 02:18:44 INFO - 2016-02-10 02:18:44,495 DEBUG : operating with platform_type : linux_ 02:18:44 INFO - 2016-02-10 02:18:44,495 INFO : Initialising browser for v8_7 test... 02:18:44 INFO - 2016-02-10 02:18:44,501 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ3dZs/profile http://localhost:57265/getInfo.html 02:18:48 INFO - 2016-02-10 02:18:48,645 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:18:48 INFO - 2016-02-10 02:18:48,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:18:48 INFO - 2016-02-10 02:18:48,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:18:48 INFO - 2016-02-10 02:18:48,645 DEBUG : BROWSER_OUTPUT: __metrics 02:18:48 INFO - 2016-02-10 02:18:48,794 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:49 INFO - 2016-02-10 02:18:49,738 INFO : Browser initialized. 02:18:49 INFO - 2016-02-10 02:18:49,738 INFO : Running cycle 1/1 for v8_7 test... 02:18:49 INFO - 2016-02-10 02:18:49,739 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ3dZs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:19:01 INFO - 2016-02-10 02:19:01,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 134524928 02:19:01 INFO - 2016-02-10 02:19:01,432 DEBUG : BROWSER_OUTPUT: 02:19:22 INFO - 2016-02-10 02:19:22,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57265/tests/v8_7/run.html (next: http://localhost:57265/tests/v8_7/run.html) 02:19:23 INFO - 2016-02-10 02:19:23,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 423444480 02:19:23 INFO - 2016-02-10 02:19:23,042 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,043 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:19:23 INFO - 2016-02-10 02:19:23,043 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:19:23 INFO - 2016-02-10 02:19:23,043 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:19:23 INFO - 2016-02-10 02:19:23,043 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:19:23 INFO - 2016-02-10 02:19:23,043 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 02:19:23 INFO - 2016-02-10 02:19:23,044 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.01650165016503 02:19:23 INFO - 2016-02-10 02:19:23,044 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 02:19:23 INFO - 2016-02-10 02:19:23,044 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 02:19:23 INFO - 2016-02-10 02:19:23,044 DEBUG : BROWSER_OUTPUT: |4;RayTrace;977.5171065493646 02:19:23 INFO - 2016-02-10 02:19:23,045 DEBUG : BROWSER_OUTPUT: |5;Earley;546.448087431694 02:19:23 INFO - 2016-02-10 02:19:23,045 DEBUG : BROWSER_OUTPUT: |6;Boyer;10923.91304347826 02:19:23 INFO - 2016-02-10 02:19:23,045 DEBUG : BROWSER_OUTPUT: |7;RegExp;24095.238095238095 02:19:23 INFO - 2016-02-10 02:19:23,046 DEBUG : BROWSER_OUTPUT: |8;Splay;527.1481286241434 02:19:23 INFO - 2016-02-10 02:19:23,046 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 02:19:23 INFO - 2016-02-10 02:19:23,046 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:19:23 INFO - 2016-02-10 02:19:23,047 DEBUG : BROWSER_OUTPUT: __startTimestamp1455099563041__endTimestamp 02:19:23 INFO - 2016-02-10 02:19:23,047 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,047 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:19:23 INFO - 2016-02-10 02:19:23,047 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:19:23 INFO - 2016-02-10 02:19:23,048 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,048 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,048 DEBUG : BROWSER_OUTPUT: Values: 165.6 02:19:23 INFO - 2016-02-10 02:19:23,048 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: Values: 165.0 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: Values: 278.6 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: Values: 5164.9 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:977.52 Median:977.52 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: Values: 977.5 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.45 Median:546.45 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: Values: 546.4 02:19:23 INFO - 2016-02-10 02:19:23,050 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10923.91 Median:10923.91 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: Values: 10923.9 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24095.24 Median:24095.24 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: Values: 24095.2 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.15 Median:527.15 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: Values: 527.1 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: Values: 4822.1 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:19:23 INFO - 2016-02-10 02:19:23,051 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-02-10 02:19:23,702 INFO : Browser exited with error code: 0 02:19:23 INFO - 2016-02-10 02:19:23,716 INFO : Completed test v8_7 (00:00:39) 02:19:24 INFO - 2016-02-10 02:19:24,104 INFO : Completed test suite (00:20:07) 02:19:24 INFO - 2016-02-10 02:19:24,104 DEBUG : Working with test: dromaeo_css 02:19:24 INFO - 2016-02-10 02:19:24,104 DEBUG : Generating results file: dromaeo_css 02:19:24 INFO - 2016-02-10 02:19:24,105 DEBUG : Working with test: kraken 02:19:24 INFO - 2016-02-10 02:19:24,105 DEBUG : Generating results file: kraken 02:19:24 INFO - 2016-02-10 02:19:24,106 INFO : javascript benchmark 02:19:24 INFO - 2016-02-10 02:19:24,106 DEBUG : Working with test: v8_7 02:19:24 INFO - 2016-02-10 02:19:24,106 DEBUG : Generating results file: v8_7 02:19:24 INFO - 2016-02-10 02:19:24,106 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:19:24 INFO - 2016-02-10 02:19:24,156 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 02:19:24 INFO - 2016-02-10 02:19:24,156 DEBUG : process_Request line: dromaeo_css 7295.86 graph.html#tests=[[72,53,35]] 02:19:24 INFO - 2016-02-10 02:19:24,156 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:19:24 INFO - 2016-02-10 02:19:24,185 DEBUG : process_Request line: kraken 1472.70 graph.html#tests=[[232,53,35]] 02:19:24 INFO - 2016-02-10 02:19:24,185 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:19:24 INFO - 2016-02-10 02:19:24,217 DEBUG : process_Request line: v8_7 23154.50 graph.html#tests=[[230,53,35]] 02:19:24 INFO - 2016-02-10 02:19:24,218 INFO : javascript benchmark 02:19:24 INFO - 2016-02-10 02:19:24,222 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3278.6229583597888, 3315.4860996545544, 3334.0164651427826, 3337.699607035366, 3365.1418888183516, 5433.239346491489, 5494.203340515623, 5494.36814766302, 5496.203050557677, 5510.724463776815, 5484.506394424501, 5502.449755024496, 5519.337679478458, 5523.972380138093, 5528.281323427958, 4940.333055037578, 4991.475895031024, 5014.398272207322, 5024.0, 5039.118154322979, 4993.500649935014, 5015.498450154992, 5067.138586440314, 5109.872253193681, 5132.538071573557, 4961.677490963094, 5041.672291301072, 5046.142155833517, 5050.964552266795, 5053.469385714502, 5059.772310246048, 5119.283300337956, 5127.051495473331, 5130.410002849682, 5157.974210128944, 4876.390451193601, 4919.77860996256, 4965.950340496585, 5022.146235140035, 5036.823711170092, 5335.946640533583, 5360.678359298455, 5375.43557926416, 5376.596755243333, 5381.7578208980685, 5960.0, 5962.07587823888, 5966.134910438005, 5969.910451343233, 5977.551683623702, 5732.942670573324, 5802.274715660543, 5823.56323275756, 5874.588778785486, 5886.087656413263, 5625.409332020161, 5630.774769009235, 5632.267805185382, 5652.09566469367, 5652.321721393377, 5838.12428135783, 6114.2357205349335, 6119.143319935212, 6119.84700382494, 6124.265088189446, 5667.093265077568, 5768.077107662753, 5810.477057064884, 5856.824295271149, 5869.383714709979, 5859.531237501075, 5917.142014407887, 5917.260342457193, 5922.8815423691285, 5926.614770039933, 5706.743196556165, 5791.362950075489, 5861.70691465425, 5865.061590145556, 5866.589338746332, 5775.768969241268, 5843.444872737083, 5850.9414905851245, 5855.355910849803, 5858.619189752652, 4598.609118224988, 4600.056988317387, 4629.3518907353, 4634.073185362941, 4648.628109751212, 3999.2601368746873, 4065.9796701016307, 4153.7300075494995, 4164.979175104105, 4184.707070505096, 5560.054790685593, 5634.239377684042, 5641.097424412074, 5643.943560564424, 5676.772929082873, 6038.486728628028, 6073.848153796102, 6076.270847498328, 6080.695965201722, 6081.483073938764, 5395.163749618815, 5493.368262649767, 5548.0845660465575, 5664.631798933056, 5671.404502527258, 5161.303224064778, 5201.115810312256, 5211.062008838369, 5217.765200565907, 5218.269442278084, 6178.104174894615, 6185.041318595625, 6199.194104766351, 6214.036824292242, 6226.315105338409, 5776.653400795965, 5825.446582574648, 5917.082852157922, 5924.9703751480965, 6039.184710064085, 6116.320830008016, 6126.131514934082, 6129.969350153221, 6131.785387511416, 6136.386361363828, 5827.970860145672, 5883.588148829541, 5887.852803679943, 5898.9115163273445, 5925.111233315038, 5723.627964182315, 5824.271966004249, 5896.7936122235515, 5968.194293770285, 5971.044632858721, 5821.970890145522, 5869.530437564899, 5915.674637894957, 5921.319048309328, 5922.200502932049, 5866.765329386777, 5890.322612899571, 5904.527637789052, 5909.438603332676, 5910.261217347832, 5463.617546771688, 5552.972235138798, 5586.748596313095, 5651.773929042956, 5819.94180058194, 5731.455511726379, 5836.037053886062, 5852.0, 5862.472377486047, 5864.208331875142, 5697.23087383198, 5705.429457054427, 5708.372079071216, 5713.171590119493, 5723.599348045597], "unit": "ms", "name": "dojo.html", "value": 5471.653289032401}, {"lowerIsBetter": false, "replicates": [595.5295316699808, 620.3269452643881, 637.1398611873974, 640.7020735358058, 688.0985908459915, 33013.0, 33412.331753364946, 37470.0, 37883.0, 37953.24093518128, 44806.77596612021, 45215.0, 45333.0, 45440.0, 45473.090538189215, 8204.671813127468, 8983.371164018537, 9152.405093668924, 9153.0, 9157.633694652206, 8358.289545388649, 10746.194035447374, 10880.238383313172, 10970.122390208804, 10970.232083754141, 10706.732331691692, 10821.080208182313, 10878.184136189779, 10881.510332035077, 10883.346999180074, 10722.303050301705, 10760.78478430435, 10829.187810914174, 10829.458527073615, 10833.729156771065, 10481.842772358421, 10624.415657138854, 10655.360678359324, 10672.786544269149, 10675.519601617945, 42092.368614470804, 42520.574794251974, 42568.78715606433, 42621.57378426207, 42712.145757084996, 3719.107414220595, 3723.2925744108534, 3819.2743378757946, 3855.267499175148, 3955.584663610337, 31365.52951705726, 31477.055688329387, 31557.684423155933, 31609.0, 32171.19572010695, 4237.894052648709, 4251.4685664291965, 4306.913861722779, 4353.36876152956, 4396.1427521633295, 287301.0, 289378.0, 290111.0, 290411.0, 291806.0, 58124.4187558119, 66358.33641663521, 66780.33219667838, 66846.0, 66857.6657116721, 57625.0, 77930.0, 78320.0, 78494.21505784869, 78673.0, 17643.823561764217, 17782.0, 17846.0, 17910.10449477521, 17931.0, 12374.071944604191, 12387.504499820086, 12392.070594705434, 12395.0, 12417.254964702146, 21750.45623859416, 21820.345389638336, 22090.116395344005, 22129.33611991643, 22161.889190554266, 8211.671533138728, 8548.230659240699, 8618.913810861937, 8624.137586241326, 8694.434861733967, 1040.3081950502983, 1079.7030816525519, 1155.78040172367, 1160.7272291011604, 1164.441068287227, 30085.0, 30428.0, 31377.215569610944, 31430.685693143234, 31585.0, 1120.2270433400927, 1136.1138312116561, 1145.4902568357002, 1157.5311998640564, 1241.1498123785236, 14188.0, 14813.555593332218, 15114.244287785566, 15538.766918496232, 16122.838771612134, 452949.0, 457727.0, 461811.0, 463482.0, 465440.0, 57077.0, 57153.0, 57191.71404142953, 57668.71165644145, 57685.423145768844, 1308.2281453942219, 1398.1960372785486, 1408.485902645527, 1479.4821812365801, 1490.2846633615925, 29831.0, 29908.700912990593, 33925.49111763375, 34648.0, 35179.824100879334, 47203.76398117987, 55913.0, 56494.435055648915, 56537.434625653215, 56597.71701141468, 312449.0, 322017.0, 325734.0, 326616.0, 327350.0, 44389.556104439835, 45050.0, 45307.0, 45598.0, 46537.30194047024, 48735.75632121817, 48756.268655970896, 49139.754301229696, 49587.50412495829, 50252.49747502478, 40261.39607905942, 41483.585164147975, 41538.0, 42042.1591568173, 42448.15103697847, 41280.0, 42205.78897105495, 42231.366529502695, 45473.317900232185, 45635.77182114068, 39022.41466378063, 39756.2048759029, 39810.601893981846, 40028.399574006995, 40260.0, 34860.0, 35008.824955875054, 35296.647033529334, 35744.64255357517, 35834.28331433409, 26522.60216096799, 27431.039913602926, 27462.862685686443, 27464.588031179148, 27716.858384394876], "unit": "ms", "name": "ext.html", "value": 20858.91726673014}, {"lowerIsBetter": false, "replicates": [359.1470258136925, 360.3225935241745, 361.52459515736786, 363.95632524097107, 367.1152522420966, 15263.389464421438, 16242.18789060548, 17263.741043884336, 18305.72541411878, 19793.60412791743, 17433.21550530226, 17505.124743762826, 17555.2100155493, 17892.910535447303, 18040.54898627535, 5433.945660543393, 5559.666420014792, 5560.555155587544, 5581.944180558204, 5588.077967135418, 4309.6336811371075, 4466.039801442689, 5528.281323427948, 5893.351731309553, 6175.969120154393, 6095.573309868311, 6164.29110652274, 6192.504599632019, 6194.349593292707, 6209.937900621004, 6092.786752463665, 6099.298580663236, 6124.112003759475, 6128.172696685935, 6147.231596050494, 5201.063808514466, 5260.395054568736, 5280.551153151987, 5283.313169288006, 5295.920561191585, 21322.78677213239, 21338.0, 21491.67762483564, 22233.555328893493, 22344.55310893773, 2343.94140146496, 2364.609839376501, 2370.9425833766654, 2381.226101517014, 2473.517664055492, 13730.382132804049, 13856.376463059187, 14164.150150990974, 14366.35351409189, 14390.928045359811, 1901.1634880652468, 1912.8182822631827, 1931.198552600669, 1947.6883698608156, 1954.9668344921265, 59982.0, 62030.37969620336, 62898.37101628971, 63579.68210158966, 64252.3574764251, 9533.952330238442, 9607.51962401877, 9634.614615415445, 9675.225981921429, 9744.46405447693, 12725.172863763826, 12732.363381830872, 12734.172278801849, 12736.6815829605, 12739.745205095845, 7887.881681774778, 8126.634301456449, 8200.548969806718, 8210.712625058095, 8274.379421543408, 8085.272325490617, 8085.555294458862, 8155.918440815634, 8171.060328062349, 8348.499090054616, 6045.818625441244, 6048.697565121726, 6070.969645151746, 6075.1191077294425, 6079.878402432015, 1581.612504936298, 1649.6205872649357, 1671.4651311580178, 1734.4709863491503, 1744.8691348148939, 1045.843123531461, 1049.569676432659, 1054.456954668331, 1066.3282132256784, 1200.2558413783336, 17746.649148486467, 17817.376391826485, 18022.36921707734, 18258.269669213347, 18463.446096617125, 995.2828777437636, 1076.0638244726981, 1084.9240553161203, 1090.820014697566, 1093.94530273486, 5771.451712087345, 5928.8814223716145, 5942.197803296586, 5995.52035837132, 9381.061893810564, 437947.0, 438986.0, 519110.0, 583971.0, 616019.0, 70175.64912175406, 80167.0, 85935.0, 88317.55841220752, 92068.53965730262, 448.74645825108706, 452.5293694557689, 452.87319550526564, 453.09833431471134, 455.257929574791, 10145.188384929335, 10152.238582106223, 10211.234157438073, 10283.33158344735, 10309.278350515691, 37383.626163738016, 37436.625633743315, 38011.42982855204, 38516.6148338513, 38535.229295414494, 47354.52645473639, 47607.0, 49287.0, 50643.49356506388, 53469.7326513365, 9209.493477858781, 9577.425354478753, 9592.328537002622, 9627.470489123165, 9667.371620844622, 11244.493997770283, 11655.0, 14817.555473335817, 17467.12664366751, 19151.61696766029, 15082.24588770535, 15134.924325378302, 15374.077555346716, 15392.615184620474, 15672.373105076125, 14051.297435128407, 14725.410983560538, 15375.923120384326, 15400.768988465406, 15572.143532105843, 14595.854041459874, 14740.11559306445, 15101.0, 15389.153596551849, 15535.766963495782, 9919.553620086968, 9969.601215951281, 9970.252231082553, 10128.544215510467, 10365.326253793479, 15154.3180556873, 15159.0, 15648.687026259639, 15843.366265349257, 16306.510804675878], "unit": "ms", "name": "jquery.html", "value": 8961.100323621451}, {"lowerIsBetter": false, "replicates": [1550.1629120275045, 1560.2822701557284, 1779.6351747891683, 1814.0929535232383, 1845.483264685888, 7581.317681408672, 7931.563763992978, 7940.602969851513, 7945.205479452059, 7954.92045079549, 7676.961615191916, 7744.728934487294, 7753.224677532244, 7760.301572858441, 7766.495177813452, 2235.35174799308, 2271.954560908785, 2310.3992961829963, 2311.0178174275948, 2312.9537409251807, 2292.8509646872985, 2311.087120587367, 2312.3409828198965, 2313.1903833658253, 2313.35226136682, 2017.778044415113, 2077.7610574783866, 2228.6545585434283, 2230.2528652901215, 2308.549832782608, 2243.4839986803045, 2261.050358849287, 2279.8290128240446, 2281.3384118605586, 2281.8744969026698, 2240.3614969733712, 2274.636058230675, 2278.5101203241384, 2279.4415368234722, 2280.863148211096, 6718.361755633207, 6779.389854913082, 7492.737754178577, 7624.847503049908, 7633.198514155989, 4675.111728771557, 4728.69263497875, 4734.597559207437, 4737.407824021997, 4739.170645137122, 3012.578239046535, 3018.3661431099495, 3046.5277881928337, 3048.4665183592783, 3090.6600273969843, 1005.0903931941605, 1033.2354057997104, 1033.2612182289624, 1078.229066217658, 1083.9810578056602, 10471.424071676054, 10510.684679459628, 10531.789364212673, 10537.841932371097, 10553.472326383728, 4198.6431153352305, 4210.115875666083, 4273.444452221192, 4282.464691913511, 4293.97853010733, 8993.55032248385, 8998.910010899937, 9004.324675649352, 9011.053839346774, 9019.32355073359, 4787.281907713871, 4788.233882578771, 4792.113459010095, 4796.5203479651755, 4802.6638135330195, 4395.450568678915, 4397.076613911115, 4397.406350142754, 4406.383106365111, 4408.338749187647, 3560.786352818839, 3628.9455658165148, 3633.8728144515344, 3640.199156185635, 3678.0, 1103.4979084516526, 1109.7503061811028, 1113.6492005018392, 1115.642994241851, 1128.514738662383, 1162.0993729859426, 1174.7944109780753, 1186.1815347410432, 1187.8752730963297, 1209.4013463335705, 7394.334509894135, 7405.481616286808, 7439.776806695808, 7488.775336739906, 7507.5870827103945, 1220.9572664956684, 1227.8403807505147, 1233.8210959410835, 1239.305988646361, 1249.375312343828, 5652.208690783294, 5782.306123265235, 5831.300243970751, 5832.066869300891, 5839.2992840858515, 8391.202835730595, 9154.496502692416, 9196.586153623102, 9221.49281789508, 9248.630054797868, 8807.823843523094, 9095.045020272775, 9128.543572821332, 9136.269098472107, 9138.54307284633, 7283.308085731847, 7375.4099672026105, 7442.925570744332, 7448.217937116525, 7461.552306861606, 7200.639968001684, 7270.272972702687, 7298.598577078312, 7322.487425880137, 7328.303811137934, 7932.920670793218, 8207.71273005442, 8249.876251856347, 8253.587320633824, 8270.25567698886, 8169.795755105933, 8260.917390826015, 8384.664613415394, 8418.87371689413, 8547.74356769298, 6972.26791186918, 7044.718211271696, 7045.682944267418, 7060.0, 7065.894011589933, 7538.585377804054, 7611.467197296358, 7619.847603048019, 7665.463417560717, 7682.769516914502, 7207.891881621885, 7212.783616491513, 7237.855242895218, 7288.12542494904, 7336.082989626297, 7061.788146355618, 7152.356287934111, 7166.462515311268, 7217.7112915484895, 7246.058012458347, 7152.463565232732, 7225.0, 7227.0, 7232.602206878461, 7234.059572255573, 6390.041493775971, 6492.480601551959, 6550.639714815731, 6556.901646475402, 6561.704723287559, 6623.735050597922, 6644.33556644351, 6655.467562594884, 6660.167479065117, 6665.566738162004], "unit": "ms", "name": "mootools.html", "value": 4519.79518395949}, {"lowerIsBetter": false, "replicates": [327.6985173640251, 330.5851156798218, 330.7403688104838, 332.28558599012126, 332.89347408829167, 5983.790567330134, 6047.274327080751, 6057.848553786158, 6066.666333351669, 6129.81610551683, 5906.852328691785, 5992.700364981744, 5995.9700201499045, 5999.880002399949, 6004.3395226525045, 4592.196365636017, 4599.816007359702, 4602.700824446417, 4610.907781844361, 4616.007558374957, 4418.82324707013, 4494.280915053592, 4528.660350473711, 4538.954610453903, 4605.37827393301, 4515.05183911379, 4519.615832654228, 4522.525134860842, 4525.660575456837, 4532.252178390561, 4535.047639995605, 4535.7278563286145, 4536.977315113403, 4541.477730061052, 4547.954520454819, 3969.7419667721792, 3970.086880017612, 3972.6623237024887, 3974.046228905071, 3976.5824588418377, 5617.185508101344, 5730.283714535683, 5751.194832723422, 5772.191893134965, 5778.942210577925, 5334.813281535166, 5358.892822143574, 5362.705051222181, 5367.543758780508, 5378.865528361783, 6133.049377346519, 6402.423781859655, 6412.807615771534, 6415.358464153594, 6420.646864422455, 4351.630111440531, 4384.342348647697, 4393.384926110347, 4443.244648409745, 4458.621017213541, 6512.283648798629, 6614.107095542088, 6614.173228346457, 6615.669216539202, 6615.974523948747, 4529.501754806968, 4533.297338912474, 4535.183666939916, 4536.296873984537, 4550.294704320836, 4519.706219095814, 4604.217283061887, 4609.861704148881, 4611.077784443125, 4627.930581041287, 5318.946810531923, 5322.3879253885525, 5323.866903327448, 5327.706976116351, 5336.119540275811, 6382.489400847921, 6427.55007149495, 6427.710753016032, 6434.099226108348, 6439.227292724903, 1604.8395160483858, 1630.9429169978994, 1632.9183540822912, 1633.3711521064238, 1634.9673006539801, 1080.5839751695653, 1093.2347356850237, 1094.682542062793, 1097.4512743628186, 1125.1954852280658, 6183.227096612924, 6186.350433204539, 6188.2883468400805, 6194.5044396448175, 6201.441870231701, 6636.435902948304, 6640.966795165993, 6641.269460359356, 6650.235222949326, 6653.4677225821815, 6016.939830601638, 6170.753169873245, 6171.938280617226, 6178.69106544671, 6185.319614842364, 3562.287542491512, 3586.300671369058, 3587.551556055493, 3587.695045921126, 3589.138606734365, 6829.180498340231, 6842.4183944364295, 6844.760433384808, 6851.760188393382, 6860.622665753332, 6643.833904152339, 6782.93217067823, 6783.18601767791, 6783.389494945479, 6784.457243420515, 6837.145356830396, 6839.965800170968, 6843.8973415398805, 6844.247132815386, 6850.897236541456, 6420.967895160495, 6583.0454584086, 6611.33886611335, 6621.304763000008, 6627.50293727982, 6445.097686324012, 6592.340765923369, 6612.305707900601, 6614.933850661624, 6615.768448104293, 6830.453563714792, 6864.965675171792, 6869.519133660596, 6874.450043996569, 6901.309869013058, 4450.755208463565, 4551.47658019332, 4557.156925968707, 4558.908821823611, 4560.315952607136, 6641.0, 6676.866462670817, 6680.5991640501725, 6681.933180668131, 6687.465002799667, 6496.090547323473, 6507.609543427409, 6508.576942498722, 6508.804735857742, 6510.674466276762, 6370.8088757337355, 6413.0, 6460.192475940507, 6473.287938326875, 6487.22153341602, 6385.169927909342, 6392.0411938209645, 6395.360463953567, 6400.295967443671, 6401.29585745577, 6496.447801936888, 6510.641914694737, 6512.5766825156215, 6513.1532900722605, 6514.0, 6179.567430279837, 6298.559100863079, 6345.302016778059, 6358.77744278948, 6359.300476947625], "unit": "ms", "name": "prototype.html", "value": 4829.639646304702}, {"lowerIsBetter": false, "replicates": [921.2952091649888, 930.2743859789365, 944.1078181118837, 945.7777422305757, 977.7751117243039, 13951.302434878253, 14395.856041439583, 14427.134371937678, 15062.096274223555, 15109.0, 13676.3161841908, 13758.449662013532, 13762.036657433984, 13763.0, 13777.311134443287, 747.6560782040241, 765.5291995422803, 867.600903584352, 896.9775755606097, 900.4507250577143, 910.5856835139996, 914.2183433164648, 914.5838643417229, 916.7753900294438, 921.741912264567, 760.52467207995, 938.0572524612754, 952.9523523823816, 955.2167222877209, 956.0964888180672, 771.1709911844762, 773.6943907156669, 775.3022279948035, 914.739299299703, 951.1914872358509, 708.348319546019, 708.5500707051008, 708.6492186367781, 708.6669265445232, 708.8192510909737, 13123.081384303103, 13373.197608143446, 13386.062975591713, 13386.598402047954, 13395.665108372272, 12877.935610321982, 13496.527621533298, 13625.454981800716, 13835.79246311306, 13919.512817051354, 11011.28426652265, 11077.224594278403, 11137.498812553455, 11162.832557511643, 11442.14183936208, 3776.376897811858, 3849.826757795906, 3863.208042351311, 3865.729398942075, 3876.3022655921923, 48807.26789098131, 49090.7545462274, 50244.49755502471, 50469.24296135561, 50689.49310506885, 10807.78384432307, 10833.67498975032, 10959.342439453658, 11060.336379817236, 11150.163737719542, 20291.0, 20317.695234571493, 20335.694964575545, 20352.491187720425, 20375.694364584542, 7563.092428908456, 7666.65500052499, 7687.577183254974, 7762.456628036096, 7871.48835325702, 4171.666266698718, 4312.288472402081, 4315.4605674290715, 4346.869593912188, 4366.759828209479, 3232.095013396253, 3243.9675603244136, 3262.200760813616, 3267.019894031781, 3267.836608169582, 553.7369749369018, 562.5049956038741, 591.618406128045, 593.0481577068829, 599.283855792324, 642.8084560158741, 676.1413005483009, 708.1749761527763, 734.3468178304578, 736.2306389822648, 8858.911410885938, 9049.864252036225, 9135.314851386172, 9151.0, 9329.58016889228, 593.6097906041467, 611.0406661541426, 632.3076231526471, 654.8068319845657, 710.0237173885907, 4336.479622445264, 4458.4426946631675, 4479.55204479556, 4522.479914809774, 4535.591796738309, 60992.39007609867, 64130.0380494293, 65053.67473162604, 65187.67406162939, 67955.66022169858, 50251.74874125606, 50551.7472412643, 50850.49149508531, 52411.0, 53287.20069198965, 48845.26732099021, 49147.262791057445, 49594.0, 50145.0, 50161.36651831195, 9411.152996230372, 9575.281853860848, 9616.567254473426, 9811.264155188532, 9835.901640983784, 37172.44241336328, 37790.43314350342, 38079.0, 38150.23699526049, 38441.4233786499, 43044.0, 44710.0, 46985.29522057103, 47437.288440672724, 47532.7623361881, 11900.285982841056, 11981.520739170335, 12104.334261615695, 12199.451024703732, 12290.81563776562, 13328.200307981551, 13377.464901404224, 13501.72996540044, 13524.459021639417, 14088.436462541384, 12265.448054837732, 12364.938175309426, 12571.811422828849, 13012.479500819862, 13074.28091454979, 12178.451969661564, 12660.11379203447, 12669.74660506803, 12913.0, 12918.160319579198, 9396.342256042011, 11783.76432471363, 12007.339596322287, 12191.939040304742, 12648.873511265137, 10318.43248621333, 10492.79014419692, 10901.509432075418, 10916.607583307497, 10953.56185752561, 10268.743281418025, 10314.793704126025, 10317.17462602975, 10360.222983276133, 10711.89288107109], "unit": "ms", "name": "yui.html", "value": 6754.807850838248}], "name": "dromaeo_css", "value": 7295.862791344627}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 111.0, 109.0, 99.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 156.0, 161.0, 123.0, 159.0, 144.0, 128.0, 163.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 161.0, 160.0, 159.0, 164.0, 160.0, 162.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 71.0, 150.0, 71.0, 73.0, 72.0, 71.0, 155.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 134.0, 92.0, 92.0, 93.0, 136.0, 92.0, 92.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 57.0, 56.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [82.0, 76.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [112.0, 115.0, 113.0, 119.0, 113.0, 118.0, 114.0, 111.0, 117.0, 110.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [129.0, 143.0, 139.0, 139.0, 142.0, 142.0, 161.0, 144.0, 145.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 65.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.6}], "name": "kraken", "value": 1472.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "DeltaBlue", "value": 400.6750800000002}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [977.5171065493646], "unit": "score", "name": "RayTrace", "value": 757.008747}, {"lowerIsBetter": false, "replicates": [546.448087431694], "unit": "score", "name": "Earley", "value": 1219.6272900000001}, {"lowerIsBetter": false, "replicates": [10923.91304347826], "unit": "score", "name": "Boyer", "value": 61.0095482587065}, {"lowerIsBetter": false, "replicates": [24095.238095238095], "unit": "score", "name": "RegExp", "value": 37.80767786561265}, {"lowerIsBetter": false, "replicates": [527.1481286241434], "unit": "score", "name": "Splay", "value": 154.588427}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23154.50349177823}]} 02:19:24 INFO - RETURN: dromaeo_css: 7295.86 02:19:24 INFO - RETURN: kraken: 1472.70 02:19:24 INFO - RETURN: v8_7: 23154.50 02:19:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23154.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7295.86"}}} 02:19:24 INFO - Return code: 0 02:19:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:19:24 INFO - # TBPL SUCCESS # 02:19:24 INFO - Running post-action listener: _resource_record_post_action 02:19:24 INFO - Running post-run listener: _resource_record_post_run 02:19:25 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 483328; Write bytes: 362676224; Read time: 264; Write time: 218864 02:19:25 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 43597824; Read time: 0; Write time: 34484 02:19:25 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 479232; Write bytes: 264937472; Read time: 140; Write time: 160784 02:19:25 INFO - Running post-run listener: _upload_blobber_files 02:19:25 INFO - Blob upload gear active. 02:19:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:19:25 INFO - Copying logs to upload dir... 02:19:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.649776 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-10 02:19:25.351662) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:19:25.355630) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010007 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455089731/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:19:25.411139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:19:25.411885) ========= 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=c6927cf182745ad25b1d38b9000001fe-1455098051.627583-551186198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:19:25.463412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 02:19:25.463732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 02:19:25.464039) ========= ========= Total master_lag: 0.30 =========