builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1454161272.38 results: success (0) buildid: 20160130031626 builduid: c1cffcab0c324579aee07de8fcf189e6 revision: 9a3a83ab43e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.377569) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.378349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.378664) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004987 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.423259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.423542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.490637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.490928) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.043721 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.546665) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.546960) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.547297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.547563) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-30 05:41:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-01-30 05:41:12 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.755100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.755424) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071736 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.872781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:12.873093) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a3a83ab43e7 --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 9a3a83ab43e7 --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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-30 05:41:12,943 Setting DEBUG logging. 2016-01-30 05:41:12,943 attempt 1/10 2016-01-30 05:41:12,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9a3a83ab43e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-30 05:41:13,480 unpacking tar archive at: mozilla-beta-9a3a83ab43e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.844299 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:13.730080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:13.730415) ========= echo 9a3a83ab43e7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9a3a83ab43e7'] 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9a3a83ab43e7 program finished with exit code 0 elapsedTime=0.004695 script_repo_revision: '9a3a83ab43e7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:13.780396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:13.780706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-30 05:41:13.790315) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-30 05:41:13.790621) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:14 INFO - MultiFileLogger online at 20160130 05:41:14 in /builds/slave/test-pgo 05:41:14 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 05:41:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:41:14 INFO - {'append_to_log': False, 05:41:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:41:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:41:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:41:14 INFO - 'branch': 'Mozilla-Beta', 05:41:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:14 INFO - 'config_files': ('talos/linux_config.py',), 05:41:14 INFO - 'default_actions': ('clobber', 05:41:14 INFO - 'read-buildbot-config', 05:41:14 INFO - 'download-and-extract', 05:41:14 INFO - 'populate-webroot', 05:41:14 INFO - 'create-virtualenv', 05:41:14 INFO - 'install', 05:41:14 INFO - 'run-tests'), 05:41:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:14 INFO - 'download_minidump_stackwalk': True, 05:41:14 INFO - 'download_symbols': 'ondemand', 05:41:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:14 INFO - 'installer_path': 'installer.exe', 05:41:14 INFO - 'log_level': 'info', 05:41:14 INFO - 'log_name': 'talos', 05:41:14 INFO - 'log_to_console': True, 05:41:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:14 INFO - 'opt_config_files': (), 05:41:14 INFO - 'pip_index': False, 05:41:14 INFO - 'sps_profile': False, 05:41:14 INFO - 'sps_profile_interval': 0, 05:41:14 INFO - 'suite': 'dromaeojs', 05:41:14 INFO - 'system_bits': '32', 05:41:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:14 INFO - 'title': 'talos-linux64-ix-007', 05:41:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:14 INFO - 'use_talos_json': True, 05:41:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:41:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:14 INFO - 'work_dir': 'build'} 05:41:14 INFO - ##### 05:41:14 INFO - ##### Running clobber step. 05:41:14 INFO - ##### 05:41:14 INFO - Running pre-action listener: _resource_record_pre_action 05:41:14 INFO - Running main action method: clobber 05:41:14 INFO - rmtree: /builds/slave/test-pgo/build 05:41:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:41:18 INFO - Running post-action listener: _resource_record_post_action 05:41:18 INFO - ##### 05:41:18 INFO - ##### Running read-buildbot-config step. 05:41:18 INFO - ##### 05:41:18 INFO - Running pre-action listener: _resource_record_pre_action 05:41:18 INFO - Running main action method: read_buildbot_config 05:41:18 INFO - Using buildbot properties: 05:41:18 INFO - { 05:41:18 INFO - "properties": { 05:41:18 INFO - "buildnumber": 94, 05:41:18 INFO - "product": "firefox", 05:41:18 INFO - "script_repo_revision": "production", 05:41:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:41:18 INFO - "repository": "", 05:41:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:41:18 INFO - "buildid": "20160130031626", 05:41:18 INFO - "slavename": "talos-linux64-ix-007", 05:41:18 INFO - "pgo_build": "True", 05:41:18 INFO - "basedir": "/builds/slave/test-pgo", 05:41:18 INFO - "project": "", 05:41:18 INFO - "platform": "ubuntu64_hw", 05:41:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:41:18 INFO - "slavebuilddir": "test", 05:41:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:41:18 INFO - "branch": "mozilla-beta", 05:41:18 INFO - "repo_path": "releases/mozilla-beta", 05:41:18 INFO - "stage_platform": "linux64-pgo", 05:41:18 INFO - "builduid": "c1cffcab0c324579aee07de8fcf189e6", 05:41:18 INFO - "revision": "9a3a83ab43e7" 05:41:18 INFO - }, 05:41:18 INFO - "sourcestamp": { 05:41:18 INFO - "repository": "", 05:41:18 INFO - "hasPatch": false, 05:41:18 INFO - "project": "", 05:41:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:41:18 INFO - "changes": [ 05:41:18 INFO - { 05:41:18 INFO - "category": null, 05:41:18 INFO - "files": [ 05:41:18 INFO - { 05:41:18 INFO - "url": null, 05:41:18 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2" 05:41:18 INFO - } 05:41:18 INFO - ], 05:41:18 INFO - "repository": "", 05:41:18 INFO - "rev": "9a3a83ab43e7", 05:41:18 INFO - "who": "sendchange", 05:41:18 INFO - "when": 1454161240, 05:41:18 INFO - "number": 7538848, 05:41:18 INFO - "comments": "No bug, Automated blocklist update from host bld-linux64-spot-273 - a=blocklist-update", 05:41:18 INFO - "project": "", 05:41:18 INFO - "at": "Sat 30 Jan 2016 05:40:40", 05:41:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:41:18 INFO - "revlink": "", 05:41:18 INFO - "properties": [ 05:41:18 INFO - [ 05:41:18 INFO - "buildid", 05:41:18 INFO - "20160130031626", 05:41:18 INFO - "Change" 05:41:18 INFO - ], 05:41:18 INFO - [ 05:41:18 INFO - "builduid", 05:41:18 INFO - "c1cffcab0c324579aee07de8fcf189e6", 05:41:18 INFO - "Change" 05:41:18 INFO - ], 05:41:18 INFO - [ 05:41:18 INFO - "pgo_build", 05:41:18 INFO - "True", 05:41:18 INFO - "Change" 05:41:18 INFO - ] 05:41:18 INFO - ], 05:41:18 INFO - "revision": "9a3a83ab43e7" 05:41:18 INFO - } 05:41:18 INFO - ], 05:41:18 INFO - "revision": "9a3a83ab43e7" 05:41:18 INFO - } 05:41:18 INFO - } 05:41:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2. 05:41:18 INFO - Running post-action listener: _resource_record_post_action 05:41:18 INFO - ##### 05:41:18 INFO - ##### Running download-and-extract step. 05:41:18 INFO - ##### 05:41:18 INFO - Running pre-action listener: _resource_record_pre_action 05:41:18 INFO - Running main action method: download_and_extract 05:41:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/test_packages.json 05:41:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:41:18 INFO - Downloaded 1270 bytes. 05:41:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:41:18 INFO - Using the following test package requirements: 05:41:18 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:41:18 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:18 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'jsshell-linux-x86_64.zip'], 05:41:18 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:18 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:41:18 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 05:41:18 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 05:41:18 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:18 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:41:18 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:41:18 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:18 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:41:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:22 INFO - Downloaded 21580325 bytes. 05:41: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 05:41:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:41: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 05:41:23 INFO - Return code: 0 05:41:23 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 05:41: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')]} 05:41:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:41:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:24 INFO - Downloaded 21580325 bytes. 05:41:24 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 05:41:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:41:24 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 05:41:25 INFO - Return code: 0 05:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:41:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:30 INFO - Downloaded 11132038 bytes. 05:41:30 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 05:41:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:41:30 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 05:41:30 INFO - Return code: 0 05:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:41:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/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 05:41:34 INFO - Downloaded 57940674 bytes. 05:41:34 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:41:34 INFO - mkdir: /builds/slave/test-pgo/properties 05:41:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:41:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:41:34 INFO - Contents: 05:41:34 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:41:34 INFO - Running post-action listener: _resource_record_post_action 05:41:34 INFO - Running post-action listener: set_extra_try_arguments 05:41:34 INFO - ##### 05:41:34 INFO - ##### Running populate-webroot step. 05:41:34 INFO - ##### 05:41:34 INFO - Running pre-action listener: _resource_record_pre_action 05:41:34 INFO - Running main action method: populate_webroot 05:41:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:34 INFO - '--tppagecycles', 05:41:34 INFO - '7'], 05:41:34 INFO - 'tests': ['tsvgm']}}, 05:41:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:41:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'tests': ['damp', 'tps']}, 05:41:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['damp', 'tps']}, 05:41:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:41:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:34 INFO - 'other': {'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'other_l64': {'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'other_nol64': {'tests': ['a11yr', 05:41:34 INFO - 'ts_paint', 05:41:34 INFO - 'tpaint', 05:41:34 INFO - 'sessionrestore', 05:41:34 INFO - 'sessionrestore_no_auto_restore']}, 05:41:34 INFO - 'svgr': {'tests': ['tsvgx', 05:41:34 INFO - 'tsvgr_opacity', 05:41:34 INFO - 'tart', 05:41:34 INFO - 'tscrollx', 05:41:34 INFO - 'cart']}, 05:41:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['tsvgx', 05:41:34 INFO - 'tsvgr_opacity', 05:41:34 INFO - 'tart', 05:41:34 INFO - 'tscrollx', 05:41:34 INFO - 'cart']}, 05:41:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'tests': ['tp5o']}, 05:41:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'talos_options': ['--e10s'], 05:41:34 INFO - 'tests': ['tp5o']}, 05:41:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'talos_options': ['--xperf_path', 05:41:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:34 INFO - 'tests': ['tp5n']}, 05:41:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:34 INFO - 'talos_options': ['--e10s', 05:41:34 INFO - '--xperf_path', 05:41:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:34 INFO - 'tests': ['tp5n']}}, 05:41:34 INFO - 'talos.zip': {'path': '', 05:41:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:34 INFO - Running post-action listener: _resource_record_post_action 05:41:34 INFO - ##### 05:41:34 INFO - ##### Running create-virtualenv step. 05:41:34 INFO - ##### 05:41:34 INFO - Running pre-action listener: _resource_record_pre_action 05:41:34 INFO - Running main action method: create_virtualenv 05:41:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:41:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:41:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:41:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:34 INFO - Using real prefix '/usr' 05:41:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:41:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:37 INFO - Installing pip.................done. 05:41:37 INFO - Return code: 0 05:41:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:41:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:41:37 INFO - Using env: {'DISPLAY': ':0', 05:41:37 INFO - 'HOME': '/home/cltbld', 05:41:37 INFO - 'LANG': 'en_US.UTF-8', 05:41:37 INFO - 'LANGUAGE': 'en_US:en', 05:41:37 INFO - 'LOGNAME': 'cltbld', 05:41:37 INFO - 'MAIL': '/var/mail/cltbld', 05:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:37 INFO - 'MOZ_NO_REMOTE': '1', 05:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:37 INFO - 'NO_EM_RESTART': '1', 05:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:37 INFO - 'SHELL': '/bin/bash', 05:41:37 INFO - 'SHLVL': '1', 05:41:37 INFO - 'TERM': 'linux', 05:41:37 INFO - 'TMOUT': '86400', 05:41:37 INFO - 'USER': 'cltbld', 05:41:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:37 INFO - '_': '/tools/buildbot/bin/python'} 05:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:41:37 INFO - Cleaning up... 05:41:37 INFO - Return code: 0 05:41:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:41:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:41:37 INFO - Using env: {'DISPLAY': ':0', 05:41:37 INFO - 'HOME': '/home/cltbld', 05:41:37 INFO - 'LANG': 'en_US.UTF-8', 05:41:37 INFO - 'LANGUAGE': 'en_US:en', 05:41:37 INFO - 'LOGNAME': 'cltbld', 05:41:37 INFO - 'MAIL': '/var/mail/cltbld', 05:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:37 INFO - 'MOZ_NO_REMOTE': '1', 05:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:37 INFO - 'NO_EM_RESTART': '1', 05:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:37 INFO - 'SHELL': '/bin/bash', 05:41:37 INFO - 'SHLVL': '1', 05:41:37 INFO - 'TERM': 'linux', 05:41:37 INFO - 'TMOUT': '86400', 05:41:37 INFO - 'USER': 'cltbld', 05:41:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:37 INFO - '_': '/tools/buildbot/bin/python'} 05:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:37 INFO - Downloading/unpacking psutil>=0.7.1 05:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:39 INFO - Installing collected packages: psutil 05:41:39 INFO - Running setup.py install for psutil 05:41:39 INFO - building 'psutil._psutil_linux' extension 05:41:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:41:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:41:41 INFO - building 'psutil._psutil_posix' extension 05:41:41 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 05:41:41 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 05:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:41 INFO - Successfully installed psutil 05:41:41 INFO - Cleaning up... 05:41:41 INFO - Return code: 0 05:41:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:41:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:41:41 INFO - Using env: {'DISPLAY': ':0', 05:41:41 INFO - 'HOME': '/home/cltbld', 05:41:41 INFO - 'LANG': 'en_US.UTF-8', 05:41:41 INFO - 'LANGUAGE': 'en_US:en', 05:41:41 INFO - 'LOGNAME': 'cltbld', 05:41:41 INFO - 'MAIL': '/var/mail/cltbld', 05:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:41 INFO - 'MOZ_NO_REMOTE': '1', 05:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:41 INFO - 'NO_EM_RESTART': '1', 05:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:41 INFO - 'SHELL': '/bin/bash', 05:41:41 INFO - 'SHLVL': '1', 05:41:41 INFO - 'TERM': 'linux', 05:41:41 INFO - 'TMOUT': '86400', 05:41:41 INFO - 'USER': 'cltbld', 05:41:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:41 INFO - '_': '/tools/buildbot/bin/python'} 05:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:41:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:41:43 INFO - Installing collected packages: mozsystemmonitor 05:41:43 INFO - Running setup.py install for mozsystemmonitor 05:41:43 INFO - Successfully installed mozsystemmonitor 05:41:43 INFO - Cleaning up... 05:41:43 INFO - Return code: 0 05:41:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:41:43 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')]} 05:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:43 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')]} 05:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:43 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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:43 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 05:41:43 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 05:41:43 INFO - Using env: {'DISPLAY': ':0', 05:41:43 INFO - 'HOME': '/home/cltbld', 05:41:43 INFO - 'LANG': 'en_US.UTF-8', 05:41:43 INFO - 'LANGUAGE': 'en_US:en', 05:41:43 INFO - 'LOGNAME': 'cltbld', 05:41:43 INFO - 'MAIL': '/var/mail/cltbld', 05:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:43 INFO - 'MOZ_NO_REMOTE': '1', 05:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:43 INFO - 'NO_EM_RESTART': '1', 05:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:43 INFO - 'SHELL': '/bin/bash', 05:41:43 INFO - 'SHLVL': '1', 05:41:43 INFO - 'TERM': 'linux', 05:41:43 INFO - 'TMOUT': '86400', 05:41:43 INFO - 'USER': 'cltbld', 05:41:43 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:43 INFO - '_': '/tools/buildbot/bin/python'} 05:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:43 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 05:41:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:41:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:46 INFO - Downloading docopt-0.6.1.tar.gz 05:41:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:46 INFO - Running setup.py install for blobuploader 05:41:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:41:46 INFO - Running setup.py install for requests 05:41:46 INFO - Running setup.py install for docopt 05:41:46 INFO - Successfully installed blobuploader requests docopt 05:41:46 INFO - Cleaning up... 05:41:46 INFO - Return code: 0 05:41:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:46 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')]} 05:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:46 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')]} 05:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:46 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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:46 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 05:41:46 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 05:41:46 INFO - Using env: {'DISPLAY': ':0', 05:41:46 INFO - 'HOME': '/home/cltbld', 05:41:46 INFO - 'LANG': 'en_US.UTF-8', 05:41:46 INFO - 'LANGUAGE': 'en_US:en', 05:41:46 INFO - 'LOGNAME': 'cltbld', 05:41:46 INFO - 'MAIL': '/var/mail/cltbld', 05:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:46 INFO - 'MOZ_NO_REMOTE': '1', 05:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:46 INFO - 'NO_EM_RESTART': '1', 05:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:46 INFO - 'SHELL': '/bin/bash', 05:41:46 INFO - 'SHLVL': '1', 05:41:46 INFO - 'TERM': 'linux', 05:41:46 INFO - 'TMOUT': '86400', 05:41:46 INFO - 'USER': 'cltbld', 05:41:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:46 INFO - '_': '/tools/buildbot/bin/python'} 05:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:47 INFO - Running setup.py (path:/tmp/pip-lnUsk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:47 INFO - Running setup.py (path:/tmp/pip-YAuDos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:47 INFO - Running setup.py (path:/tmp/pip-lDR5MW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:47 INFO - Running setup.py (path:/tmp/pip-KEsZ6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:47 INFO - Running setup.py (path:/tmp/pip-RI_dfX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:47 INFO - Running setup.py (path:/tmp/pip-BYcKlF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:47 INFO - Running setup.py (path:/tmp/pip-SGFZib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:47 INFO - Running setup.py (path:/tmp/pip-dNmRcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:47 INFO - Running setup.py (path:/tmp/pip-WMJ9Ak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:47 INFO - Running setup.py (path:/tmp/pip-WghQKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:47 INFO - Running setup.py (path:/tmp/pip-eEG3f0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:47 INFO - Running setup.py (path:/tmp/pip-KDzAcw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:47 INFO - Running setup.py (path:/tmp/pip-hzw87R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:48 INFO - Running setup.py (path:/tmp/pip-mEfAO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:48 INFO - Running setup.py (path:/tmp/pip-o5MFIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:48 INFO - Running setup.py (path:/tmp/pip-O_i_n7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:48 INFO - Running setup.py (path:/tmp/pip-c4blfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:48 INFO - Running setup.py install for manifestparser 05:41:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:41:48 INFO - Running setup.py install for mozcrash 05:41:48 INFO - Running setup.py install for mozdebug 05:41:48 INFO - Running setup.py install for mozdevice 05:41:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:41:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:41:48 INFO - Running setup.py install for mozfile 05:41:48 INFO - Running setup.py install for mozhttpd 05:41:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:41:48 INFO - Running setup.py install for mozinfo 05:41:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:41:48 INFO - Running setup.py install for mozInstall 05:41:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Running setup.py install for mozleak 05:41:49 INFO - Running setup.py install for mozlog 05:41:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Running setup.py install for moznetwork 05:41:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Running setup.py install for mozprocess 05:41:49 INFO - Running setup.py install for mozprofile 05:41:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Running setup.py install for mozrunner 05:41:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:41:49 INFO - Running setup.py install for mozscreenshot 05:41:49 INFO - Running setup.py install for moztest 05:41:49 INFO - Running setup.py install for mozversion 05:41:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:41:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:50 INFO - Cleaning up... 05:41:50 INFO - Return code: 0 05:41:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:50 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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:50 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 05:41:50 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 05:41:50 INFO - Using env: {'DISPLAY': ':0', 05:41:50 INFO - 'HOME': '/home/cltbld', 05:41:50 INFO - 'LANG': 'en_US.UTF-8', 05:41:50 INFO - 'LANGUAGE': 'en_US:en', 05:41:50 INFO - 'LOGNAME': 'cltbld', 05:41:50 INFO - 'MAIL': '/var/mail/cltbld', 05:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:50 INFO - 'MOZ_NO_REMOTE': '1', 05:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:50 INFO - 'NO_EM_RESTART': '1', 05:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:50 INFO - 'SHELL': '/bin/bash', 05:41:50 INFO - 'SHLVL': '1', 05:41:50 INFO - 'TERM': 'linux', 05:41:50 INFO - 'TMOUT': '86400', 05:41:50 INFO - 'USER': 'cltbld', 05:41:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:50 INFO - '_': '/tools/buildbot/bin/python'} 05:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:50 INFO - Running setup.py (path:/tmp/pip-H6tPkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:50 INFO - Running setup.py (path:/tmp/pip-WabpGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:50 INFO - Running setup.py (path:/tmp/pip-JScvtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:50 INFO - Running setup.py (path:/tmp/pip-xb30ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:50 INFO - Running setup.py (path:/tmp/pip-UqFaZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:50 INFO - Running setup.py (path:/tmp/pip-IgVBjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:50 INFO - Running setup.py (path:/tmp/pip-l1TtgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:50 INFO - Running setup.py (path:/tmp/pip-2FMIMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:50 INFO - Running setup.py (path:/tmp/pip-f8hb7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:50 INFO - Running setup.py (path:/tmp/pip-ByaYQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:50 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)) 05:41:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:50 INFO - Running setup.py (path:/tmp/pip-ZUErXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:51 INFO - Running setup.py (path:/tmp/pip-UFfK_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:51 INFO - Running setup.py (path:/tmp/pip-hnpfL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:51 INFO - Running setup.py (path:/tmp/pip-ytigBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:51 INFO - Running setup.py (path:/tmp/pip-AIskFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:51 INFO - Running setup.py (path:/tmp/pip-MASoU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:51 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)) 05:41:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:51 INFO - Running setup.py (path:/tmp/pip-j_PkyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:51 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)) 05:41:51 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)) 05:41:51 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)) 05:41:51 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)) 05:41:51 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)) 05:41:51 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)) 05:41:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:53 INFO - Downloading blessings-1.6.tar.gz 05:41:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:53 INFO - Installing collected packages: blessings 05:41:53 INFO - Running setup.py install for blessings 05:41:53 INFO - Successfully installed blessings 05:41:53 INFO - Cleaning up... 05:41:53 INFO - Return code: 0 05:41:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:41:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:53 INFO - Reading from file tmpfile_stdout 05:41:53 INFO - Current package versions: 05:41:53 INFO - argparse == 1.2.1 05:41:53 INFO - blessings == 1.6 05:41:53 INFO - blobuploader == 1.2.4 05:41:53 INFO - docopt == 0.6.1 05:41:53 INFO - manifestparser == 1.1 05:41:53 INFO - mozInstall == 1.12 05:41:53 INFO - mozcrash == 0.16 05:41:53 INFO - mozdebug == 0.1 05:41:53 INFO - mozdevice == 0.47 05:41:53 INFO - mozfile == 1.2 05:41:53 INFO - mozhttpd == 0.7 05:41:53 INFO - mozinfo == 0.9 05:41:53 INFO - mozleak == 0.1 05:41:53 INFO - mozlog == 3.1 05:41:53 INFO - moznetwork == 0.27 05:41:53 INFO - mozprocess == 0.22 05:41:53 INFO - mozprofile == 0.27 05:41:53 INFO - mozrunner == 6.11 05:41:53 INFO - mozscreenshot == 0.1 05:41:53 INFO - mozsystemmonitor == 0.0 05:41:53 INFO - moztest == 0.7 05:41:53 INFO - mozversion == 1.4 05:41:53 INFO - psutil == 3.1.1 05:41:53 INFO - requests == 1.2.3 05:41:53 INFO - wsgiref == 0.1.2 05:41:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:53 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 05:41:53 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 05:41:53 INFO - Using env: {'DISPLAY': ':0', 05:41:53 INFO - 'HOME': '/home/cltbld', 05:41:53 INFO - 'LANG': 'en_US.UTF-8', 05:41:53 INFO - 'LANGUAGE': 'en_US:en', 05:41:53 INFO - 'LOGNAME': 'cltbld', 05:41:53 INFO - 'MAIL': '/var/mail/cltbld', 05:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:53 INFO - 'MOZ_NO_REMOTE': '1', 05:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:53 INFO - 'NO_EM_RESTART': '1', 05:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:53 INFO - 'SHELL': '/bin/bash', 05:41:53 INFO - 'SHLVL': '1', 05:41:53 INFO - 'TERM': 'linux', 05:41:53 INFO - 'TMOUT': '86400', 05:41:53 INFO - 'USER': 'cltbld', 05:41:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:53 INFO - '_': '/tools/buildbot/bin/python'} 05:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 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)) 05:41:53 INFO - Cleaning up... 05:41:53 INFO - Return code: 0 05:41:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:53 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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:53 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 05:41:53 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 05:41:53 INFO - Using env: {'DISPLAY': ':0', 05:41:53 INFO - 'HOME': '/home/cltbld', 05:41:53 INFO - 'LANG': 'en_US.UTF-8', 05:41:53 INFO - 'LANGUAGE': 'en_US:en', 05:41:53 INFO - 'LOGNAME': 'cltbld', 05:41:53 INFO - 'MAIL': '/var/mail/cltbld', 05:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:53 INFO - 'MOZ_NO_REMOTE': '1', 05:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:53 INFO - 'NO_EM_RESTART': '1', 05:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:53 INFO - 'SHELL': '/bin/bash', 05:41:53 INFO - 'SHLVL': '1', 05:41:53 INFO - 'TERM': 'linux', 05:41:53 INFO - 'TMOUT': '86400', 05:41:53 INFO - 'USER': 'cltbld', 05:41:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:53 INFO - '_': '/tools/buildbot/bin/python'} 05:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:54 INFO - Downloading/unpacking jsonschema 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:56 INFO - warning: no files found matching '*.txt' 05:41:56 INFO - no previously-included directories found matching 'build' 05:41:56 INFO - no previously-included directories found matching 'dist' 05:41:56 INFO - no previously-included directories found matching '.git*' 05:41:56 INFO - Installing collected packages: jsonschema, functools32 05:41:56 INFO - Running setup.py install for functools32 05:41:56 INFO - warning: no files found matching '*.txt' 05:41:56 INFO - no previously-included directories found matching 'build' 05:41:56 INFO - no previously-included directories found matching 'dist' 05:41:56 INFO - no previously-included directories found matching '.git*' 05:41:56 INFO - Successfully installed jsonschema functools32 05:41:56 INFO - Cleaning up... 05:41:56 INFO - Return code: 0 05:41:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:41:56 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')]} 05:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:56 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')]} 05:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:56 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 0x7f6c91390f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', '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 05:41:56 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 05:41:56 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 05:41:56 INFO - Using env: {'DISPLAY': ':0', 05:41:56 INFO - 'HOME': '/home/cltbld', 05:41:56 INFO - 'LANG': 'en_US.UTF-8', 05:41:56 INFO - 'LANGUAGE': 'en_US:en', 05:41:56 INFO - 'LOGNAME': 'cltbld', 05:41:56 INFO - 'MAIL': '/var/mail/cltbld', 05:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:56 INFO - 'MOZ_NO_REMOTE': '1', 05:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:56 INFO - 'NO_EM_RESTART': '1', 05:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:56 INFO - 'SHELL': '/bin/bash', 05:41:56 INFO - 'SHLVL': '1', 05:41:56 INFO - 'TERM': 'linux', 05:41:56 INFO - 'TMOUT': '86400', 05:41:56 INFO - 'USER': 'cltbld', 05:41:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:56 INFO - '_': '/tools/buildbot/bin/python'} 05:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:56 INFO - Downloading/unpacking flake8 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:41:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:41:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:59 INFO - no previously-included directories found matching 'docs/_build' 05:41:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:41:59 INFO - Running setup.py install for pep8 05:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:59 INFO - no previously-included directories found matching 'docs/_build' 05:41:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:41:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:41:59 INFO - Cleaning up... 05:41:59 INFO - Return code: 0 05:41:59 INFO - Running post-action listener: _resource_record_post_action 05:41:59 INFO - Running post-action listener: _start_resource_monitoring 05:41:59 INFO - Starting resource monitoring. 05:41:59 INFO - ##### 05:41:59 INFO - ##### Running install step. 05:41:59 INFO - ##### 05:41:59 INFO - Running pre-action listener: _resource_record_pre_action 05:41:59 INFO - Running main action method: install 05:41:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:59 INFO - Reading from file tmpfile_stdout 05:41:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:41:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:41:59 INFO - Reading from file tmpfile_stdout 05:41:59 INFO - Output received: 05:41:59 INFO - Usage: mozinstall [options] installer 05:41:59 INFO - Options: 05:41:59 INFO - -h, --help show this help message and exit 05:41:59 INFO - -d DEST, --destination=DEST 05:41:59 INFO - Directory to install application into. [default: 05:41:59 INFO - "/builds/slave/test-pgo"] 05:41:59 INFO - --app=APP Application being installed. [default: firefox] 05:41:59 INFO - mkdir: /builds/slave/test-pgo/build/application 05:41:59 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'] 05:41:59 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 05:42:14 INFO - Reading from file tmpfile_stdout 05:42:14 INFO - Output received: 05:42:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:42:14 INFO - Running post-action listener: _resource_record_post_action 05:42:14 INFO - ##### 05:42:14 INFO - ##### Running run-tests step. 05:42:14 INFO - ##### 05:42:14 INFO - Running pre-action listener: _resource_record_pre_action 05:42:14 INFO - Running main action method: run_tests 05:42:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:42:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:42:14 INFO - Python 2.7.3 05:42:14 INFO - Return code: 0 05:42:14 INFO - grabbing minidump binary from tooltool 05:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:14 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 0x2831350>, '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 0x2832250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28326e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:42:14 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 05:42:14 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 05:42:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:14 INFO - Return code: 0 05:42:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:42:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:42:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:42:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:42:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:42:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:42:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:42:15 INFO - Return code: 0 05:42:15 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/1454152586/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:42:15 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/1454152586/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 05:42:15 INFO - Using env: {'DISPLAY': ':0', 05:42:15 INFO - 'HOME': '/home/cltbld', 05:42:15 INFO - 'LANG': 'en_US.UTF-8', 05:42:15 INFO - 'LANGUAGE': 'en_US:en', 05:42:15 INFO - 'LOGNAME': 'cltbld', 05:42:15 INFO - 'MAIL': '/var/mail/cltbld', 05:42:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:42:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:15 INFO - 'MOZ_NO_REMOTE': '1', 05:42:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:15 INFO - 'NO_EM_RESTART': '1', 05:42:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:42:15 INFO - 'SHELL': '/bin/bash', 05:42:15 INFO - 'SHLVL': '1', 05:42:15 INFO - 'TERM': 'linux', 05:42:15 INFO - 'TMOUT': '86400', 05:42:15 INFO - 'USER': 'cltbld', 05:42:15 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418', 05:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:15 INFO - '_': '/tools/buildbot/bin/python'} 05:42:15 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/1454152586/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 05:42:15 INFO - mozversion INFO | application_buildid: 20160130031626 05:42:15 INFO - mozversion INFO | application_changeset: 9a3a83ab43e7598159f44d3361e8704653c4fb08 05:42:15 INFO - mozversion INFO | application_display_name: Nightly 05:42:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:15 INFO - mozversion INFO | application_name: Firefox 05:42:15 INFO - mozversion INFO | application_remotingname: firefox 05:42:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:42:15 INFO - mozversion INFO | application_vendor: Mozilla 05:42:15 INFO - mozversion INFO | application_version: 45.0 05:42:15 INFO - mozversion INFO | platform_buildid: 20160130031626 05:42:15 INFO - mozversion INFO | platform_changeset: 9a3a83ab43e7598159f44d3361e8704653c4fb08 05:42:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:42:15 INFO - mozversion INFO | platform_version: 45.0 05:42:15 INFO - 2016-01-30 05:42:15,754 DEBUG : using testdate: 1454161335 05:42:15 INFO - 2016-01-30 05:42:15,754 DEBUG : actual date: 1454161335 05:42:15 INFO - 2016-01-30 05:42:15,801 INFO : starting webserver on 'localhost:53670' 05:42:15 INFO - 2016-01-30 05:42:15,802 INFO : Starting test suite talos-linux64-ix-007 05:42:15 INFO - 2016-01-30 05:42:15,802 INFO : Starting test dromaeo_css 05:42:15 INFO - 2016-01-30 05:42:15,802 DEBUG : operating with platform_type : linux_ 05:42:15 INFO - 2016-01-30 05:42:15,803 INFO : Initialising browser for dromaeo_css test... 05:42:15 INFO - 2016-01-30 05:42:15,816 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCGYPR7/profile http://localhost:53670/getInfo.html 05:42:20 INFO - 2016-01-30 05:42:20,271 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:42:20 INFO - 2016-01-30 05:42:20,272 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:42:20 INFO - 2016-01-30 05:42:20,272 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:42:20 INFO - 2016-01-30 05:42:20,272 DEBUG : BROWSER_OUTPUT: __metrics 05:42:20 INFO - 2016-01-30 05:42:20,429 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] 05:42:21 INFO - 2016-01-30 05:42:21,587 INFO : Browser initialized. 05:42:21 INFO - 2016-01-30 05:42:21,587 INFO : Running cycle 1/1 for dromaeo_css test... 05:42:21 INFO - 2016-01-30 05:42:21,587 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCGYPR7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:42:33 INFO - 2016-01-30 05:42:33,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 134578176 05:42:33 INFO - 2016-01-30 05:42:33,359 DEBUG : BROWSER_OUTPUT: 05:43:24 INFO - 2016-01-30 05:43:24,450 DEBUG : BROWSER_OUTPUT: 1454161404445 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] 05:45:33 INFO - 2016-01-30 05:45:33,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53670/tests/dromaeo/cssquery-ext.html) 05:45:34 INFO - 2016-01-30 05:45:34,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 275181568 05:45:34 INFO - 2016-01-30 05:45:34,352 DEBUG : BROWSER_OUTPUT: 05:48:36 INFO - 2016-01-30 05:48:36,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-ext.html (next: http://localhost:53670/tests/dromaeo/cssquery-jquery.html) 05:48:37 INFO - 2016-01-30 05:48:37,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 223109120 05:48:37 INFO - 2016-01-30 05:48:37,119 DEBUG : BROWSER_OUTPUT: 05:51:38 INFO - 2016-01-30 05:51:38,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53670/tests/dromaeo/cssquery-mootools.html) 05:51:39 INFO - 2016-01-30 05:51:39,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 217796608 05:51:39 INFO - 2016-01-30 05:51:39,483 DEBUG : BROWSER_OUTPUT: 05:54:41 INFO - 2016-01-30 05:54:41,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53670/tests/dromaeo/cssquery-prototype.html) 05:54:41 INFO - 2016-01-30 05:54:41,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 199176192 05:54:41 INFO - 2016-01-30 05:54:41,746 DEBUG : BROWSER_OUTPUT: 05:57:44 INFO - 2016-01-30 05:57:44,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53670/tests/dromaeo/cssquery-yui.html) 05:57:44 INFO - 2016-01-30 05:57:44,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 200990720 05:57:44 INFO - 2016-01-30 05:57:44,804 DEBUG : BROWSER_OUTPUT: 06:00:46 INFO - 2016-01-30 06:00:46,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/dromaeo/cssquery-yui.html (next: http://localhost:53670/tests/dromaeo/cssquery-dojo.html) 06:00:47 INFO - 2016-01-30 06:00:47,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 244752384 06:00:47 INFO - 2016-01-30 06:00:47,183 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:47 INFO - 2016-01-30 06:00:47,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:47 INFO - 2016-01-30 06:00:47,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:47 INFO - 2016-01-30 06:00:47,185 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:47 INFO - 2016-01-30 06:00:47,186 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3285.1458620758604;3392.2197894484284;3418.6239513653495;3419.281950790334;3443.5695538057753;5625.718714064295;5636.070048442012;5643.0971044632815;5652.406497317784;5673.00722373585;5659.4340565943485;5665.1785491103765;5666.858328541788;5668.404817494165;5684.403137670537;4793.233082706767;5115.386153661557;5138.049460849755;5193.480651934795;5219.164933610623;5025.949740502603;5042.672226305279;5051.116054690433;5052.873678158038;5065.696058236499;5068.5438310552045;5089.694618322894;5096.311997880276;5184.092783762845;5253.789848406059;5023.974880125595;5056.342675452204;5057.519535644108;5062.949370506321;5106.412762532319;4902.779374928136;4934.407871055496;5039.596832253411;5058.974705126488;5084.084864724348;5175.844724658266;5177.58579313654;5274.446183150791;5288.180332048539;5334.706591137486;5991.161237426763;6016.278046634388;6060.030395136757;6064.847678940987;6069.787557435468;6095.420935011167;6107.72515236811;6122.908156377658;6127;6128.233970753656;5412.621116521845;5585.888282234373;5600.915986260209;5719.628224165416;5721.71391430431;5987.820365388958;5993.310769261503;6007.639541627516;6010.459058684652;6016.398360164036;5843.328017277982;5848.619839710405;5850.12248162779;5856.355800861902;5857.179994800731;5850.063989761617;5915.201447804578;5948.672822994777;6060.878782424415;6082.939170608237;5989.071693887455;6030.33666296707;6035;6035.185249991283;6052.57631965767;5792;5991.161237426763;6010.068439391901;6051.697415129226;6055.939440605625;4462.866114016585;4530.61489773373;4594.356790049395;4602;4615.215413379734;4082.183563287295;4094;4104.4664193654635;4120;4133.607307305801;5595.21666966625;5713.4000929902595;5786.768529258782;5796.188533605298;5801.767929282866;6134.846628834315;6218.81343559694;6219;6239.719212635442;6241.063840423882;5661.603687741901;5665.348484924287;5665.405132461115;5666.291713535808;5676.262085928885;4961.677490963076;5051.494850514992;5156.407013193456;5159;5210.583153347723;6341.048842673636;6377.617342959345;6387.265464471552;6396.136521569621;6409.038644203313;6208.937910621016;6210.068489726577;6214.564980451325;6215.595986260879;6227.688615569294;5967.403259673998;6030.547708921761;6117.462039585284;6292.2134733158355;6351.618902865843;6009.098635204754;6025.548083893638;6031.939680603138;6040.063790112539;6059.606125601998;6048.0625503047095;6066.029435290332;6075.119107729266;6088.847778805565;6095.969520152371;5649.661020338793;5692.345380281321;5745.052066408995;5750.712464376681;5987.64074155552;5795.855103622274;5812;5819.447152520504;5854.502367298657;5966.552508561788;5759.798407055733;5841.883162336644;5845.590808643354;5848.970755146197;5874.794382196603;5925.111233315038;5980.372060933713;6011.879762404815;6014.248218972629;6019.759209631566;5643.943560564506;5748.281464816898;5789.305283366023;5813.418658134153;5927.229460170151 06:00:47 INFO - 2016-01-30 06:00:47,188 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.4027711872448;642.1683919324471;643.8551325951661;645.3127419298444;649.9935000649994;31184.376312473767;39582;39656.99999999996;39734.99999999993;39947.201055978934;45153.32270015952;45337.31994020084;45394.546054539445;45477.54522454774;45784.313235301495;7895.210478952087;8031.759047228563;8847.469151850877;9026.593803278869;9030.819383612325;8130.430869839084;10775.515101820398;10985.505652245629;11030.724231894186;11037.944810275938;10683.626073087444;10696.197785166143;10827.133829293638;10827.458627068654;10831.945840270828;10648.893511064867;10678.572857085706;10724.678259652223;10789.514471848746;10792.298500597437;10457.111145552637;10568.735781605445;10575.048245657928;10576.365418074864;10586.36481811086;41775.58224417747;42015;42015.159696805895;42239;42244.78877605623;3722.40441529354;3739.7569158004917;3800.9429858552144;4151.7924103794685;4275.87172384829;32545.837270813732;32785.67619958845;32811.50782738261;33005.6699433005;33092;4218.430511880888;4249.521941166559;4280.807363668642;4307.07397909451;4324.524302326741;287368;291504.5424772884;291815;292429;292751;56313.7184314084;57272.14091788627;62404.375956240765;63244.68377658174;63370;62054.68972655108;62301;62369;62464.37535624586;62479.68760156261;15786.68426631484;15889.126098064717;15896.841031589767;15970.36118555268;15984.600384990235;12873.163244389085;12976.545820896223;12998.740025199442;13221.338933053308;13227.93386033083;20204.090815913318;20380.592388152152;20534.281300154424;20594.38216853497;20610.690839637417;8215.219554142346;8239.299659528888;8358.582070896431;8445.366597505088;8483;1030.9844802869168;1080.9082826345448;1090.2041509697965;1116.9556464705527;1223.889849913512;26239;26812.731872681023;29548.556771648444;29955;30002.399952000836;1092.126298960828;1100.6863044032411;1108.490094556513;1110.5119140351967;1167.3754541320352;13279.66800829987;14785.778213326808;15070.397184112731;15092.094474331576;16886.155692215587;321866;397115;397644;398421;398944;51498.22752658713;51842.481575184516;61575;65328;66594.66702666455;1416.978745318821;1437.8856386300702;1444.8627380398846;1446.2045874768835;1456.4975083596141;31153.68846311508;31880;31963.840180798947;32803.67196328006;32934.83532582322;52101.7394913023;52746.736266318425;52830.735846320524;52835.735821320646;52849.20726189187;324994;326888;327232;327316;328329;35465.82267088648;35854.64145358513;35966.280674386886;36152.27695446129;36300.09249768777;45984;46089;46730.53269467398;47568;47618.285725713446;39384.03920474951;40472.79763601163;40527.79736101301;40740.388894167205;44633.33050004317;38776;45814.541854581024;45831;47103.76448117737;47626;39062;39520.40719389154;39538.209235815695;39697.603023969394;39788.20423591454;33990.66009339974;35019.64980350266;35257.647423525435;40125.598744013354;40749.79625101855;26696.733032669425;28324.858375708813;30033.84983075158;30372.392552149275;30383.848080759453 06:00:47 INFO - 2016-01-30 06:00:47,188 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.7237189223758;386.675192838016;387.26999605743174;389.77977442744844;390.53526303698595;14762.704745905075;16623.75064374034;16676.83323166768;17847.196876140573;17877;18266.817331826678;18397.724034139497;18539.35112271071;18889.433317000512;18890.62218755624;5522.779088836452;5614.943850561483;5660.773569057254;5663.745131469073;5664.037113690682;4305.870823875289;4422.911541769163;5631.63394379366;6003.189569408118;6257.530685198628;6158;6179.073139029137;6217.129601855721;6231.127642130083;6449.645269510175;6468.191476065492;6579.835504112388;6611.338866113374;6618.07346971422;6639.170103737033;6562.081308616797;6579.769708060195;6581.7367305307735;6583.93416065838;6586.604803711793;22179.778202217934;22263.44341391462;22317.33048008546;22752.089916403325;22901.77098229013;2555.297293244354;2562.7181010088875;2571.2029270926073;2599.558075127214;2607.2308668942705;14360.64098397538;14438.20589867557;14578.708425831424;14639.487617933428;14921.030133041317;2020.7878172791793;2025.7974202579624;2131.7548481924623;2141.839362047853;2162.8810415427147;70831;72893.27106728971;74482.62758686172;75850.62074689647;76744.61627691882;15990.680186396206;16326.591835204215;16664.583385415463;17182.828171718375;17216.483505494856;25637.359066023124;25700.228993130237;25907.740922590532;25916.222513324632;25954.22137335883;9774.804503910023;9801.068898454636;9854.950725246472;10106.949465252774;10184.032516910882;8421.873671894926;8431.873521897176;8450.66197352099;8456.40805143634;8477.576121193915;6940.414348870233;8139.30815880645;8289.58552072394;8317.667293308321;8383.11977242393;1713.5801728576578;1738.1483073293996;1744.9738253925948;1869.364416098533;1886.1700851625515;442.5397586510058;447.5144468251918;454;993.6323560282597;1055.4933631856752;11181.608643697431;14568.49010284635;17125.400610978806;17191.05449200281;17392.21735021927;968.4141094637783;1023.22746326523;1033.943133127685;1056.5509658395306;1059.131512160037;9715.854262186072;9985.950070249748;9987.202303585424;10132;10205.795884082278;618114;621464;638230;641456;656797.0762686532;83150;84762;84945;85173;87010.56494717486;1228.791105512065;1232.420762241745;1242.9502819887284;1244.8319476870688;1246.2709315050615;16436.506904792874;16465.25906334242;16498.25757840876;16647.500574982285;16849.15754212309;36782.63217367899;37229.25541489209;37444.81277593595;37902.62097378991;38861;49264.75367623282;50603.493965059875;51200.48799511957;51863.481365185864;53656;10081.848772268275;10145;10306.484675766033;10387.94806025965;10398;12183.147179697336;12271.079669025037;12273.509059637872;12386.194897331645;17455.56361090983;14544.927275363556;14960.326785294905;15157.772633410286;15174;15377.461788837338;11649.708757281136;14683.779743303645;15008.6998260032;15014.6997060056;15390.230488475756;16010.759838602664;16166.515004549883;16264.430744923871;16593.170341483117;16624.3350265988;9760.951195243979;10022.548985295532;10142.746431339276;10285.43430111351;10316.329438586468;10197.13324367437;10294.794104117726;14689.41242350294;15735.842641573438;15944.920275398548 06:00:47 INFO - 2016-01-30 06:00:47,189 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1500.6848561802021;1571.55210764932;1604.9888570200771;1727.9654406911861;1847.8429333506642;7789.6494657740395;8158.510489370642;8176.509409435431;8181.140980197068;8181.631826567811;7978.960105199466;8041.557714325724;8043.91956080439;8049.637766300516;8063.435559510836;2295.6326987681973;2330.114556468544;2361.327021798788;2367.538330025646;2369.526094781042;2317.5480781247666;2321.2223904991847;2322.6516022596575;2345.6833327500826;2347.776961188693;2016.3950814755588;2058.87646741196;2251.1108112295633;2273.2839155665997;2312.6415405612156;2328.6041372966465;2336.754640762721;2350.4711439925964;2350.800181984525;2350.917717879883;2253.6281513550243;2283.394900351408;2283.5547068321516;2286.622707253301;2287.256641591473;7025.297470252985;7168.569885806816;7291.744788932362;7464.589447580381;7473.364763995067;4574.382458368111;4659.394278743775;4659.487456379796;4660.487346391894;4666.65000124992;3115.750739940799;3127.0618814355603;3146.465100932847;3162.6362968258713;3205.3749518843833;1040.7866387390566;1069.379759739357;1075.9408232547207;1088.7387027113516;1107.1696227829127;10877.12982961369;10938.945305273422;10954.726131846688;10968;10986.560537578567;4175.227582897173;4231.9843237622745;4267.76527291002;4305.677074219446;4306.332518459643;8955.462672239686;8962.193402593668;8965.641374344954;8970.686025989058;8982.326325525612;4585.243434833282;4593.379893714306;4625.676202665848;4628.421447319085;4640.605548528345;4218.388333691659;4226.598473145046;4263.616274535307;4271.5514870938105;4277.1873344064525;3559.34152181842;3611.530501034849;3612.205314830733;3614.8192590370904;3619.0228638268045;1064.744461329291;1066.7599790047332;1067.7384040909872;1068.1294744782977;1072.045879167526;1162.0761494611636;1185.1703807334727;1189.143816452153;1193.4390836306923;1197.4072833947077;7249.347558719741;7264.745733899288;7800.258975397328;7861.056673199253;7867.173946735625;1090.6782499162766;1141.2524796258465;1196.2045239915533;1198.8980936620485;1221.3038568016323;5329.520343169056;6095.207623009069;6140.78507252253;6144.354842741537;6155.784547540815;7894;9451.905480945103;9454.101860323259;9550.331476796697;9588.808223835624;9324.813503729887;9471.052894710612;9481.952590237004;9503.144716975366;9641.37331073492;7661.233876612294;7667.769966901002;7769;7769.689212431439;7769.728059518003;7338.853222935618;7342.3758980487255;7592.544447333178;7727.227277272228;7731.458797884094;8525.232729054414;8592.742217733477;8597.914020859962;8644.697435589724;8648.740537783877;8492.830143396974;8854.203121719076;8855;9059.094090591152;9085.954570227106;7232.276772322725;7320.633968301457;7321.048263725682;7323.414126869944;7326.3406293433845;7688.577128258;7789.143194248742;7827.217278272127;7849.843003140019;7866.72466463671;7325.670344834602;7384.667689953858;7402.3707984821895;7405.296496832792;7509.3617042552;7140.964295178491;7211.963940180265;7290.9635451822405;7292.0520332356455;7412.592307423143;7365.153007404003;7378.372838308804;7400.370968467741;7418.332350088518;7506.361959233308;6981.197162326397;7005.369516743517;7025.859482810418;7029.894551581832;7030.156381234285;6534.738610455719;6580.539362244597;6601;6603.834904127243;6610.570312929644 06:00:47 INFO - 2016-01-30 06:00:47,190 DEBUG : BROWSER_OUTPUT: |4;prototype.html;348.252997320747;348.44075259208967;353.7046566117292;365.0818192246499;368.3958308374267;6000.819975400734;6057.757689692407;6095.085737139431;6125.111858780474;6140.478059364954;5957.940420595793;6087.208662873832;6139.570230083885;6150.784722534712;6151.292601350846;4817.638677099214;4820.3733514643045;4824.7105173689515;4826.541478559531;4832.9758351208375;4532.0709254602725;4629.074185162964;4673.462551806551;4757.357756702852;4818.68678535894;4699.600533954618;4735.881602959919;4759.619230461555;4765.26138448541;4765.7140571565815;4743.620510359163;4750.239961606144;4758.666893317469;4760.928586071212;4786.066716990188;4239.236937351276;4245.469316335458;4246.2356775780345;4251.0010147615285;4255.170241802819;5722.2561067061015;5835.270591176103;5897.380775018647;5917.8816423671715;5924.97037514814;5511.559075273968;5522.199281104217;5531.529819965308;5537.833864984057;5544.91682624761;6239.313675495692;6423.261324947644;6561.967190164067;6576.145101136869;6583.506237032242;4488.708233964814;4570.3373010913565;4576.427946506687;4599.402077729907;4600.263957766775;6639.800805975829;6697.93302066978;6706.1952565691945;6717.764878229287;6719.664016799189;4592.242280023758;4615.676902616851;4615.8846028848875;4619.514950930104;4622.14490319292;4612.331211974245;4772.379590653193;4781.091592597395;4781.13939490895;4801.591864691471;5477.3427188737605;5477.643953143033;5483.067878460672;5493.725313734377;5499.230107784913;6552.312007239267;6554.115194448784;6558.147440832661;6563.901541476882;6567.868642627121;1653.8015438147258;1660.2528862012143;1688.1221764682296;1689.2482845133798;1692.1708362902089;1114.7046032801313;1133.0425790207262;1146.0888593568134;1153.411760002388;1154.9538018479166;6369.331220221903;6385.13800636908;6387;6391.680415979183;6396.42432181106;6778.525503214826;6780.593164410151;6783.118194634764;6783.253842077367;6788.932110678928;6246.656433896089;6335.746570137143;6375.71309291083;6380.521460890452;6396.808095757042;3663.157473781045;3682.8710995115043;3691.3171063353366;3692.6861216796337;3695.4087346024507;6985.231624521299;6994;6998.790036298919;7000.719971201197;7002.719891204397;6848.7260509580055;6942.514024018371;6958.060661810692;6958.304169583002;6958.93041069593;7091.503594748318;7100.112485939154;7100.7869763907165;7102.92897071033;7105.82235444118;6576.638284894186;6623.205215374186;6666.633335166418;6797;6867.690953907186;6714.3957043866285;6732.091167692299;6745.156855393076;6754;6761.526693131434;7050.612216328152;7050.717971281091;7058.929410705828;7065.752698655522;7066.046083778624;4625.722456652612;4734.053189362073;4744.4069491313585;4759.095771803346;4763.190257656138;6747.561408508432;6756.797296080928;6762.628055456997;6763.425108865801;6765.661716914233;6617.246429696231;6623.337666233531;6634.800955971328;6635.369639884203;6637.800865974028;6428.4214420702365;6614;6659.334066593302;6660;6663.833404164935;6512.902306465312;6536.281009089092;6539.051837483634;6551.737930482727;6557.147570815763;6499.2200935887995;6629.270780214076;6660.800175994728;6689.0300906369275;6703;6441.5490915635455;6442.2591401989375;6442.516811239269;6443.96778016107;6447.871042579216 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: |5;yui.html;825.2325337436184;867.4089270420459;899.8560230363144;903.7469508537612;924.1036194890953;13208.669783255424;13689;13753.174809511424;13845.653858653539;13894.65263368415;13980.440782368718;14010.22943738094;14017.649558761035;14042.789358159636;14059.086159399632;690.8134803603024;708.1714394158846;708.8972099045635;721.2462976189881;866.5970323799432;811.0551207842856;821.4373154389262;828.3828547731918;828.6436832162168;855.7988872614931;925.5557332480413;935.0509233128346;935.9812803743921;936.0358830404695;937.0582564522646;760.8668483015477;764.2739397572301;895.8656201569752;906.302147346546;917.6925729880498;677.478341676906;677.5392732941598;677.8102131403166;677.8983152527111;678.4063944048958;13575.1854888706;14012.299385030708;14018.509352172625;14033.859661403358;14051.78922316166;12694.174878632859;12922.612321630271;13012.86987130126;13021.869781302255;13290.401931913088;11012.119030477543;11132.109431245563;11543.826842597367;11634.418279086096;11797;3962.821673024721;3969.206158768229;4010.258102251093;4024.074462873526;4027.577104404054;47539.52460475385;49621;49681.25478117831;49835.003299934164;54425.455745442436;10983.286086404518;11279.266847654877;11282.210245282751;11986.101042421853;11997.700057498458;17391.65216695659;17506.56233594145;17544.473665790047;17643.91178044127;17716.91141544284;8277.296429803413;8499.277561407349;8717.259032982141;8735.737927862174;8841.381103322705;4708.788104535304;4759.50025247351;4778.092162489116;4797.376341075638;4874.561289483963;3251.284717362224;3281.2945216778508;3282.688144626257;3283.1463819407127;3285.802851828898;576.7289373994216;593.8485686150004;595.9314678811992;605.5186127029023;614.4807637546267;671.5030877150873;674.723363420995;676.4588329336511;704.4399702236734;737.1080991999634;8502.404831661848;8722.127787221227;8753.562321884008;8880.644774208959;9043.864342034874;520.5185203686575;569.4846164221303;602.5566328537822;616.1466369078857;663.3764261594087;3901.297766402075;3929.1945151243926;3986.86045988389;4383.408239887638;4460.799264033127;56290.718546407006;56512;56965.71517142471;57703.422965770646;65675.67162164158;56409.43590564042;56867;57333.42666573364;57595.42404575984;58076.419235807945;48355.75822120937;48395.5160448398;48402.27396589054;51890;53785.46214537883;8513.82972340562;8597.097304782908;8855.91144088551;8889.244414224864;9087.36388452802;38701;39871.60128398679;40456.1908761829;40463.393049103695;40915.59084409118;49018.509814901394;49272.507274928226;49304.260436094206;50141.74929125331;50495;11829.467673954865;12038.518459261531;12355.196912200678;12561.11507863185;13071.411786469822;13646.181229126285;13900.443982240597;13952.441902324199;13961.162330260217;14025.29873506341;11700.88299117032;11826.881731182579;11878.703032423913;11936.940315298369;12151.270923744603;10906.61826836057;11082.390468524309;11588.594399195988;11656.18406711522;11731.648050558497;10971.615993440191;11044.613438529614;11529.135314851588;11582.131340149353;11824.349660768741;11017.092908388655;11029.944850275697;11091.50088246047;11364.772704545698;11472.82790758156;10056.748581285527;10219;10224.079832814785;10364.689059328231;10391.896081039093 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1039 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1454162447184__endTimestamp 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,194 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5587.05 Median:5795.86 stddev:646.42 (11.2%) stddev-sans-first:622.67 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: Values: 3285.1 3392.2 3418.6 3419.3 3443.6 5625.7 5636.1 5643.1 5652.4 5673.0 5659.4 5665.2 5666.9 5668.4 5684.4 4793.2 5115.4 5138.0 5193.5 5219.2 5025.9 5042.7 5051.1 5052.9 5065.7 5068.5 5089.7 5096.3 5184.1 5253.8 5024.0 5056.3 5057.5 5062.9 5106.4 4902.8 4934.4 5039.6 5059.0 5084.1 5175.8 5177.6 5274.4 5288.2 5334.7 5991.2 6016.3 6060.0 6064.8 6069.8 6095.4 6107.7 6122.9 6127.0 6128.2 5412.6 5585.9 5600.9 5719.6 5721.7 5987.8 5993.3 6007.6 6010.5 6016.4 5843.3 5848.6 5850.1 5856.4 5857.2 5850.1 5915.2 5948.7 6060.9 6082.9 5989.1 6030.3 6035.0 6035.2 6052.6 5792.0 5991.2 6010.1 6051.7 6055.9 4462.9 4530.6 4594.4 4602.0 4615.2 4082.2 4094.0 4104.5 4120.0 4133.6 5595.2 5713.4 5786.8 5796.2 5801.8 6134.8 6218.8 6219.0 6239.7 6241.1 5661.6 5665.3 5665.4 5666.3 5676.3 4961.7 5051.5 5156.4 5159.0 5210.6 6341.0 6377.6 6387.3 6396.1 6409.0 6208.9 6210.1 6214.6 6215.6 6227.7 5967.4 6030.5 6117.5 6292.2 6351.6 6009.1 6025.5 6031.9 6040.1 6059.6 6048.1 6066.0 6075.1 6088.8 6096.0 5649.7 5692.3 5745.1 5750.7 5987.6 5795.9 5812.0 5819.4 5854.5 5966.6 5759.8 5841.9 5845.6 5849.0 5874.8 5925.1 5980.4 6011.9 6014.2 6019.8 5643.9 5748.3 5789.3 5813.4 5927.2 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51827.75 Median:35910.46 stddev:88007.01 (245.1%) stddev-sans-first:88169.80 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: Values: 588.4 642.2 643.9 645.3 650.0 31184.4 39582.0 39657.0 39735.0 39947.2 45153.3 45337.3 45394.5 45477.5 45784.3 7895.2 8031.8 8847.5 9026.6 9030.8 8130.4 10775.5 10985.5 11030.7 11037.9 10683.6 10696.2 10827.1 10827.5 10831.9 10648.9 10678.6 10724.7 10789.5 10792.3 10457.1 10568.7 10575.0 10576.4 10586.4 41775.6 42015.0 42015.2 42239.0 42244.8 3722.4 3739.8 3800.9 4151.8 4275.9 32545.8 32785.7 32811.5 33005.7 33092.0 4218.4 4249.5 4280.8 4307.1 4324.5 287368.0 291504.5 291815.0 292429.0 292751.0 56313.7 57272.1 62404.4 63244.7 63370.0 62054.7 62301.0 62369.0 62464.4 62479.7 15786.7 15889.1 15896.8 15970.4 15984.6 12873.2 12976.5 12998.7 13221.3 13227.9 20204.1 20380.6 20534.3 20594.4 20610.7 8215.2 8239.3 8358.6 8445.4 8483.0 1031.0 1080.9 1090.2 1117.0 1223.9 26239.0 26812.7 29548.6 29955.0 30002.4 1092.1 1100.7 1108.5 1110.5 1167.4 13279.7 14785.8 15070.4 15092.1 16886.2 321866.0 397115.0 397644.0 398421.0 398944.0 51498.2 51842.5 61575.0 65328.0 66594.7 1417.0 1437.9 1444.9 1446.2 1456.5 31153.7 31880.0 31963.8 32803.7 32934.8 52101.7 52746.7 52830.7 52835.7 52849.2 324994.0 326888.0 327232.0 327316.0 328329.0 35465.8 35854.6 35966.3 36152.3 36300.1 45984.0 46089.0 46730.5 47568.0 47618.3 39384.0 40472.8 40527.8 40740.4 44633.3 38776.0 45814.5 45831.0 47103.8 47626.0 39062.0 39520.4 39538.2 39697.6 39788.2 33990.7 35019.6 35257.6 40125.6 40749.8 26696.7 28324.9 30033.8 30372.4 30383.8 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33324.65 Median:22534.71 stddev:103719.42 (460.3%) stddev-sans-first:103980.88 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: Values: 383.7 386.7 387.3 389.8 390.5 14762.7 16623.8 16676.8 17847.2 17877.0 18266.8 18397.7 18539.4 18889.4 18890.6 5522.8 5614.9 5660.8 5663.7 5664.0 4305.9 4422.9 5631.6 6003.2 6257.5 6158.0 6179.1 6217.1 6231.1 6449.6 6468.2 6579.8 6611.3 6618.1 6639.2 6562.1 6579.8 6581.7 6583.9 6586.6 22179.8 22263.4 22317.3 22752.1 22901.8 2555.3 2562.7 2571.2 2599.6 2607.2 14360.6 14438.2 14578.7 14639.5 14921.0 2020.8 2025.8 2131.8 2141.8 2162.9 70831.0 72893.3 74482.6 75850.6 76744.6 15990.7 16326.6 16664.6 17182.8 17216.5 25637.4 25700.2 25907.7 25916.2 25954.2 9774.8 9801.1 9855.0 10106.9 10184.0 8421.9 8431.9 8450.7 8456.4 8477.6 6940.4 8139.3 8289.6 8317.7 8383.1 1713.6 1738.1 1745.0 1869.4 1886.2 442.5 447.5 454.0 993.6 1055.5 11181.6 14568.5 17125.4 17191.1 17392.2 968.4 1023.2 1033.9 1056.6 1059.1 9715.9 9986.0 9987.2 10132.0 10205.8 618114.0 621464.0 638230.0 641456.0 656797.1 83150.0 84762.0 84945.0 85173.0 87010.6 1228.8 1232.4 1243.0 1244.8 1246.3 16436.5 16465.3 16498.3 16647.5 16849.2 36782.6 37229.3 37444.8 37902.6 38861.0 49264.8 50603.5 51200.5 51863.5 53656.0 10081.8 10145.0 10306.5 10387.9 10398.0 12183.1 12271.1 12273.5 12386.2 17455.6 14544.9 14960.3 15157.8 15174.0 15377.5 11649.7 14683.8 15008.7 15014.7 15390.2 16010.8 16166.5 16264.4 16593.2 16624.3 9761.0 10022.5 10142.7 10285.4 10316.3 10197.1 10294.8 14689.4 15735.8 15944.9 06:00:47 INFO - 2016-01-30 06:00:47,195 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,196 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5591.14 Median:6557.64 stddev:2903.26 (44.3%) stddev-sans-first:2895.12 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: Values: 1500.7 1571.6 1605.0 1728.0 1847.8 7789.6 8158.5 8176.5 8181.1 8181.6 7979.0 8041.6 8043.9 8049.6 8063.4 2295.6 2330.1 2361.3 2367.5 2369.5 2317.5 2321.2 2322.7 2345.7 2347.8 2016.4 2058.9 2251.1 2273.3 2312.6 2328.6 2336.8 2350.5 2350.8 2350.9 2253.6 2283.4 2283.6 2286.6 2287.3 7025.3 7168.6 7291.7 7464.6 7473.4 4574.4 4659.4 4659.5 4660.5 4666.7 3115.8 3127.1 3146.5 3162.6 3205.4 1040.8 1069.4 1075.9 1088.7 1107.2 10877.1 10938.9 10954.7 10968.0 10986.6 4175.2 4232.0 4267.8 4305.7 4306.3 8955.5 8962.2 8965.6 8970.7 8982.3 4585.2 4593.4 4625.7 4628.4 4640.6 4218.4 4226.6 4263.6 4271.6 4277.2 3559.3 3611.5 3612.2 3614.8 3619.0 1064.7 1066.8 1067.7 1068.1 1072.0 1162.1 1185.2 1189.1 1193.4 1197.4 7249.3 7264.7 7800.3 7861.1 7867.2 1090.7 1141.3 1196.2 1198.9 1221.3 5329.5 6095.2 6140.8 6144.4 6155.8 7894.0 9451.9 9454.1 9550.3 9588.8 9324.8 9471.1 9482.0 9503.1 9641.4 7661.2 7667.8 7769.0 7769.7 7769.7 7338.9 7342.4 7592.5 7727.2 7731.5 8525.2 8592.7 8597.9 8644.7 8648.7 8492.8 8854.2 8855.0 9059.1 9086.0 7232.3 7320.6 7321.0 7323.4 7326.3 7688.6 7789.1 7827.2 7849.8 7866.7 7325.7 7384.7 7402.4 7405.3 7509.4 7141.0 7212.0 7291.0 7292.1 7412.6 7365.2 7378.4 7400.4 7418.3 7506.4 6981.2 7005.4 7025.9 7029.9 7030.2 6534.7 6580.5 6601.0 6603.8 6610.6 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5506.32 Median:6242.99 stddev:1647.68 (26.4%) stddev-sans-first:1606.18 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: Values: 348.3 348.4 353.7 365.1 368.4 6000.8 6057.8 6095.1 6125.1 6140.5 5957.9 6087.2 6139.6 6150.8 6151.3 4817.6 4820.4 4824.7 4826.5 4833.0 4532.1 4629.1 4673.5 4757.4 4818.7 4699.6 4735.9 4759.6 4765.3 4765.7 4743.6 4750.2 4758.7 4760.9 4786.1 4239.2 4245.5 4246.2 4251.0 4255.2 5722.3 5835.3 5897.4 5917.9 5925.0 5511.6 5522.2 5531.5 5537.8 5544.9 6239.3 6423.3 6562.0 6576.1 6583.5 4488.7 4570.3 4576.4 4599.4 4600.3 6639.8 6697.9 6706.2 6717.8 6719.7 4592.2 4615.7 4615.9 4619.5 4622.1 4612.3 4772.4 4781.1 4781.1 4801.6 5477.3 5477.6 5483.1 5493.7 5499.2 6552.3 6554.1 6558.1 6563.9 6567.9 1653.8 1660.3 1688.1 1689.2 1692.2 1114.7 1133.0 1146.1 1153.4 1155.0 6369.3 6385.1 6387.0 6391.7 6396.4 6778.5 6780.6 6783.1 6783.3 6788.9 6246.7 6335.7 6375.7 6380.5 6396.8 3663.2 3682.9 3691.3 3692.7 3695.4 6985.2 6994.0 6998.8 7000.7 7002.7 6848.7 6942.5 6958.1 6958.3 6958.9 7091.5 7100.1 7100.8 7102.9 7105.8 6576.6 6623.2 6666.6 6797.0 6867.7 6714.4 6732.1 6745.2 6754.0 6761.5 7050.6 7050.7 7058.9 7065.8 7066.0 4625.7 4734.1 4744.4 4759.1 4763.2 6747.6 6756.8 6762.6 6763.4 6765.7 6617.2 6623.3 6634.8 6635.4 6637.8 6428.4 6614.0 6659.3 6660.0 6663.8 6512.9 6536.3 6539.1 6551.7 6557.1 6499.2 6629.3 6660.8 6689.0 6703.0 6441.5 6442.3 6442.5 6444.0 6447.9 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14796.86 Median:26124.16 stddev:17178.82 (65.8%) stddev-sans-first:17194.97 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: Values: 825.2 867.4 899.9 903.7 924.1 13208.7 13689.0 13753.2 13845.7 13894.7 13980.4 14010.2 14017.6 14042.8 14059.1 690.8 708.2 708.9 721.2 866.6 811.1 821.4 828.4 828.6 855.8 925.6 935.1 936.0 936.0 937.1 760.9 764.3 895.9 906.3 917.7 677.5 677.5 677.8 677.9 678.4 13575.2 14012.3 14018.5 14033.9 14051.8 12694.2 12922.6 13012.9 13021.9 13290.4 11012.1 11132.1 11543.8 11634.4 11797.0 3962.8 3969.2 4010.3 4024.1 4027.6 47539.5 49621.0 49681.3 49835.0 54425.5 10983.3 11279.3 11282.2 11986.1 11997.7 17391.7 17506.6 17544.5 17643.9 17716.9 8277.3 8499.3 8717.3 8735.7 8841.4 4708.8 4759.5 4778.1 4797.4 4874.6 3251.3 3281.3 3282.7 3283.1 3285.8 576.7 593.8 595.9 605.5 614.5 671.5 674.7 676.5 704.4 737.1 8502.4 8722.1 8753.6 8880.6 9043.9 520.5 569.5 602.6 616.1 663.4 3901.3 3929.2 3986.9 4383.4 4460.8 56290.7 56512.0 56965.7 57703.4 65675.7 56409.4 56867.0 57333.4 57595.4 58076.4 48355.8 48395.5 48402.3 51890.0 53785.5 8513.8 8597.1 8855.9 8889.2 9087.4 38701.0 39871.6 40456.2 40463.4 40915.6 49018.5 49272.5 49304.3 50141.7 50495.0 11829.5 12038.5 12355.2 12561.1 13071.4 13646.2 13900.4 13952.4 13961.2 14025.3 11700.9 11826.9 11878.7 11936.9 12151.3 10906.6 11082.4 11588.6 11656.2 11731.6 10971.6 11044.6 11529.1 11582.1 11824.3 11017.1 11029.9 11091.5 11364.8 11472.8 10056.7 10219.0 10224.1 10364.7 10391.9 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:47 INFO - 2016-01-30 06:00:47,197 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2016-01-30 06:00:47,726 INFO : Browser exited with error code: 0 06:00:47 INFO - 2016-01-30 06:00:47,749 INFO : Completed test dromaeo_css (00:18:31) 06:00:47 INFO - 2016-01-30 06:00:47,749 INFO : Starting test kraken 06:00:47 INFO - 2016-01-30 06:00:47,749 DEBUG : operating with platform_type : linux_ 06:00:47 INFO - 2016-01-30 06:00:47,749 INFO : Initialising browser for kraken test... 06:00:47 INFO - 2016-01-30 06:00:47,755 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7mduai/profile http://localhost:53670/getInfo.html 06:00:51 INFO - 2016-01-30 06:00:51,869 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:51 INFO - 2016-01-30 06:00:51,869 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:51 INFO - 2016-01-30 06:00:51,869 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:51 INFO - 2016-01-30 06:00:51,869 DEBUG : BROWSER_OUTPUT: __metrics 06:00:52 INFO - 2016-01-30 06:00:52,147 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:53 INFO - 2016-01-30 06:00:53,024 INFO : Browser initialized. 06:00:53 INFO - 2016-01-30 06:00:53,025 INFO : Running cycle 1/1 for kraken test... 06:00:53 INFO - 2016-01-30 06:00:53,025 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7mduai/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:04 INFO - 2016-01-30 06:01:04,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 135118848 06:01:04 INFO - 2016-01-30 06:01:04,790 DEBUG : BROWSER_OUTPUT: 06:01:07 INFO - 2016-01-30 06:01:07,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53670/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:07 INFO - 2016-01-30 06:01:07,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 166191104 06:01:07 INFO - 2016-01-30 06:01:07,790 DEBUG : BROWSER_OUTPUT: 06:01:10 INFO - 2016-01-30 06:01:10,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53670/tests/kraken/driver.html?testName=audio-dft) 06:01:10 INFO - 2016-01-30 06:01:10,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 160661504 06:01:10 INFO - 2016-01-30 06:01:10,961 DEBUG : BROWSER_OUTPUT: 06:01:13 INFO - 2016-01-30 06:01:13,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53670/tests/kraken/driver.html?testName=audio-fft) 06:01:14 INFO - 2016-01-30 06:01:14,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 159543296 06:01:14 INFO - 2016-01-30 06:01:14,307 DEBUG : BROWSER_OUTPUT: 06:01:16 INFO - 2016-01-30 06:01:16,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53670/tests/kraken/driver.html?testName=audio-oscillator) 06:01:16 INFO - 2016-01-30 06:01:16,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 159588352 06:01:16 INFO - 2016-01-30 06:01:16,817 DEBUG : BROWSER_OUTPUT: 06:01:18 INFO - 2016-01-30 06:01:18,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:19 INFO - 2016-01-30 06:01:19,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 159662080 06:01:19 INFO - 2016-01-30 06:01:19,553 DEBUG : BROWSER_OUTPUT: 06:01:22 INFO - 2016-01-30 06:01:22,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53670/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:22 INFO - 2016-01-30 06:01:22,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 159764480 06:01:22 INFO - 2016-01-30 06:01:22,953 DEBUG : BROWSER_OUTPUT: 06:01:26 INFO - 2016-01-30 06:01:26,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53670/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:26 INFO - 2016-01-30 06:01:26,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 158908416 06:01:26 INFO - 2016-01-30 06:01:26,836 DEBUG : BROWSER_OUTPUT: 06:01:29 INFO - 2016-01-30 06:01:29,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53670/tests/kraken/driver.html?testName=json-parse-financial) 06:01:30 INFO - 2016-01-30 06:01:30,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 160374784 06:01:30 INFO - 2016-01-30 06:01:30,128 DEBUG : BROWSER_OUTPUT: 06:01:31 INFO - 2016-01-30 06:01:31,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:32 INFO - 2016-01-30 06:01:32,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 166572032 06:01:32 INFO - 2016-01-30 06:01:32,209 DEBUG : BROWSER_OUTPUT: 06:01:33 INFO - 2016-01-30 06:01:33,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:34 INFO - 2016-01-30 06:01:34,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 164265984 06:01:34 INFO - 2016-01-30 06:01:34,544 DEBUG : BROWSER_OUTPUT: 06:01:36 INFO - 2016-01-30 06:01:36,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:37 INFO - 2016-01-30 06:01:37,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 168001536 06:01:37 INFO - 2016-01-30 06:01:37,131 DEBUG : BROWSER_OUTPUT: 06:01:39 INFO - 2016-01-30 06:01:39,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:40 INFO - 2016-01-30 06:01:40,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 177115136 06:01:40 INFO - 2016-01-30 06:01:40,350 DEBUG : BROWSER_OUTPUT: 06:01:42 INFO - 2016-01-30 06:01:42,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:43 INFO - 2016-01-30 06:01:43,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 171614208 06:01:43 INFO - 2016-01-30 06:01:43,385 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53670/tests/kraken/driver.html?testName=ai-astar) 06:01:45 INFO - 2016-01-30 06:01:45,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 230768640 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:45 INFO - 2016-01-30 06:01:45,271 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;103;107;108;107;98;108;108;97 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;119;156;169;122;148;148;122;164;123 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;160;160;162;161;158;160;158 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;73;154;70;70;73;72;149;70 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;135;91;92;93;137;92;92;143 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;109;109 06:01:45 INFO - 2016-01-30 06:01:45,272 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;146;146;145;145;145 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;94;96;96;95;96;95;96;95;95 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;60;56;57;56;56;55;54;54 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;64;63;64;64;64;64 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;77;88;79;84;79;79;79;80;80 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;120;113;126;122;123;123;113;114;113 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;143;142;142;141;132;143;142;142;135 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;63;63;65;62;65;62;64;69 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:01:45 INFO - 2016-01-30 06:01:45,273 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,862 06:01:45 INFO - 2016-01-30 06:01:45,274 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:01:45 INFO - 2016-01-30 06:01:45,274 DEBUG : BROWSER_OUTPUT: __startTimestamp1454162505270__endTimestamp 06:01:45 INFO - 2016-01-30 06:01:45,274 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.50 Median:108.50 stddev:4.60 (4.2%) stddev-sans-first:4.70 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 103.0 107.0 108.0 107.0 98.0 108.0 108.0 97.0 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:151.00 stddev:19.18 (12.7%) stddev-sans-first:19.89 06:01:45 INFO - 2016-01-30 06:01:45,275 DEBUG : BROWSER_OUTPUT: Values: 154.0 119.0 156.0 169.0 122.0 148.0 148.0 122.0 164.0 123.0 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.36 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 160.0 160.0 162.0 161.0 158.0 160.0 158.0 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.40 Median:71.50 stddev:33.82 (47.3%) stddev-sans-first:35.41 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 73.0 154.0 70.0 70.0 73.0 72.0 149.0 70.0 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:22.41 (24.4%) stddev-sans-first:23.27 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 135.0 91.0 92.0 93.0 137.0 92.0 92.0 143.0 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 06:01:45 INFO - 2016-01-30 06:01:45,276 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.75 (3.1%) stddev-sans-first:1.83 06:01:45 INFO - 2016-01-30 06:01:45,277 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 60.0 56.0 57.0 56.0 56.0 55.0 54.0 54.0 06:01:45 INFO - 2016-01-30 06:01:45,278 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,278 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:01:45 INFO - 2016-01-30 06:01:45,278 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 06:01:45 INFO - 2016-01-30 06:01:45,278 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,278 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.50 stddev:3.20 (4.0%) stddev-sans-first:3.36 06:01:45 INFO - 2016-01-30 06:01:45,279 DEBUG : BROWSER_OUTPUT: Values: 79.0 77.0 88.0 79.0 84.0 79.0 79.0 79.0 80.0 80.0 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:121.00 stddev:5.38 (4.4%) stddev-sans-first:5.27 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: Values: 112.0 120.0 113.0 126.0 122.0 123.0 123.0 113.0 114.0 113.0 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.70 Median:142.00 stddev:4.06 (2.9%) stddev-sans-first:3.93 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: Values: 135.0 143.0 142.0 142.0 141.0 132.0 143.0 142.0 142.0 135.0 06:01:45 INFO - 2016-01-30 06:01:45,280 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,281 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.05 (3.2%) stddev-sans-first:2.15 06:01:45 INFO - 2016-01-30 06:01:45,281 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 65.0 62.0 65.0 62.0 64.0 69.0 06:01:45 INFO - 2016-01-30 06:01:45,281 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:45 INFO - 2016-01-30 06:01:45,281 DEBUG : BROWSER_OUTPUT: 06:01:45 INFO - 2016-01-30 06:01:45,950 INFO : Browser exited with error code: 0 06:01:45 INFO - 2016-01-30 06:01:45,998 INFO : Completed test kraken (00:00:58) 06:01:45 INFO - 2016-01-30 06:01:45,998 INFO : Starting test v8_7 06:01:45 INFO - 2016-01-30 06:01:45,998 DEBUG : operating with platform_type : linux_ 06:01:45 INFO - 2016-01-30 06:01:45,998 INFO : Initialising browser for v8_7 test... 06:01:46 INFO - 2016-01-30 06:01:46,004 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpez6LfD/profile http://localhost:53670/getInfo.html 06:01:50 INFO - 2016-01-30 06:01:50,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:50 INFO - 2016-01-30 06:01:50,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:50 INFO - 2016-01-30 06:01:50,386 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:01:50 INFO - 2016-01-30 06:01:50,386 DEBUG : BROWSER_OUTPUT: __metrics 06:01:50 INFO - 2016-01-30 06:01:50,548 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:51 INFO - 2016-01-30 06:01:51,274 INFO : Browser initialized. 06:01:51 INFO - 2016-01-30 06:01:51,274 INFO : Running cycle 1/1 for v8_7 test... 06:01:51 INFO - 2016-01-30 06:01:51,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpez6LfD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:02:03 INFO - 2016-01-30 06:02:03,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 134578176 06:02:03 INFO - 2016-01-30 06:02:03,056 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53670/tests/v8_7/run.html (next: http://localhost:53670/tests/v8_7/run.html) 06:02:24 INFO - 2016-01-30 06:02:24,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 424833024 06:02:24 INFO - 2016-01-30 06:02:24,675 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,675 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:02:24 INFO - 2016-01-30 06:02:24,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:02:24 INFO - 2016-01-30 06:02:24,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:02:24 INFO - 2016-01-30 06:02:24,676 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:02:24 INFO - 2016-01-30 06:02:24,676 DEBUG : BROWSER_OUTPUT: |0;Richards;172.0282126268708 06:02:24 INFO - 2016-01-30 06:02:24,676 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.15276630883568 06:02:24 INFO - 2016-01-30 06:02:24,677 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 06:02:24 INFO - 2016-01-30 06:02:24,677 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 06:02:24 INFO - 2016-01-30 06:02:24,677 DEBUG : BROWSER_OUTPUT: |4;RayTrace;985.2216748768473 06:02:24 INFO - 2016-01-30 06:02:24,677 DEBUG : BROWSER_OUTPUT: |5;Earley;543.1830526887561 06:02:24 INFO - 2016-01-30 06:02:24,678 DEBUG : BROWSER_OUTPUT: |6;Boyer;10520.833333333334 06:02:24 INFO - 2016-01-30 06:02:24,678 DEBUG : BROWSER_OUTPUT: |7;RegExp;24634.146341463416 06:02:24 INFO - 2016-01-30 06:02:24,678 DEBUG : BROWSER_OUTPUT: |8;Splay;518.6721991701245 06:02:24 INFO - 2016-01-30 06:02:24,678 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 06:02:24 INFO - 2016-01-30 06:02:24,679 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:02:24 INFO - 2016-01-30 06:02:24,679 DEBUG : BROWSER_OUTPUT: __startTimestamp1454162544675__endTimestamp 06:02:24 INFO - 2016-01-30 06:02:24,679 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,679 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:02:24 INFO - 2016-01-30 06:02:24,680 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:02:24 INFO - 2016-01-30 06:02:24,680 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,680 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.03 Median:172.03 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,680 DEBUG : BROWSER_OUTPUT: Values: 172.0 06:02:24 INFO - 2016-01-30 06:02:24,681 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,681 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.15 Median:165.15 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,681 DEBUG : BROWSER_OUTPUT: Values: 165.2 06:02:24 INFO - 2016-01-30 06:02:24,681 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,681 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: Values: 278.3 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: Values: 5133.3 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:985.22 Median:985.22 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: Values: 985.2 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,682 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.18 Median:543.18 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: Values: 543.2 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10520.83 Median:10520.83 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: Values: 10520.8 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24634.15 Median:24634.15 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: Values: 24634.1 06:02:24 INFO - 2016-01-30 06:02:24,683 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.67 Median:518.67 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: Values: 518.7 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:02:24 INFO - 2016-01-30 06:02:24,684 DEBUG : BROWSER_OUTPUT: 06:02:25 INFO - 2016-01-30 06:02:25,346 INFO : Browser exited with error code: 0 06:02:25 INFO - 2016-01-30 06:02:25,364 INFO : Completed test v8_7 (00:00:39) 06:02:25 INFO - 2016-01-30 06:02:25,719 INFO : Completed test suite (00:20:09) 06:02:25 INFO - 2016-01-30 06:02:25,719 DEBUG : Working with test: dromaeo_css 06:02:25 INFO - 2016-01-30 06:02:25,720 DEBUG : Generating results file: dromaeo_css 06:02:25 INFO - 2016-01-30 06:02:25,721 DEBUG : Working with test: kraken 06:02:25 INFO - 2016-01-30 06:02:25,721 DEBUG : Generating results file: kraken 06:02:25 INFO - 2016-01-30 06:02:25,721 INFO : javascript benchmark 06:02:25 INFO - 2016-01-30 06:02:25,721 DEBUG : Working with test: v8_7 06:02:25 INFO - 2016-01-30 06:02:25,721 DEBUG : Generating results file: v8_7 06:02:25 INFO - 2016-01-30 06:02:25,722 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:25 INFO - 2016-01-30 06:02:25,929 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 06:02:25 INFO - 2016-01-30 06:02:25,929 DEBUG : process_Request line: dromaeo_css 7460.95 graph.html#tests=[[72,53,35]] 06:02:25 INFO - 2016-01-30 06:02:25,929 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:26 INFO - 2016-01-30 06:02:26,047 DEBUG : process_Request line: kraken 1472.60 graph.html#tests=[[232,53,35]] 06:02:26 INFO - 2016-01-30 06:02:26,047 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:02:26 INFO - 2016-01-30 06:02:26,101 DEBUG : process_Request line: v8_7 23149.36 graph.html#tests=[[230,53,35]] 06:02:26 INFO - 2016-01-30 06:02:26,103 INFO : javascript benchmark 06:02:26 INFO - 2016-01-30 06:02:26,107 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3285.1458620758604, 3392.2197894484284, 3418.6239513653495, 3419.281950790334, 3443.5695538057753, 5625.718714064295, 5636.070048442012, 5643.0971044632815, 5652.406497317784, 5673.00722373585, 5659.4340565943485, 5665.1785491103765, 5666.858328541788, 5668.404817494165, 5684.403137670537, 4793.233082706767, 5115.386153661557, 5138.049460849755, 5193.480651934795, 5219.164933610623, 5025.949740502603, 5042.672226305279, 5051.116054690433, 5052.873678158038, 5065.696058236499, 5068.5438310552045, 5089.694618322894, 5096.311997880276, 5184.092783762845, 5253.789848406059, 5023.974880125595, 5056.342675452204, 5057.519535644108, 5062.949370506321, 5106.412762532319, 4902.779374928136, 4934.407871055496, 5039.596832253411, 5058.974705126488, 5084.084864724348, 5175.844724658266, 5177.58579313654, 5274.446183150791, 5288.180332048539, 5334.706591137486, 5991.161237426763, 6016.278046634388, 6060.030395136757, 6064.847678940987, 6069.787557435468, 6095.420935011167, 6107.72515236811, 6122.908156377658, 6127.0, 6128.233970753656, 5412.621116521845, 5585.888282234373, 5600.915986260209, 5719.628224165416, 5721.71391430431, 5987.820365388958, 5993.310769261503, 6007.639541627516, 6010.459058684652, 6016.398360164036, 5843.328017277982, 5848.619839710405, 5850.12248162779, 5856.355800861902, 5857.179994800731, 5850.063989761617, 5915.201447804578, 5948.672822994777, 6060.878782424415, 6082.939170608237, 5989.071693887455, 6030.33666296707, 6035.0, 6035.185249991283, 6052.57631965767, 5792.0, 5991.161237426763, 6010.068439391901, 6051.697415129226, 6055.939440605625, 4462.866114016585, 4530.61489773373, 4594.356790049395, 4602.0, 4615.215413379734, 4082.183563287295, 4094.0, 4104.4664193654635, 4120.0, 4133.607307305801, 5595.21666966625, 5713.4000929902595, 5786.768529258782, 5796.188533605298, 5801.767929282866, 6134.846628834315, 6218.81343559694, 6219.0, 6239.719212635442, 6241.063840423882, 5661.603687741901, 5665.348484924287, 5665.405132461115, 5666.291713535808, 5676.262085928885, 4961.677490963076, 5051.494850514992, 5156.407013193456, 5159.0, 5210.583153347723, 6341.048842673636, 6377.617342959345, 6387.265464471552, 6396.136521569621, 6409.038644203313, 6208.937910621016, 6210.068489726577, 6214.564980451325, 6215.595986260879, 6227.688615569294, 5967.403259673998, 6030.547708921761, 6117.462039585284, 6292.2134733158355, 6351.618902865843, 6009.098635204754, 6025.548083893638, 6031.939680603138, 6040.063790112539, 6059.606125601998, 6048.0625503047095, 6066.029435290332, 6075.119107729266, 6088.847778805565, 6095.969520152371, 5649.661020338793, 5692.345380281321, 5745.052066408995, 5750.712464376681, 5987.64074155552, 5795.855103622274, 5812.0, 5819.447152520504, 5854.502367298657, 5966.552508561788, 5759.798407055733, 5841.883162336644, 5845.590808643354, 5848.970755146197, 5874.794382196603, 5925.111233315038, 5980.372060933713, 6011.879762404815, 6014.248218972629, 6019.759209631566, 5643.943560564506, 5748.281464816898, 5789.305283366023, 5813.418658134153, 5927.229460170151], "unit": "ms", "name": "dojo.html", "value": 5544.134076093434}, {"lowerIsBetter": false, "replicates": [588.4027711872448, 642.1683919324471, 643.8551325951661, 645.3127419298444, 649.9935000649994, 31184.376312473767, 39582.0, 39656.99999999996, 39734.99999999993, 39947.201055978934, 45153.32270015952, 45337.31994020084, 45394.546054539445, 45477.54522454774, 45784.313235301495, 7895.210478952087, 8031.759047228563, 8847.469151850877, 9026.593803278869, 9030.819383612325, 8130.430869839084, 10775.515101820398, 10985.505652245629, 11030.724231894186, 11037.944810275938, 10683.626073087444, 10696.197785166143, 10827.133829293638, 10827.458627068654, 10831.945840270828, 10648.893511064867, 10678.572857085706, 10724.678259652223, 10789.514471848746, 10792.298500597437, 10457.111145552637, 10568.735781605445, 10575.048245657928, 10576.365418074864, 10586.36481811086, 41775.58224417747, 42015.0, 42015.159696805895, 42239.0, 42244.78877605623, 3722.40441529354, 3739.7569158004917, 3800.9429858552144, 4151.7924103794685, 4275.87172384829, 32545.837270813732, 32785.67619958845, 32811.50782738261, 33005.6699433005, 33092.0, 4218.430511880888, 4249.521941166559, 4280.807363668642, 4307.07397909451, 4324.524302326741, 287368.0, 291504.5424772884, 291815.0, 292429.0, 292751.0, 56313.7184314084, 57272.14091788627, 62404.375956240765, 63244.68377658174, 63370.0, 62054.68972655108, 62301.0, 62369.0, 62464.37535624586, 62479.68760156261, 15786.68426631484, 15889.126098064717, 15896.841031589767, 15970.36118555268, 15984.600384990235, 12873.163244389085, 12976.545820896223, 12998.740025199442, 13221.338933053308, 13227.93386033083, 20204.090815913318, 20380.592388152152, 20534.281300154424, 20594.38216853497, 20610.690839637417, 8215.219554142346, 8239.299659528888, 8358.582070896431, 8445.366597505088, 8483.0, 1030.9844802869168, 1080.9082826345448, 1090.2041509697965, 1116.9556464705527, 1223.889849913512, 26239.0, 26812.731872681023, 29548.556771648444, 29955.0, 30002.399952000836, 1092.126298960828, 1100.6863044032411, 1108.490094556513, 1110.5119140351967, 1167.3754541320352, 13279.66800829987, 14785.778213326808, 15070.397184112731, 15092.094474331576, 16886.155692215587, 321866.0, 397115.0, 397644.0, 398421.0, 398944.0, 51498.22752658713, 51842.481575184516, 61575.0, 65328.0, 66594.66702666455, 1416.978745318821, 1437.8856386300702, 1444.8627380398846, 1446.2045874768835, 1456.4975083596141, 31153.68846311508, 31880.0, 31963.840180798947, 32803.67196328006, 32934.83532582322, 52101.7394913023, 52746.736266318425, 52830.735846320524, 52835.735821320646, 52849.20726189187, 324994.0, 326888.0, 327232.0, 327316.0, 328329.0, 35465.82267088648, 35854.64145358513, 35966.280674386886, 36152.27695446129, 36300.09249768777, 45984.0, 46089.0, 46730.53269467398, 47568.0, 47618.285725713446, 39384.03920474951, 40472.79763601163, 40527.79736101301, 40740.388894167205, 44633.33050004317, 38776.0, 45814.541854581024, 45831.0, 47103.76448117737, 47626.0, 39062.0, 39520.40719389154, 39538.209235815695, 39697.603023969394, 39788.20423591454, 33990.66009339974, 35019.64980350266, 35257.647423525435, 40125.598744013354, 40749.79625101855, 26696.733032669425, 28324.858375708813, 30033.84983075158, 30372.392552149275, 30383.848080759453], "unit": "ms", "name": "ext.html", "value": 20392.316073311184}, {"lowerIsBetter": false, "replicates": [383.7237189223758, 386.675192838016, 387.26999605743174, 389.77977442744844, 390.53526303698595, 14762.704745905075, 16623.75064374034, 16676.83323166768, 17847.196876140573, 17877.0, 18266.817331826678, 18397.724034139497, 18539.35112271071, 18889.433317000512, 18890.62218755624, 5522.779088836452, 5614.943850561483, 5660.773569057254, 5663.745131469073, 5664.037113690682, 4305.870823875289, 4422.911541769163, 5631.63394379366, 6003.189569408118, 6257.530685198628, 6158.0, 6179.073139029137, 6217.129601855721, 6231.127642130083, 6449.645269510175, 6468.191476065492, 6579.835504112388, 6611.338866113374, 6618.07346971422, 6639.170103737033, 6562.081308616797, 6579.769708060195, 6581.7367305307735, 6583.93416065838, 6586.604803711793, 22179.778202217934, 22263.44341391462, 22317.33048008546, 22752.089916403325, 22901.77098229013, 2555.297293244354, 2562.7181010088875, 2571.2029270926073, 2599.558075127214, 2607.2308668942705, 14360.64098397538, 14438.20589867557, 14578.708425831424, 14639.487617933428, 14921.030133041317, 2020.7878172791793, 2025.7974202579624, 2131.7548481924623, 2141.839362047853, 2162.8810415427147, 70831.0, 72893.27106728971, 74482.62758686172, 75850.62074689647, 76744.61627691882, 15990.680186396206, 16326.591835204215, 16664.583385415463, 17182.828171718375, 17216.483505494856, 25637.359066023124, 25700.228993130237, 25907.740922590532, 25916.222513324632, 25954.22137335883, 9774.804503910023, 9801.068898454636, 9854.950725246472, 10106.949465252774, 10184.032516910882, 8421.873671894926, 8431.873521897176, 8450.66197352099, 8456.40805143634, 8477.576121193915, 6940.414348870233, 8139.30815880645, 8289.58552072394, 8317.667293308321, 8383.11977242393, 1713.5801728576578, 1738.1483073293996, 1744.9738253925948, 1869.364416098533, 1886.1700851625515, 442.5397586510058, 447.5144468251918, 454.0, 993.6323560282597, 1055.4933631856752, 11181.608643697431, 14568.49010284635, 17125.400610978806, 17191.05449200281, 17392.21735021927, 968.4141094637783, 1023.22746326523, 1033.943133127685, 1056.5509658395306, 1059.131512160037, 9715.854262186072, 9985.950070249748, 9987.202303585424, 10132.0, 10205.795884082278, 618114.0, 621464.0, 638230.0, 641456.0, 656797.0762686532, 83150.0, 84762.0, 84945.0, 85173.0, 87010.56494717486, 1228.791105512065, 1232.420762241745, 1242.9502819887284, 1244.8319476870688, 1246.2709315050615, 16436.506904792874, 16465.25906334242, 16498.25757840876, 16647.500574982285, 16849.15754212309, 36782.63217367899, 37229.25541489209, 37444.81277593595, 37902.62097378991, 38861.0, 49264.75367623282, 50603.493965059875, 51200.48799511957, 51863.481365185864, 53656.0, 10081.848772268275, 10145.0, 10306.484675766033, 10387.94806025965, 10398.0, 12183.147179697336, 12271.079669025037, 12273.509059637872, 12386.194897331645, 17455.56361090983, 14544.927275363556, 14960.326785294905, 15157.772633410286, 15174.0, 15377.461788837338, 11649.708757281136, 14683.779743303645, 15008.6998260032, 15014.6997060056, 15390.230488475756, 16010.759838602664, 16166.515004549883, 16264.430744923871, 16593.170341483117, 16624.3350265988, 9760.951195243979, 10022.548985295532, 10142.746431339276, 10285.43430111351, 10316.329438586468, 10197.13324367437, 10294.794104117726, 14689.41242350294, 15735.842641573438, 15944.920275398548], "unit": "ms", "name": "jquery.html", "value": 10003.96470705624}, {"lowerIsBetter": false, "replicates": [1500.6848561802021, 1571.55210764932, 1604.9888570200771, 1727.9654406911861, 1847.8429333506642, 7789.6494657740395, 8158.510489370642, 8176.509409435431, 8181.140980197068, 8181.631826567811, 7978.960105199466, 8041.557714325724, 8043.91956080439, 8049.637766300516, 8063.435559510836, 2295.6326987681973, 2330.114556468544, 2361.327021798788, 2367.538330025646, 2369.526094781042, 2317.5480781247666, 2321.2223904991847, 2322.6516022596575, 2345.6833327500826, 2347.776961188693, 2016.3950814755588, 2058.87646741196, 2251.1108112295633, 2273.2839155665997, 2312.6415405612156, 2328.6041372966465, 2336.754640762721, 2350.4711439925964, 2350.800181984525, 2350.917717879883, 2253.6281513550243, 2283.394900351408, 2283.5547068321516, 2286.622707253301, 2287.256641591473, 7025.297470252985, 7168.569885806816, 7291.744788932362, 7464.589447580381, 7473.364763995067, 4574.382458368111, 4659.394278743775, 4659.487456379796, 4660.487346391894, 4666.65000124992, 3115.750739940799, 3127.0618814355603, 3146.465100932847, 3162.6362968258713, 3205.3749518843833, 1040.7866387390566, 1069.379759739357, 1075.9408232547207, 1088.7387027113516, 1107.1696227829127, 10877.12982961369, 10938.945305273422, 10954.726131846688, 10968.0, 10986.560537578567, 4175.227582897173, 4231.9843237622745, 4267.76527291002, 4305.677074219446, 4306.332518459643, 8955.462672239686, 8962.193402593668, 8965.641374344954, 8970.686025989058, 8982.326325525612, 4585.243434833282, 4593.379893714306, 4625.676202665848, 4628.421447319085, 4640.605548528345, 4218.388333691659, 4226.598473145046, 4263.616274535307, 4271.5514870938105, 4277.1873344064525, 3559.34152181842, 3611.530501034849, 3612.205314830733, 3614.8192590370904, 3619.0228638268045, 1064.744461329291, 1066.7599790047332, 1067.7384040909872, 1068.1294744782977, 1072.045879167526, 1162.0761494611636, 1185.1703807334727, 1189.143816452153, 1193.4390836306923, 1197.4072833947077, 7249.347558719741, 7264.745733899288, 7800.258975397328, 7861.056673199253, 7867.173946735625, 1090.6782499162766, 1141.2524796258465, 1196.2045239915533, 1198.8980936620485, 1221.3038568016323, 5329.520343169056, 6095.207623009069, 6140.78507252253, 6144.354842741537, 6155.784547540815, 7894.0, 9451.905480945103, 9454.101860323259, 9550.331476796697, 9588.808223835624, 9324.813503729887, 9471.052894710612, 9481.952590237004, 9503.144716975366, 9641.37331073492, 7661.233876612294, 7667.769966901002, 7769.0, 7769.689212431439, 7769.728059518003, 7338.853222935618, 7342.3758980487255, 7592.544447333178, 7727.227277272228, 7731.458797884094, 8525.232729054414, 8592.742217733477, 8597.914020859962, 8644.697435589724, 8648.740537783877, 8492.830143396974, 8854.203121719076, 8855.0, 9059.094090591152, 9085.954570227106, 7232.276772322725, 7320.633968301457, 7321.048263725682, 7323.414126869944, 7326.3406293433845, 7688.577128258, 7789.143194248742, 7827.217278272127, 7849.843003140019, 7866.72466463671, 7325.670344834602, 7384.667689953858, 7402.3707984821895, 7405.296496832792, 7509.3617042552, 7140.964295178491, 7211.963940180265, 7290.9635451822405, 7292.0520332356455, 7412.592307423143, 7365.153007404003, 7378.372838308804, 7400.370968467741, 7418.332350088518, 7506.361959233308, 6981.197162326397, 7005.369516743517, 7025.859482810418, 7029.894551581832, 7030.156381234285, 6534.738610455719, 6580.539362244597, 6601.0, 6603.834904127243, 6610.570312929644], "unit": "ms", "name": "mootools.html", "value": 4583.954422457336}, {"lowerIsBetter": false, "replicates": [348.252997320747, 348.44075259208967, 353.7046566117292, 365.0818192246499, 368.3958308374267, 6000.819975400734, 6057.757689692407, 6095.085737139431, 6125.111858780474, 6140.478059364954, 5957.940420595793, 6087.208662873832, 6139.570230083885, 6150.784722534712, 6151.292601350846, 4817.638677099214, 4820.3733514643045, 4824.7105173689515, 4826.541478559531, 4832.9758351208375, 4532.0709254602725, 4629.074185162964, 4673.462551806551, 4757.357756702852, 4818.68678535894, 4699.600533954618, 4735.881602959919, 4759.619230461555, 4765.26138448541, 4765.7140571565815, 4743.620510359163, 4750.239961606144, 4758.666893317469, 4760.928586071212, 4786.066716990188, 4239.236937351276, 4245.469316335458, 4246.2356775780345, 4251.0010147615285, 4255.170241802819, 5722.2561067061015, 5835.270591176103, 5897.380775018647, 5917.8816423671715, 5924.97037514814, 5511.559075273968, 5522.199281104217, 5531.529819965308, 5537.833864984057, 5544.91682624761, 6239.313675495692, 6423.261324947644, 6561.967190164067, 6576.145101136869, 6583.506237032242, 4488.708233964814, 4570.3373010913565, 4576.427946506687, 4599.402077729907, 4600.263957766775, 6639.800805975829, 6697.93302066978, 6706.1952565691945, 6717.764878229287, 6719.664016799189, 4592.242280023758, 4615.676902616851, 4615.8846028848875, 4619.514950930104, 4622.14490319292, 4612.331211974245, 4772.379590653193, 4781.091592597395, 4781.13939490895, 4801.591864691471, 5477.3427188737605, 5477.643953143033, 5483.067878460672, 5493.725313734377, 5499.230107784913, 6552.312007239267, 6554.115194448784, 6558.147440832661, 6563.901541476882, 6567.868642627121, 1653.8015438147258, 1660.2528862012143, 1688.1221764682296, 1689.2482845133798, 1692.1708362902089, 1114.7046032801313, 1133.0425790207262, 1146.0888593568134, 1153.411760002388, 1154.9538018479166, 6369.331220221903, 6385.13800636908, 6387.0, 6391.680415979183, 6396.42432181106, 6778.525503214826, 6780.593164410151, 6783.118194634764, 6783.253842077367, 6788.932110678928, 6246.656433896089, 6335.746570137143, 6375.71309291083, 6380.521460890452, 6396.808095757042, 3663.157473781045, 3682.8710995115043, 3691.3171063353366, 3692.6861216796337, 3695.4087346024507, 6985.231624521299, 6994.0, 6998.790036298919, 7000.719971201197, 7002.719891204397, 6848.7260509580055, 6942.514024018371, 6958.060661810692, 6958.304169583002, 6958.93041069593, 7091.503594748318, 7100.112485939154, 7100.7869763907165, 7102.92897071033, 7105.82235444118, 6576.638284894186, 6623.205215374186, 6666.633335166418, 6797.0, 6867.690953907186, 6714.3957043866285, 6732.091167692299, 6745.156855393076, 6754.0, 6761.526693131434, 7050.612216328152, 7050.717971281091, 7058.929410705828, 7065.752698655522, 7066.046083778624, 4625.722456652612, 4734.053189362073, 4744.4069491313585, 4759.095771803346, 4763.190257656138, 6747.561408508432, 6756.797296080928, 6762.628055456997, 6763.425108865801, 6765.661716914233, 6617.246429696231, 6623.337666233531, 6634.800955971328, 6635.369639884203, 6637.800865974028, 6428.4214420702365, 6614.0, 6659.334066593302, 6660.0, 6663.833404164935, 6512.902306465312, 6536.281009089092, 6539.051837483634, 6551.737930482727, 6557.147570815763, 6499.2200935887995, 6629.270780214076, 6660.800175994728, 6689.0300906369275, 6703.0, 6441.5490915635455, 6442.2591401989375, 6442.516811239269, 6443.96778016107, 6447.871042579216], "unit": "ms", "name": "prototype.html", "value": 4974.65964493057}, {"lowerIsBetter": false, "replicates": [825.2325337436184, 867.4089270420459, 899.8560230363144, 903.7469508537612, 924.1036194890953, 13208.669783255424, 13689.0, 13753.174809511424, 13845.653858653539, 13894.65263368415, 13980.440782368718, 14010.22943738094, 14017.649558761035, 14042.789358159636, 14059.086159399632, 690.8134803603024, 708.1714394158846, 708.8972099045635, 721.2462976189881, 866.5970323799432, 811.0551207842856, 821.4373154389262, 828.3828547731918, 828.6436832162168, 855.7988872614931, 925.5557332480413, 935.0509233128346, 935.9812803743921, 936.0358830404695, 937.0582564522646, 760.8668483015477, 764.2739397572301, 895.8656201569752, 906.302147346546, 917.6925729880498, 677.478341676906, 677.5392732941598, 677.8102131403166, 677.8983152527111, 678.4063944048958, 13575.1854888706, 14012.299385030708, 14018.509352172625, 14033.859661403358, 14051.78922316166, 12694.174878632859, 12922.612321630271, 13012.86987130126, 13021.869781302255, 13290.401931913088, 11012.119030477543, 11132.109431245563, 11543.826842597367, 11634.418279086096, 11797.0, 3962.821673024721, 3969.206158768229, 4010.258102251093, 4024.074462873526, 4027.577104404054, 47539.52460475385, 49621.0, 49681.25478117831, 49835.003299934164, 54425.455745442436, 10983.286086404518, 11279.266847654877, 11282.210245282751, 11986.101042421853, 11997.700057498458, 17391.65216695659, 17506.56233594145, 17544.473665790047, 17643.91178044127, 17716.91141544284, 8277.296429803413, 8499.277561407349, 8717.259032982141, 8735.737927862174, 8841.381103322705, 4708.788104535304, 4759.50025247351, 4778.092162489116, 4797.376341075638, 4874.561289483963, 3251.284717362224, 3281.2945216778508, 3282.688144626257, 3283.1463819407127, 3285.802851828898, 576.7289373994216, 593.8485686150004, 595.9314678811992, 605.5186127029023, 614.4807637546267, 671.5030877150873, 674.723363420995, 676.4588329336511, 704.4399702236734, 737.1080991999634, 8502.404831661848, 8722.127787221227, 8753.562321884008, 8880.644774208959, 9043.864342034874, 520.5185203686575, 569.4846164221303, 602.5566328537822, 616.1466369078857, 663.3764261594087, 3901.297766402075, 3929.1945151243926, 3986.86045988389, 4383.408239887638, 4460.799264033127, 56290.718546407006, 56512.0, 56965.71517142471, 57703.422965770646, 65675.67162164158, 56409.43590564042, 56867.0, 57333.42666573364, 57595.42404575984, 58076.419235807945, 48355.75822120937, 48395.5160448398, 48402.27396589054, 51890.0, 53785.46214537883, 8513.82972340562, 8597.097304782908, 8855.91144088551, 8889.244414224864, 9087.36388452802, 38701.0, 39871.60128398679, 40456.1908761829, 40463.393049103695, 40915.59084409118, 49018.509814901394, 49272.507274928226, 49304.260436094206, 50141.74929125331, 50495.0, 11829.467673954865, 12038.518459261531, 12355.196912200678, 12561.11507863185, 13071.411786469822, 13646.181229126285, 13900.443982240597, 13952.441902324199, 13961.162330260217, 14025.29873506341, 11700.88299117032, 11826.881731182579, 11878.703032423913, 11936.940315298369, 12151.270923744603, 10906.61826836057, 11082.390468524309, 11588.594399195988, 11656.18406711522, 11731.648050558497, 10971.615993440191, 11044.613438529614, 11529.135314851588, 11582.131340149353, 11824.349660768741, 11017.092908388655, 11029.944850275697, 11091.50088246047, 11364.772704545698, 11472.82790758156, 10056.748581285527, 10219.0, 10224.079832814785, 10364.689059328231, 10391.896081039093], "unit": "ms", "name": "yui.html", "value": 6687.255468603061}], "name": "dromaeo_css", "value": 7460.949989234756}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 107.0, 108.0, 107.0, 98.0, 108.0, 108.0, 97.0], "unit": "ms", "name": "ai-astar", "value": 105.5}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 156.0, 169.0, 122.0, 148.0, 148.0, 122.0, 164.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 158.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 154.0, 70.0, 70.0, 73.0, 72.0, 149.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 135.0, 91.0, 92.0, 93.0, 137.0, 92.0, 92.0, 143.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 60.0, 56.0, 57.0, 56.0, 56.0, 55.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 88.0, 79.0, 84.0, 79.0, 79.0, 79.0, 80.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [112.0, 120.0, 113.0, 126.0, 122.0, 123.0, 123.0, 113.0, 114.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 142.0, 142.0, 141.0, 132.0, 143.0, 142.0, 142.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 62.0, 65.0, 62.0, 64.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1472.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.0282126268708], "unit": "score", "name": "Richards", "value": 205.21052600000002}, {"lowerIsBetter": false, "replicates": [165.15276630883568], "unit": "score", "name": "DeltaBlue", "value": 400.34449000000006}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [985.2216748768473], "unit": "score", "name": "RayTrace", "value": 751.0888350000004}, {"lowerIsBetter": false, "replicates": [543.1830526887561], "unit": "score", "name": "Earley", "value": 1226.958383}, {"lowerIsBetter": false, "replicates": [10520.833333333334], "unit": "score", "name": "Boyer", "value": 63.34697821782174}, {"lowerIsBetter": false, "replicates": [24634.146341463416], "unit": "score", "name": "RegExp", "value": 36.98057920792082}, {"lowerIsBetter": false, "replicates": [518.6721991701245], "unit": "score", "name": "Splay", "value": 157.114648}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23149.356592975702}]} 06:02:26 INFO - RETURN: dromaeo_css: 7460.95 06:02:26 INFO - RETURN: kraken: 1472.60 06:02:26 INFO - RETURN: v8_7: 23149.36 06:02:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23149.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7460.95"}}} 06:02:26 INFO - Return code: 0 06:02:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:02:26 INFO - # TBPL SUCCESS # 06:02:26 INFO - Running post-action listener: _resource_record_post_action 06:02:26 INFO - Running post-run listener: _resource_record_post_run 06:02:27 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 426057728; Read time: 1904; Write time: 341700 06:02:27 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 29483008; Read time: 108; Write time: 7292 06:02:27 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 7909376; Write bytes: 342036480; Read time: 1796; Write time: 309636 06:02:27 INFO - Running post-run listener: _upload_blobber_files 06:02:27 INFO - Blob upload gear active. 06:02:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:02:27 INFO - Copying logs to upload dir... 06:02:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.559498 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-30 06:02:27.362824) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-30 06:02:27.366282) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009835 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454152586/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-30 06:02:27.416832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 06:02:27.417151) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1454160031.492890-1966176418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 06:02:27.466445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-30 06:02:27.466739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-30 06:02:27.467025) ========= ========= Total master_lag: 0.28 =========