builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1460153891.45 results: success (0) buildid: 20160408123310 builduid: b272f7ad2125420187cc77c7a23e722e revision: 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.446777) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.447239) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.447567) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006554 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.499735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.500048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.596921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.597209) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.655528) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.655847) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.656237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.656560) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 15:18: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% 39.7M=0s 2016-04-08 15:18:12 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.766493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.766822) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018137 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.817353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:11.817724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 --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 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 --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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 15:18:12,518 truncating revision to first 12 chars 2016-04-08 15:18:12,518 Setting DEBUG logging. 2016-04-08 15:18:12,518 attempt 1/10 2016-04-08 15:18:12,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4d8384aa00eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 15:18:12,882 unpacking tar archive at: mozilla-beta-4d8384aa00eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:12.507831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:12.508244) ========= echo 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4d8384aa00ebe55a35807235f4591eb06dbdf1d6'] 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 program finished with exit code 0 elapsedTime=0.004587 script_repo_revision: '4d8384aa00ebe55a35807235f4591eb06dbdf1d6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:12.561658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:12.561970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 15:18:12.580536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-08 15:18:12.580837) ========= /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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:13 INFO - MultiFileLogger online at 20160408 15:18:13 in /builds/slave/test-pgo 15:18:13 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 15:18:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:18:13 INFO - {'append_to_log': False, 15:18:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:18:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:18:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:18:13 INFO - 'branch': 'Mozilla-Beta', 15:18:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:13 INFO - 'config_files': ('talos/linux_config.py',), 15:18:13 INFO - 'default_actions': ('clobber', 15:18:13 INFO - 'read-buildbot-config', 15:18:13 INFO - 'download-and-extract', 15:18:13 INFO - 'populate-webroot', 15:18:13 INFO - 'create-virtualenv', 15:18:13 INFO - 'install', 15:18:13 INFO - 'run-tests'), 15:18:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:13 INFO - 'download_minidump_stackwalk': True, 15:18:13 INFO - 'download_symbols': 'ondemand', 15:18:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:13 INFO - 'installer_path': 'installer.exe', 15:18:13 INFO - 'log_level': 'info', 15:18:13 INFO - 'log_name': 'talos', 15:18:13 INFO - 'log_to_console': True, 15:18:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:13 INFO - 'opt_config_files': (), 15:18:13 INFO - 'pip_index': False, 15:18:13 INFO - 'sps_profile': False, 15:18:13 INFO - 'sps_profile_interval': 0, 15:18:13 INFO - 'suite': 'dromaeojs', 15:18:13 INFO - 'system_bits': '32', 15:18:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:13 INFO - 'title': 'talos-linux64-ix-007', 15:18:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:13 INFO - 'use_talos_json': True, 15:18:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:18:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:13 INFO - 'work_dir': 'build'} 15:18:13 INFO - ##### 15:18:13 INFO - ##### Running clobber step. 15:18:13 INFO - ##### 15:18:13 INFO - Running pre-action listener: _resource_record_pre_action 15:18:13 INFO - Running main action method: clobber 15:18:13 INFO - rmtree: /builds/slave/test-pgo/build 15:18:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:18:14 INFO - Running post-action listener: _resource_record_post_action 15:18:14 INFO - ##### 15:18:14 INFO - ##### Running read-buildbot-config step. 15:18:14 INFO - ##### 15:18:14 INFO - Running pre-action listener: _resource_record_pre_action 15:18:14 INFO - Running main action method: read_buildbot_config 15:18:14 INFO - Using buildbot properties: 15:18:14 INFO - { 15:18:14 INFO - "project": "", 15:18:14 INFO - "product": "firefox", 15:18:14 INFO - "script_repo_revision": "production", 15:18:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:18:14 INFO - "repository": "", 15:18:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:18:14 INFO - "buildid": "20160408123310", 15:18:14 INFO - "pgo_build": "True", 15:18:14 INFO - "basedir": "/builds/slave/test-pgo", 15:18:14 INFO - "buildnumber": 201, 15:18:14 INFO - "slavename": "talos-linux64-ix-007", 15:18:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:18:14 INFO - "platform": "ubuntu64_hw", 15:18:14 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:18:14 INFO - "branch": "mozilla-beta", 15:18:14 INFO - "repo_path": "releases/mozilla-beta", 15:18:14 INFO - "revision": "4d8384aa00ebe55a35807235f4591eb06dbdf1d6", 15:18:14 INFO - "stage_platform": "linux64-pgo", 15:18:14 INFO - "builduid": "b272f7ad2125420187cc77c7a23e722e", 15:18:14 INFO - "slavebuilddir": "test" 15:18:14 INFO - } 15:18:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 15:18:14 INFO - Running post-action listener: _resource_record_post_action 15:18:14 INFO - ##### 15:18:14 INFO - ##### Running download-and-extract step. 15:18:14 INFO - ##### 15:18:14 INFO - Running pre-action listener: _resource_record_pre_action 15:18:14 INFO - Running main action method: download_and_extract 15:18:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:18: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')]} 15:18:14 INFO - https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/test_packages.json 15:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/test_packages.json 15:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:18:19 INFO - Downloaded 1412 bytes. 15:18:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:18:19 INFO - Using the following test package requirements: 15:18:19 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:18:19 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:19 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 15:18:19 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'jsshell-linux-x86_64.zip'], 15:18:19 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:19 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:18:19 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 15:18:19 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 15:18:19 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:19 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:18:19 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:18:19 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:19 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:19 INFO - https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:18:20 INFO - Downloaded 23142485 bytes. 15:18:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:18:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:18:21 INFO - Return code: 0 15:18:21 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:21 INFO - https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:18:33 INFO - Downloaded 23142485 bytes. 15:18:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:18:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:18:35 INFO - Return code: 0 15:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:35 INFO - https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 15:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 15:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 15:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:18:36 INFO - Downloaded 10801548 bytes. 15:18:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:18:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:18:36 INFO - Return code: 0 15:18:36 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')]} 15:18:36 INFO - https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:18:38 INFO - Downloaded 52865614 bytes. 15:18:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:18:38 INFO - mkdir: /builds/slave/test-pgo/properties 15:18:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:18:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:18:38 INFO - Contents: 15:18:38 INFO - build_url:https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:18:38 INFO - Running post-action listener: _resource_record_post_action 15:18:38 INFO - Running post-action listener: set_extra_try_arguments 15:18:38 INFO - ##### 15:18:38 INFO - ##### Running populate-webroot step. 15:18:38 INFO - ##### 15:18:38 INFO - Running pre-action listener: _resource_record_pre_action 15:18:38 INFO - Running main action method: populate_webroot 15:18:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:39 INFO - '--tppagecycles', 15:18:39 INFO - '7'], 15:18:39 INFO - 'tests': ['tsvgm']}}, 15:18:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:18:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:18:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:18:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'tests': ['damp', 'tps']}, 15:18:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['damp', 'tps']}, 15:18:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:18:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:39 INFO - 'other': {'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'other_l64': {'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:18:39 INFO - 'ts_paint', 15:18:39 INFO - 'tpaint', 15:18:39 INFO - 'sessionrestore', 15:18:39 INFO - 'sessionrestore_no_auto_restore']}, 15:18:39 INFO - 'svgr': {'tests': ['tsvgx', 15:18:39 INFO - 'tsvgr_opacity', 15:18:39 INFO - 'tart', 15:18:39 INFO - 'tscrollx', 15:18:39 INFO - 'cart']}, 15:18:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['tsvgx', 15:18:39 INFO - 'tsvgr_opacity', 15:18:39 INFO - 'tart', 15:18:39 INFO - 'tscrollx', 15:18:39 INFO - 'cart']}, 15:18:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'tests': ['tp5o']}, 15:18:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'talos_options': ['--e10s'], 15:18:39 INFO - 'tests': ['tp5o']}, 15:18:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'talos_options': ['--xperf_path', 15:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:39 INFO - 'tests': ['tp5n']}, 15:18:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:39 INFO - 'talos_options': ['--e10s', 15:18:39 INFO - '--xperf_path', 15:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:39 INFO - 'tests': ['tp5n']}}, 15:18:39 INFO - 'talos.zip': {'path': '', 15:18:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:39 INFO - Running post-action listener: _resource_record_post_action 15:18:39 INFO - ##### 15:18:39 INFO - ##### Running create-virtualenv step. 15:18:39 INFO - ##### 15:18:39 INFO - Running pre-action listener: _resource_record_pre_action 15:18:39 INFO - Running main action method: create_virtualenv 15:18:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:18:39 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 15:18:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:18:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:39 INFO - Using real prefix '/usr' 15:18:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:18:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:41 INFO - Installing pip.................done. 15:18:41 INFO - Return code: 0 15:18:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:18: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')]} 15:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:18: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 pip>=1.5 15:18:41 INFO - Using env: {'DISPLAY': ':0', 15:18:41 INFO - 'HOME': '/home/cltbld', 15:18:41 INFO - 'LANG': 'en_US.UTF-8', 15:18:41 INFO - 'LANGUAGE': 'en_US:en', 15:18:41 INFO - 'LOGNAME': 'cltbld', 15:18:41 INFO - 'MAIL': '/var/mail/cltbld', 15:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:41 INFO - 'MOZ_NO_REMOTE': '1', 15:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:41 INFO - 'NO_EM_RESTART': '1', 15:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:41 INFO - 'SHELL': '/bin/bash', 15:18:41 INFO - 'SHLVL': '1', 15:18:41 INFO - 'TERM': 'linux', 15:18:41 INFO - 'TMOUT': '86400', 15:18:41 INFO - 'USER': 'cltbld', 15:18:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:41 INFO - '_': '/tools/buildbot/bin/python'} 15:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:41 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 15:18:41 INFO - Cleaning up... 15:18:41 INFO - Return code: 0 15:18:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:18: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')]} 15:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', '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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:18: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 psutil>=0.7.1 15:18:41 INFO - Using env: {'DISPLAY': ':0', 15:18:41 INFO - 'HOME': '/home/cltbld', 15:18:41 INFO - 'LANG': 'en_US.UTF-8', 15:18:41 INFO - 'LANGUAGE': 'en_US:en', 15:18:41 INFO - 'LOGNAME': 'cltbld', 15:18:41 INFO - 'MAIL': '/var/mail/cltbld', 15:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:41 INFO - 'MOZ_NO_REMOTE': '1', 15:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:41 INFO - 'NO_EM_RESTART': '1', 15:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:41 INFO - 'SHELL': '/bin/bash', 15:18:41 INFO - 'SHLVL': '1', 15:18:41 INFO - 'TERM': 'linux', 15:18:41 INFO - 'TMOUT': '86400', 15:18:41 INFO - 'USER': 'cltbld', 15:18:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:41 INFO - '_': '/tools/buildbot/bin/python'} 15:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:42 INFO - Downloading/unpacking psutil>=0.7.1 15:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:44 INFO - Installing collected packages: psutil 15:18:44 INFO - Running setup.py install for psutil 15:18:44 INFO - building 'psutil._psutil_linux' extension 15:18:44 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 15:18:44 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 15:18:44 INFO - building 'psutil._psutil_posix' extension 15:18:44 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 15:18:44 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 15:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:44 INFO - Successfully installed psutil 15:18:44 INFO - Cleaning up... 15:18:44 INFO - Return code: 0 15:18:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:18:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:18:44 INFO - Using env: {'DISPLAY': ':0', 15:18:44 INFO - 'HOME': '/home/cltbld', 15:18:44 INFO - 'LANG': 'en_US.UTF-8', 15:18:44 INFO - 'LANGUAGE': 'en_US:en', 15:18:44 INFO - 'LOGNAME': 'cltbld', 15:18:44 INFO - 'MAIL': '/var/mail/cltbld', 15:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:44 INFO - 'MOZ_NO_REMOTE': '1', 15:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:44 INFO - 'NO_EM_RESTART': '1', 15:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:44 INFO - 'SHELL': '/bin/bash', 15:18:44 INFO - 'SHLVL': '1', 15:18:44 INFO - 'TERM': 'linux', 15:18:44 INFO - 'TMOUT': '86400', 15:18:44 INFO - 'USER': 'cltbld', 15:18:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:44 INFO - '_': '/tools/buildbot/bin/python'} 15:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:18:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:18:46 INFO - Installing collected packages: mozsystemmonitor 15:18:46 INFO - Running setup.py install for mozsystemmonitor 15:18:46 INFO - Successfully installed mozsystemmonitor 15:18:46 INFO - Cleaning up... 15:18:46 INFO - Return code: 0 15:18:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:18: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')]} 15:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:46 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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:46 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 15:18:46 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 15:18:46 INFO - Using env: {'DISPLAY': ':0', 15:18:46 INFO - 'HOME': '/home/cltbld', 15:18:46 INFO - 'LANG': 'en_US.UTF-8', 15:18:46 INFO - 'LANGUAGE': 'en_US:en', 15:18:46 INFO - 'LOGNAME': 'cltbld', 15:18:46 INFO - 'MAIL': '/var/mail/cltbld', 15:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:46 INFO - 'MOZ_NO_REMOTE': '1', 15:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:46 INFO - 'NO_EM_RESTART': '1', 15:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:46 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:46 INFO - 'SHELL': '/bin/bash', 15:18:46 INFO - 'SHLVL': '1', 15:18:46 INFO - 'TERM': 'linux', 15:18:46 INFO - 'TMOUT': '86400', 15:18:46 INFO - 'USER': 'cltbld', 15:18:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:46 INFO - '_': '/tools/buildbot/bin/python'} 15:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:48 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 15:18:48 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 15:18:48 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 15:18:48 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 15:18:48 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 15:18:48 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 15:18:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:18:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:49 INFO - Downloading docopt-0.6.1.tar.gz 15:18:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:49 INFO - Running setup.py install for blobuploader 15:18:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:18:49 INFO - Running setup.py install for requests 15:18:50 INFO - Running setup.py install for docopt 15:18:50 INFO - Successfully installed blobuploader requests docopt 15:18:50 INFO - Cleaning up... 15:18:50 INFO - Return code: 0 15:18:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18: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')]} 15:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:50 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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:50 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 15:18:50 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 15:18:50 INFO - Using env: {'DISPLAY': ':0', 15:18:50 INFO - 'HOME': '/home/cltbld', 15:18:50 INFO - 'LANG': 'en_US.UTF-8', 15:18:50 INFO - 'LANGUAGE': 'en_US:en', 15:18:50 INFO - 'LOGNAME': 'cltbld', 15:18:50 INFO - 'MAIL': '/var/mail/cltbld', 15:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:50 INFO - 'MOZ_NO_REMOTE': '1', 15:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:50 INFO - 'NO_EM_RESTART': '1', 15:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:50 INFO - 'SHELL': '/bin/bash', 15:18:50 INFO - 'SHLVL': '1', 15:18:50 INFO - 'TERM': 'linux', 15:18:50 INFO - 'TMOUT': '86400', 15:18:50 INFO - 'USER': 'cltbld', 15:18:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:50 INFO - '_': '/tools/buildbot/bin/python'} 15:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:50 INFO - Running setup.py (path:/tmp/pip-olOKmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:50 INFO - Running setup.py (path:/tmp/pip-y0OAF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:50 INFO - Running setup.py (path:/tmp/pip-4bRLS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:50 INFO - Running setup.py (path:/tmp/pip-m5a3eM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:50 INFO - Running setup.py (path:/tmp/pip-VIDyZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:50 INFO - Running setup.py (path:/tmp/pip-Ijnzcc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:50 INFO - Running setup.py (path:/tmp/pip-i8vLip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:51 INFO - Running setup.py (path:/tmp/pip-4j_9de-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:51 INFO - Running setup.py (path:/tmp/pip-UrggSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:51 INFO - Running setup.py (path:/tmp/pip-fn2bKG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:51 INFO - Running setup.py (path:/tmp/pip-64GQe1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:51 INFO - Running setup.py (path:/tmp/pip-IdVdPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:51 INFO - Running setup.py (path:/tmp/pip-cuRmtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:51 INFO - Running setup.py (path:/tmp/pip-6Gu2dC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:51 INFO - Running setup.py (path:/tmp/pip-skwZSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:51 INFO - Running setup.py (path:/tmp/pip-iP1Fuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:51 INFO - Running setup.py (path:/tmp/pip-J3ZqTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:51 INFO - Running setup.py install for manifestparser 15:18:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:18:51 INFO - Running setup.py install for mozcrash 15:18:51 INFO - Running setup.py install for mozdebug 15:18:52 INFO - Running setup.py install for mozdevice 15:18:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for mozfile 15:18:52 INFO - Running setup.py install for mozhttpd 15:18:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for mozinfo 15:18:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for mozInstall 15:18:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for mozleak 15:18:52 INFO - Running setup.py install for mozlog 15:18:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for moznetwork 15:18:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:18:52 INFO - Running setup.py install for mozprocess 15:18:52 INFO - Running setup.py install for mozprofile 15:18:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:18:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:18:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:18:53 INFO - Running setup.py install for mozrunner 15:18:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:18:53 INFO - Running setup.py install for mozscreenshot 15:18:53 INFO - Running setup.py install for moztest 15:18:53 INFO - Running setup.py install for mozversion 15:18:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:18:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:53 INFO - Cleaning up... 15:18:53 INFO - Return code: 0 15:18:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18: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')]} 15:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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/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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:53 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 15:18:53 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 15:18:53 INFO - Using env: {'DISPLAY': ':0', 15:18:53 INFO - 'HOME': '/home/cltbld', 15:18:53 INFO - 'LANG': 'en_US.UTF-8', 15:18:53 INFO - 'LANGUAGE': 'en_US:en', 15:18:53 INFO - 'LOGNAME': 'cltbld', 15:18:53 INFO - 'MAIL': '/var/mail/cltbld', 15:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:53 INFO - 'MOZ_NO_REMOTE': '1', 15:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:53 INFO - 'NO_EM_RESTART': '1', 15:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:53 INFO - 'SHELL': '/bin/bash', 15:18:53 INFO - 'SHLVL': '1', 15:18:53 INFO - 'TERM': 'linux', 15:18:53 INFO - 'TMOUT': '86400', 15:18:53 INFO - 'USER': 'cltbld', 15:18:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:53 INFO - '_': '/tools/buildbot/bin/python'} 15:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:53 INFO - Running setup.py (path:/tmp/pip-vKHzVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:53 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)) 15:18:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:53 INFO - Running setup.py (path:/tmp/pip-WN0Upj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:53 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)) 15:18:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:53 INFO - Running setup.py (path:/tmp/pip-fA0xb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:53 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)) 15:18:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:53 INFO - Running setup.py (path:/tmp/pip-2EpIsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:54 INFO - Running setup.py (path:/tmp/pip-2MbSjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:54 INFO - Running setup.py (path:/tmp/pip-vVSL0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:54 INFO - Running setup.py (path:/tmp/pip-kWE3X2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:54 INFO - Running setup.py (path:/tmp/pip-cg8s5Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:54 INFO - Running setup.py (path:/tmp/pip-MExWi6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:54 INFO - Running setup.py (path:/tmp/pip-Qtv0mN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:54 INFO - Running setup.py (path:/tmp/pip-lBvGFY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:54 INFO - Running setup.py (path:/tmp/pip-n0z5DF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:54 INFO - Running setup.py (path:/tmp/pip-SAEZXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:54 INFO - Running setup.py (path:/tmp/pip-rMiKa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:54 INFO - Running setup.py (path:/tmp/pip-U54lFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:54 INFO - Running setup.py (path:/tmp/pip-JaJ6CB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:54 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)) 15:18:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:54 INFO - Running setup.py (path:/tmp/pip-96kkMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:54 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)) 15:18:54 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)) 15:18:54 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)) 15:18:54 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)) 15:18:54 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:18:54 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:18:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:56 INFO - Downloading blessings-1.6.tar.gz 15:18:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:56 INFO - Installing collected packages: blessings 15:18:56 INFO - Running setup.py install for blessings 15:18:57 INFO - Successfully installed blessings 15:18:57 INFO - Cleaning up... 15:18:57 INFO - Return code: 0 15:18:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:18:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:18:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:18:57 INFO - Reading from file tmpfile_stdout 15:18:57 INFO - Current package versions: 15:18:57 INFO - argparse == 1.2.1 15:18:57 INFO - blessings == 1.6 15:18:57 INFO - blobuploader == 1.2.4 15:18:57 INFO - docopt == 0.6.1 15:18:57 INFO - manifestparser == 1.1 15:18:57 INFO - mozInstall == 1.12 15:18:57 INFO - mozcrash == 0.16 15:18:57 INFO - mozdebug == 0.1 15:18:57 INFO - mozdevice == 0.48 15:18:57 INFO - mozfile == 1.2 15:18:57 INFO - mozhttpd == 0.7 15:18:57 INFO - mozinfo == 0.9 15:18:57 INFO - mozleak == 0.1 15:18:57 INFO - mozlog == 3.1 15:18:57 INFO - moznetwork == 0.27 15:18:57 INFO - mozprocess == 0.22 15:18:57 INFO - mozprofile == 0.28 15:18:57 INFO - mozrunner == 6.11 15:18:57 INFO - mozscreenshot == 0.1 15:18:57 INFO - mozsystemmonitor == 0.0 15:18:57 INFO - moztest == 0.7 15:18:57 INFO - mozversion == 1.4 15:18:57 INFO - psutil == 3.1.1 15:18:57 INFO - requests == 1.2.3 15:18:57 INFO - wsgiref == 0.1.2 15:18:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:57 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 15:18:57 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 15:18:57 INFO - Using env: {'DISPLAY': ':0', 15:18:57 INFO - 'HOME': '/home/cltbld', 15:18:57 INFO - 'LANG': 'en_US.UTF-8', 15:18:57 INFO - 'LANGUAGE': 'en_US:en', 15:18:57 INFO - 'LOGNAME': 'cltbld', 15:18:57 INFO - 'MAIL': '/var/mail/cltbld', 15:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:57 INFO - 'MOZ_NO_REMOTE': '1', 15:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:57 INFO - 'NO_EM_RESTART': '1', 15:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:57 INFO - 'SHELL': '/bin/bash', 15:18:57 INFO - 'SHLVL': '1', 15:18:57 INFO - 'TERM': 'linux', 15:18:57 INFO - 'TMOUT': '86400', 15:18:57 INFO - 'USER': 'cltbld', 15:18:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:57 INFO - '_': '/tools/buildbot/bin/python'} 15:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 15:18:57 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 2)) 15:18:57 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 3)) 15:18:57 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 4)) 15:18:57 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 5)) 15:18:57 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 6)) 15:18:57 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 7)) 15:18:57 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 8)) 15:18:57 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 9)) 15:18:57 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:18:57 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 4)) 15:18:57 INFO - Cleaning up... 15:18:57 INFO - Return code: 0 15:18:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:18:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:18:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:18:57 INFO - Using env: {'DISPLAY': ':0', 15:18:57 INFO - 'HOME': '/home/cltbld', 15:18:57 INFO - 'LANG': 'en_US.UTF-8', 15:18:57 INFO - 'LANGUAGE': 'en_US:en', 15:18:57 INFO - 'LOGNAME': 'cltbld', 15:18:57 INFO - 'MAIL': '/var/mail/cltbld', 15:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:57 INFO - 'MOZ_NO_REMOTE': '1', 15:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:57 INFO - 'NO_EM_RESTART': '1', 15:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:57 INFO - 'SHELL': '/bin/bash', 15:18:57 INFO - 'SHLVL': '1', 15:18:57 INFO - 'TERM': 'linux', 15:18:57 INFO - 'TMOUT': '86400', 15:18:57 INFO - 'USER': 'cltbld', 15:18:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:57 INFO - '_': '/tools/buildbot/bin/python'} 15:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:57 INFO - Downloading/unpacking jsonschema 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:59 INFO - warning: no files found matching '*.txt' 15:18:59 INFO - no previously-included directories found matching 'build' 15:18:59 INFO - no previously-included directories found matching 'dist' 15:18:59 INFO - no previously-included directories found matching '.git*' 15:18:59 INFO - Installing collected packages: jsonschema, functools32 15:18:59 INFO - Running setup.py install for functools32 15:19:00 INFO - warning: no files found matching '*.txt' 15:19:00 INFO - no previously-included directories found matching 'build' 15:19:00 INFO - no previously-included directories found matching 'dist' 15:19:00 INFO - no previously-included directories found matching '.git*' 15:19:00 INFO - Successfully installed jsonschema functools32 15:19:00 INFO - Cleaning up... 15:19:00 INFO - Return code: 0 15:19:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:19:00 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')]} 15:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:00 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')]} 15:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:00 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 0x7f7e1b98af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e014e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, '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-1460152509.459411-354946931', '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 15:19:00 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 15:19:00 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 15:19:00 INFO - Using env: {'DISPLAY': ':0', 15:19:00 INFO - 'HOME': '/home/cltbld', 15:19:00 INFO - 'LANG': 'en_US.UTF-8', 15:19:00 INFO - 'LANGUAGE': 'en_US:en', 15:19:00 INFO - 'LOGNAME': 'cltbld', 15:19:00 INFO - 'MAIL': '/var/mail/cltbld', 15:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:00 INFO - 'MOZ_NO_REMOTE': '1', 15:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:00 INFO - 'NO_EM_RESTART': '1', 15:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:00 INFO - 'SHELL': '/bin/bash', 15:19:00 INFO - 'SHLVL': '1', 15:19:00 INFO - 'TERM': 'linux', 15:19:00 INFO - 'TMOUT': '86400', 15:19:00 INFO - 'USER': 'cltbld', 15:19:00 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:00 INFO - '_': '/tools/buildbot/bin/python'} 15:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:00 INFO - Downloading/unpacking flake8 15:19:00 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 15:19:00 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 15:19:00 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 15:19:00 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 15:19:00 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 15:19:00 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 15:19:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:19:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:19:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:19:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:02 INFO - no previously-included directories found matching 'docs/_build' 15:19:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:19:03 INFO - Running setup.py install for pep8 15:19:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:03 INFO - no previously-included directories found matching 'docs/_build' 15:19:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:19:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:19:03 INFO - Cleaning up... 15:19:03 INFO - Return code: 0 15:19:03 INFO - Running post-action listener: _resource_record_post_action 15:19:03 INFO - Running post-action listener: _start_resource_monitoring 15:19:03 INFO - Starting resource monitoring. 15:19:03 INFO - ##### 15:19:03 INFO - ##### Running install step. 15:19:03 INFO - ##### 15:19:03 INFO - Running pre-action listener: _resource_record_pre_action 15:19:03 INFO - Running main action method: install 15:19:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:19:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:19:03 INFO - Reading from file tmpfile_stdout 15:19:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:19:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:19:03 INFO - Reading from file tmpfile_stdout 15:19:03 INFO - Output received: 15:19:03 INFO - Usage: mozinstall [options] installer 15:19:03 INFO - Options: 15:19:03 INFO - -h, --help show this help message and exit 15:19:03 INFO - -d DEST, --destination=DEST 15:19:03 INFO - Directory to install application into. [default: 15:19:03 INFO - "/builds/slave/test-pgo"] 15:19:03 INFO - --app=APP Application being installed. [default: firefox] 15:19:03 INFO - mkdir: /builds/slave/test-pgo/build/application 15:19:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:19:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:19:15 INFO - Reading from file tmpfile_stdout 15:19:15 INFO - Output received: 15:19:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:19:15 INFO - Running post-action listener: _resource_record_post_action 15:19:15 INFO - ##### 15:19:15 INFO - ##### Running run-tests step. 15:19:15 INFO - ##### 15:19:15 INFO - Running pre-action listener: _resource_record_pre_action 15:19:15 INFO - Running main action method: run_tests 15:19:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:19:15 INFO - Python 2.7.3 15:19:15 INFO - Return code: 0 15:19:15 INFO - grabbing minidump binary from tooltool 15:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e906c0>, '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 0x1e915c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91a70>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:19:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:19:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:19:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:16 INFO - Return code: 0 15:19:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:19:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:19:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:19:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:19:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:19:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:19:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:19:17 INFO - Return code: 0 15:19:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:19:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:19:17 INFO - Using env: {'DISPLAY': ':0', 15:19:17 INFO - 'HOME': '/home/cltbld', 15:19:17 INFO - 'LANG': 'en_US.UTF-8', 15:19:17 INFO - 'LANGUAGE': 'en_US:en', 15:19:17 INFO - 'LOGNAME': 'cltbld', 15:19:17 INFO - 'MAIL': '/var/mail/cltbld', 15:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:17 INFO - 'MOZ_NO_REMOTE': '1', 15:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:17 INFO - 'NO_EM_RESTART': '1', 15:19:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:17 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:19:17 INFO - 'SHELL': '/bin/bash', 15:19:17 INFO - 'SHLVL': '1', 15:19:17 INFO - 'TERM': 'linux', 15:19:17 INFO - 'TMOUT': '86400', 15:19:17 INFO - 'USER': 'cltbld', 15:19:17 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460152509.459411-354946931', 15:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:17 INFO - '_': '/tools/buildbot/bin/python'} 15:19:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:19:17 INFO - mozversion application_buildid: 20160408123310 15:19:17 INFO - mozversion application_changeset: 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 15:19:17 INFO - mozversion application_display_name: Firefox 15:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:17 INFO - mozversion application_name: Firefox 15:19:17 INFO - mozversion application_remotingname: firefox 15:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:17 INFO - mozversion application_vendor: Mozilla 15:19:17 INFO - mozversion application_version: 46.0 15:19:17 INFO - mozversion platform_buildid: 20160408123310 15:19:17 INFO - mozversion platform_changeset: 4d8384aa00ebe55a35807235f4591eb06dbdf1d6 15:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:17 INFO - mozversion platform_version: 46.0 15:19:17 INFO - using testdate: 1460153957 15:19:17 INFO - actual date: 1460153957 15:19:17 INFO - starting webserver on 'localhost:60702' 15:19:17 INFO - SUITE-START | Running 3 tests 15:19:17 INFO - TEST-START | dromaeo_css 15:19:17 INFO - operating with platform_type : linux_ 15:19:17 INFO - Initialising browser for dromaeo_css test... 15:19:17 INFO - TEST-INFO | started process 602 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4rAAQa/profile http://localhost:60702/getInfo.html) 15:19:21 INFO - PROCESS | 602 | __metrics Screen width/height:1600/1200 15:19:21 INFO - PROCESS | 602 | colorDepth:24 15:19:21 INFO - PROCESS | 602 | Browser inner width/height: 1024/697 15:19:21 INFO - PROCESS | 602 | __metrics 15:19:21 INFO - PROCESS | 602 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:19:22 INFO - TEST-INFO | 602: exit 0 15:19:22 INFO - Browser initialized. 15:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:22 INFO - TEST-INFO | started process 690 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4rAAQa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:34 INFO - PROCESS | 690 | RSS: Main: 136941568 15:19:34 INFO - PROCESS | 690 | 15:20:25 INFO - PROCESS | 690 | 1460154025155 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] 15:22:33 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60702/tests/dromaeo/cssquery-ext.html) 15:22:34 INFO - PROCESS | 690 | RSS: Main: 213192704 15:22:34 INFO - PROCESS | 690 | 15:25:36 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-ext.html (next: http://localhost:60702/tests/dromaeo/cssquery-jquery.html) 15:25:36 INFO - PROCESS | 690 | RSS: Main: 225304576 15:25:36 INFO - PROCESS | 690 | 15:28:38 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60702/tests/dromaeo/cssquery-mootools.html) 15:28:39 INFO - PROCESS | 690 | RSS: Main: 232382464 15:28:39 INFO - PROCESS | 690 | 15:31:41 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60702/tests/dromaeo/cssquery-prototype.html) 15:31:41 INFO - PROCESS | 690 | RSS: Main: 204374016 15:31:41 INFO - PROCESS | 690 | 15:34:44 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60702/tests/dromaeo/cssquery-yui.html) 15:34:44 INFO - PROCESS | 690 | RSS: Main: 205844480 15:34:44 INFO - PROCESS | 690 | 15:37:46 INFO - PROCESS | 690 | Cycle 1(1): loaded http://localhost:60702/tests/dromaeo/cssquery-yui.html (next: http://localhost:60702/tests/dromaeo/cssquery-dojo.html) 15:37:47 INFO - PROCESS | 690 | RSS: Main: 221171712 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | __start_tp_report 15:37:47 INFO - PROCESS | 690 | _x_x_mozilla_page_load 15:37:47 INFO - PROCESS | 690 | _x_x_mozilla_page_load_details 15:37:47 INFO - PROCESS | 690 | |i|pagename|runs| 15:37:47 INFO - PROCESS | 690 | |0;dojo.html;3241.400340936927;3312.42032644287;3316.0217735767947;3356.916077098072;3379.509971054197;5285.735713214338;5287.867803304919;5297.073012222865;5304.416514183436;5315.310383269714;5301.7084060376765;5317.734113294329;5325.520703136717;5330;5337.332833395825;4828.420589529262;4882.829100981476;4912.21404575268;4960.751962401883;4964.255361695738;4879.463259041502;4896.143174944388;4957.206846904496;4958.603311735071;4966.15575352191;4850.854474365775;4865.48912364202;4934.925976110361;4936.975315123419;4990.6007519398545;4950.603951683856;4963.627727920402;4976.129177393959;4977.626677999165;5008.424031236418;4841.782119804582;4898.730569818658;4901.093297739894;4913.238448040559;4964.304997300381;5083.872903177413;5186.273921650972;5214.035403450373;5216.5305122538775;5244.108501554745;5730.68481233532;5746.540276777848;5766.163906233614;5768.192453056576;5770.855728606776;5594.552435805126;5670.121131224667;5674.262345895048;5730.9426905730825;5734.225879506255;5356.0894647909945;5405.8107966221;5407.594430417735;5414.160805075219;5436.483534064258;5943.851403714855;5959.910601340984;5965.433283838029;5965.522758179335;5966.940330596725;5558.694271815089;5640.85897852557;5673.461021202979;5732.369439361667;5746.482816546531;5804.187413762077;5816.709164541756;5819.15622234782;5847.707614619252;5853.590248682636;5743.569232307594;5759.884802303931;5776.942230577724;5780.768769249267;5782.681952492653;5426.375966763794;5547.445255474501;5736.254286942754;5763.135529670583;5765.625234359753;4422.579854913778;4471.441069866267;4476.820927162942;4497.2129877272;4504.459464864237;3945.5659877413464;3947.269755095259;3949.3483575210344;3972.523297204354;3972.5431575369203;5319.601029922771;5361.785528578813;5362.570994320523;5366.248725178478;5400.702961337086;5772.94227057724;5795.420457954171;5797.246357973437;5805.390434004453;5843.766249350064;5326.387465441447;5331.067063263913;5331.280277162611;5333.359996800331;5334.946650533522;4866.9513304867205;4869.829555965524;4897.877553061202;4937.21004639256;4959.90080198394;5986.880262394728;5989.940100599026;5990.5507086968655;5995.640261584319;6004.969975150097;5788.710564471759;5809.8547536311935;5817.825465236049;5819.272590926134;5824.242848429677;5816.534677225896;5832.183494310885;5878.118282257525;5967.343592204767;5970.731317090828;5790.305163380422;5792.21805056312;5795.652260864362;5797.652140871562;5799.333076696234;5798.362180160263;5851.473367396955;5864.091065884794;5867.9413205869105;5880.176775251382;5550.139728342114;5564.360098588552;5628.85927851807;5663.207150998781;5711.600187986801;5492.038893193755;5513.173024046425;5516.917246241229;5520.503154716095;5525.613207075467;5457.317835270591;5460.645058071213;5461.535769459481;5469.972650136724;5494.560435165097;5448.210009548672;5520.585956053232;5548.833534993957;5647.519960803378;5679.772809087755;5582.49757521825;5586.888262234814;5598.972005139948;5599.440055994368;5632.267805185464 15:37:47 INFO - PROCESS | 690 | |1;ext.html;539.8191605812053;555.5083750880469;570.1362435909598;585.058056528988;590.9261342332209;31212.53181202281;39157.216855662904;39756.20487590246;39869;39869.202615947666;42204.155916881646;42845;42847.357289640604;42871.35692964608;42886.35670464946;8780.9023872016;8933.15135062168;9010.324225683067;9059.456432614032;9063.13900179482;8687.391882568223;8767.649294028231;8825.646974121028;8827.558622068904;9053.185213330798;9055.320850936207;9110.134537218953;9128.087191280885;9128.863067053999;9132.771680707969;8982.910170898273;9009.729708108767;9019.23336516397;9064.410813297147;9071;8854.911450885538;8947.50788706621;8972.147645973622;8993.955030224806;8998.280137589043;42849;43172.3524147138;43193;43230;43262.13475730499;3611.133328001261;3700.278445703062;3791.620837916214;3882.4758657581147;4336.522982471925;32428.351432971445;32761.017169484952;32774.50838237428;33120.33759324824;34554;4137.627613514768;4225.87322380326;4235.97882010588;4238.131183107455;4331.371951067109;354171;372220;374743;376630;377233;55045.724771375884;68421.3157868415;69672.30327696759;69712;69823.65088174527;54348;54351.72824135933;54355.45644543583;54366.45633543614;55655.443445565834;18023.909880450778;18078;18144.09279536018;18171.454856354067;18172.45482635523;13963.720725585634;14229.64425889361;14271.286435678383;14271.857281427261;14275.072120312147;21446.46383840385;21921.780782192294;21941.561168776534;21980.670289945665;21988.780112198994;8079.272865442138;8304.584770761438;8356.53760591894;8362.205590468895;8430.40987130895;1041.739565108723;1043.6503771236721;1128.514738662383;1131.6265632341308;1207.9490842966675;29495.705042949296;29571.112866614036;30329.545056824165;30678.233044174074;32148.19629509281;1072.5066469423996;1105.4969988655143;1105.922585419029;1119.3955264157428;1194.2714943884223;14362.569122926328;14877.776833347509;15236.162011089496;15337.003094798802;17131.400400985905;454778;459394;460044;460760;461748;58590.70704646449;59215.70392148012;59631;59647;59678;1458.9708205835823;1465.0916431812132;1472.8600782925605;1478.150063713369;1480.5484327280283;30982.84508577443;31016.844915775277;31145.8442707785;31279.530807037456;31978.84010579932;46943.76528117474;47934.76032619954;48043.279350810466;52376.73811630918;53712;224314;224935;225355;226181;226618;32905.67094329122;33288;33315;33337.66662333443;33376.66623333735;46596;47921.5207847931;47968.760156198994;48041.27938081002;48442;37929.60868807068;38932.6106738929;39449.80275098606;39605.40591891181;40029;38273.2345353097;39748.20503589854;40021.59978400179;41216.79391603023;42524.78737606292;41155.38266925939;41337;41668.79165604274;41872;42029.579704202566;31082.378352433276;32250.516242256854;32721;36555.26889462249;37617.81191094027;25394.365140871625;27245;27339.179824605293;27578;27681.498829040294 15:37:47 INFO - PROCESS | 690 | |2;jquery.html;386.57090629401375;391.9314120028996;398.6969902873816;401.51216272229243;405.12695141969067;13368.732625347511;17261;17778.82221177788;17801.37695180669;18461.169247383867;11372.203945723802;11662.125340599447;13550;17899.105044747743;17911.55221119473;5231.999999999991;5420.5934554908345;5432.375276843154;5436.429174936634;5438.7280635968245;5282.418933917266;5366.087765079927;5369.167778994262;5370.865728356803;5373;3914.725969182158;4080.204360149772;5546.91679624806;5725.942740572604;6002.969985150068;5625.324961004665;5703.74333155009;5714.342850572196;5740.282464691913;5750.281214848144;5683.687397193153;5684.8010319638615;5693.259876216065;5694.6867922264255;5697.800576979827;14085.85914140866;18864.33974810875;20907.58184836295;21515.67726484104;21575.56848863014;2181.472968921745;2240.6526988316673;2249.426396268941;2289.7907260981233;2384.6899903012672;10304;10876.347419154876;12430.316332601704;13555.932220338835;13980.161190328612;1955.9511012224666;1980.8514361422806;2021.848361372903;2036.2262340310735;2059.4336557446672;55989.99999999959;61735.07397389043;61936.69031654858;63376.68311658458;64125.67937160331;10656.467176641137;10892.61875834342;11039.503222355013;11066.502007409525;11095.50070246841;14715.55853324402;14827;14883.553493395215;14915.70168596622;14924.328405221791;8457.534835584102;8507.702230421906;8526.616302266413;8533.317334613215;8600.78498037554;8344.749657510285;8356.832863342699;8366.414350995494;8391.95804020976;8483.618237179342;4776.426828780569;4833.178359678863;4856.927146092811;4857.975710121497;4922.409310882717;1934.6034063017048;1959.6864501679947;1962.4210857796984;1985.057097878496;1991.820736133755;688.3247623345547;979.1432496565506;992.1864071461332;1014.8579198912158;1062.984055239172;15487.457938972082;15523.767143492856;16022.278997445143;16320.673586528203;17085.402010929556;903.385697725553;933.780561568031;971.2861047130353;987.7382493639192;1064.669952314785;9302.25581953442;9548.37935534188;10049.598016079275;10053.195744340435;10149.695509134737;408576;410131;417114;567311;578777;49264.7536762321;49554.75222623864;57447;62739.372606274264;67298.66350668215;978.3885071830106;1192.6064398748392;1199.3763243113533;1216.3067051780577;1236.2397125767768;15520.456784012506;15714.135722534913;15821.683566328838;15864;15933.123678197348;22414;24626.87686561556;29208.561871571517;34098;34403.31193376169;43914.56085439232;44716.77641611771;45919.77040114778;46201.76899115483;49134.26298605452;7140.571565706075;7302.853942921006;7395.667194976131;7661;7691.807704807425;10724.302920310154;11528.308301501937;11564.363959981945;11620.186586939171;11774.764504710029;9009.189172974464;9093.181613654802;9904.306698531034;9945.353552019096;10176.236782241509;9179.586918588546;9960.900390995997;10104.141148002502;10530.842037369599;10668.359898406121;8058.435909486279;9778.608855645694;10686.358818470917;11054.944725276322;11167.553297867995;7742.4193185510185;7809.453338266494;7812.648430820513;7872.330851877655;7880.133185349721;9508.09673081084;10185.796284074426;10283.794324113625;10373.481325933522;10450.790984180427 15:37:47 INFO - PROCESS | 690 | |3;mootools.html;1432.6131944375013;1547.0794877048156;1591.5861875912267;1810.9637807243855;1921.6637088509508;7292;8296.626651800669;8476.830463390728;8484.66061357545;8492.235698787108;8316.41785075045;8491.363147763912;8522.062573116968;8524.06235314115;8528.74413767588;2377.132346693453;2397.2927986244013;2399.3881560202126;2400.7479214682467;2404.95190096198;2403.158894386959;2414.058517178302;2442.25511219079;2448.045262347686;2463.15021317646;2473.8392004519646;2482.640017197505;2494.0273293415585;2507.849529028264;2510.786583140426;2440.1581454398206;2462.249014050705;2468.6543883856275;2470.197185914585;2481.553320402327;2413.481101563172;2415.4685969086772;2427.890744916483;2427.9514409711883;2431.3556907419547;8617.698380556712;8671.13288671134;8682.175193356685;8686.174813392718;8693;5210.452902445227;5316.867078323035;5369.328833895763;5401.7299135043095;5402.324709411324;3408.880689175867;3417.333619944112;3459.290845376717;3489.59869614995;3536.0275924120815;1111.2554588425774;1137.8463907372482;1143.2054721968236;1145.7651181507854;1174.6006357838376;12453.1905426147;12462.376881155906;12465.688357791038;12478.126531142823;12487.06347023977;4884.584810291094;4902.607791376681;4925.236588328815;4931.334269873521;4968.6025117990475;10399.740006499898;10434.739131521621;10440.42577658236;10444.21668374875;10447.738806529898;5358.356997160366;5366.570674346043;5418.4039755626845;5430.294061772023;5430.728463576806;4309.159713855768;4395.362672412482;4740.336352910595;4837.612990960714;4838.685485443435;4110.116324990082;4121.155163191538;4132.607402296777;4166.66666666666;4167.291560434734;1342.912710673803;1361.659585103724;1362.4263975108765;1365.2968721108637;1370.9314534273246;1435.3253970633784;1441.099312929419;1451.8330392005055;1470.8382077971414;1471.146734893759;8247.134050924567;8275.875861862078;8294.792630184294;8297.917020829835;8336;533.1469648562347;544.1348256272466;548.2543740512899;552.5938435250088;555.1367623345656;5910.438508341701;5981.910271345933;5995.250593675791;5999.100134979788;6005.729742161613;10268.127209187154;10717.678469645924;10797.082248009006;10957.50691218897;10981.670549883516;10445.947770261251;10777.568897244022;10795.83806242907;10801.189910756724;10824.5128969195;8339.708110216234;8371.748847534462;8405.327573794082;8421.915780842113;8434.704785332606;8012.158723334199;8145.959270203611;8149.388795840217;8169.468984515987;8209.138040505899;9489.525523723923;9492.85760713576;9551.044895510393;9695.175910047725;9751.171150452292;9676.419414835133;9751;9834.065763752433;9953.900460995297;10023.69928902134;6567.540272181092;6770.763023294161;7394.963025184839;7815.804604884696;7824.061112666516;7804.921950780419;7853;7858.096318923397;7869.331106855752;7897.05235371759;7297.635118244173;7513.774586762406;7554.169041405551;7648.273414025659;7722.382209423345;7285.854282914418;7409;7424.703011879465;7509.88735168962;7530;7825.843483130419;7869.0950540688555;7885.093214280431;7888.132305446282;7896.052473703192;6994.125734283215;7091.893621595577;7165.820854478679;7172.856542869009;7200.49596528238;7281.5631062136445;7323.194448610755;7329.816754581178;7353.816154595964;7440.665170067468 15:37:47 INFO - PROCESS | 690 | |4;prototype.html;370.70528929501046;375.8552957111512;375.8722034508268;379.3266951161686;387.7673395962421;5954.702264886754;5975.25309336333;6003.879922401549;6019.157317975476;6037.275526936763;5742.196092547037;5797.420257974211;5863.2670916135485;5951.077582974646;5987.850303742409;4697.9060418791605;4713.5993440557595;4722;4732.9526704733025;4736.952630473703;4511.4135162429;4739.530745468898;4742.09900118978;4746.857594272177;4752.643551733634;4610.178979303173;4619.976900115512;4692.953070469286;4701.576858082772;4707.082118986799;4654.488006319302;4673.252279635276;4673.415823022122;4679.040796636698;4701.7414042227665;4171.812268447927;4174.853880114181;4181.60274773896;4185.204811085884;4186.204621121977;5674.347450043257;5731.455511726379;5765.1352297155345;5788.710564471759;5800;5449.01917654822;5452.972735136339;5459.262999495097;5461.754221060022;5466.070767969415;6471.741130354827;6480.967595161994;6480.967595161994;6482.286948435668;6485.643289619069;4517.751523666197;4571.22289210835;4575.771211439414;4578.2903649934315;4579.67942244043;6496.707648155844;6647.900281495781;6670.099536562599;6690.933090669128;6698.966505167492;4668.766561671903;4669.299605059268;4669.7431641260055;4670.1126785910565;4670.556297151765;4732.574068333866;4734.455537613149;4734.810607575727;4736.550027747358;4739.146953548326;5403.054465468527;5411.161270003156;5415.646088477881;5426.755795989111;5430.972845135828;6249;6461.256955450183;6485.254195767453;6498.8228943303575;6506.739730410731;1653.619667476463;1672.1722747240194;1672.690552247838;1673.2888522378184;1674.8157702652697;1109.5617231193633;1122.3882983773863;1122.4780477078198;1136.267107715519;1144.0332918683698;6271.310155882849;6276.968615156895;6280.403361680725;6281.466075383552;6284.968575157095;6510.674466276667;6620.668966551653;6651.66741662915;6674.933250667528;6684.131062961881;6148.78479253224;6229.875402492015;6254.874902501924;6265.686715664198;6312.368763123743;3598.9280214395567;3627.093226693327;3633.4913112164318;3638.472421498868;3639.1629925117372;6794.45644348451;6945.722171113099;6957.9215221640725;6959.373656370951;6960.338767817049;6883.862322753517;6900.413464855544;6907.102076730093;6908;6909.998050282681;6945.610877824354;6951.965240173767;6957.826054348682;6962.303769623099;6973.198082220508;6630.7679231226675;6692.431143352869;6730.226024007302;6743.35938085881;6754.155730533684;6578.671066446755;6581.934180658132;6593.274739778716;6597.109390232449;6602.306757790363;6946.548474349152;6955.582665040114;6962.025316455599;6962.363844496641;6974.79075627732;4645.953540464688;4723.0081682846985;4724.267738500538;4730.030343779448;4730.574248317668;6722.731090756315;6725.764598239038;6740.831479213059;6768.424683901727;6815.693293801692;6556.213254409501;6568.376004279586;6571.277159512354;6573.835654108686;6577.046328282468;6439.484841212786;6544.411003009752;6552.737890484518;6556.114924485133;6558.475321974326;6441.3880681335195;6453.580517266362;6459.515536334888;6460.709268082854;6462.4506916910705;6500.804975850732;6501.2198536175965;6507.219133703986;6508.642024688687;6509.088727578048;6310.11658367838;6406.519511036598;6416.230052393743;6419.26178489461;6429.067785171031 15:37:47 INFO - PROCESS | 690 | |5;yui.html;848.7241646464897;913.1416468519591;918.2883265469261;922.97692557686;946.5654888941584;13975.510857120003;14145.080569762971;14167.929160354197;14197.645058873533;14281.857181428182;12716.554920577782;12782.872171278308;12799.680007999781;12823.230606163614;12862.807057894115;720.020771750419;728.2280782370677;856.9700060497884;868.4702331577748;875.5097145598453;868.8045189832301;872.075599864146;874.5190145419994;876.3033388456192;876.6405773632812;920.8618707193907;923.5382308845577;925.1303774451993;926.2913870888775;927.5964955244457;762.439606888939;774.0904437286194;907.1427501011547;919.6689191890914;925.7222833150028;678.1726293921457;678.6437120511722;679.3953381490477;680.0105845994067;681.6148875885109;13889.513867014706;14019.158850469004;14041.087329323562;14099.718005639932;14132.92933535336;13051.282179480124;13553.59339219825;13631;13695.9999999999;13833.930830345884;11272.605458808903;11305.378204198765;11370.431478426046;11555.653330400102;11607.941960290229;3913.3151698452943;3942.1918506706056;3943.9802800985813;3972.82122304497;3989.261986532472;47979.52020479785;48569.75715121437;50037.74981125107;50521.49478505205;50909;10759.65504311961;10767.569297228023;10799.946000270105;10818.729531761768;11075.612353567587;18012.549686257687;18238.08809559517;18241.817581824278;18258.908705456386;18260.543486412946;8250.339972802161;8260.29787468072;8371.748847534584;8476.703315384055;8673.52295623734;4560.4071470708595;4658.534146585314;4659.603933665609;4702.130105930414;4715.198416269242;3261.934761304808;3266.2161081340782;3271.9018429447156;3287.589051368579;3295.489199174132;586.3169407640052;596.5436441122545;603.3724926076831;607.2743072028971;612.0268772651506;670.3196255800367;703.395080231001;714.6141083814682;728.730369763191;745.7129005332878;9491.857622135674;9586.328956973084;9649;9690.418574885529;9766.46284454362;558.9804356847491;699.5068476723999;724.7753196508994;731.974380896666;776.6466257852663;4298.699091063658;4357.607815296575;4383.539728328479;4428.036946681695;4440.777961101997;57721;58220.708896455246;58221.70889145527;58626;60301.39698603046;52639.73680131575;53164;53613.19580206222;53803;53911.19133213005;46765.5323446768;47140.5285947143;47161.76419117882;47453.050938981716;47736.04527909422;8896.377253592187;9504.667336643184;9596.568154433207;9608.039196080335;9642.987486314116;34203.4869476963;34911.301773964886;35369.64630353663;35819;35878.46182307215;43279.78360108179;43331.78334108309;45067.77466112648;45095.32357014582;45247.54752452565;11364.54541818318;11631;11707.531698732297;11712.88287117118;11890.464929078385;12575.874241257836;12591.748165036464;13192.274424906722;13199.934000329937;13285.53500627512;11717.824232636687;11792.823107653221;12024.458899349374;12218.144729868824;12383.257004579755;12582.811257831323;12614.55849045279;12729.490820367451;12903.548375806802;13421.194728316332;11243.437828108725;11319.660410187707;11545.191836571359;11913.16607837443;12339.93830030844;9997.404308847279;10218.795624087625;10249.692509224735;10533.262671612914;10697.304675196086;9661.758456038655;9795.608175673178;9838.704838854846;9944.204463643036;10032.347897386646 15:37:47 INFO - PROCESS | 690 | __end_tp_report 15:37:47 INFO - PROCESS | 690 | __start_cc_report 15:37:47 INFO - PROCESS | 690 | _x_x_mozilla_cycle_collect,819 15:37:47 INFO - PROCESS | 690 | __end_cc_report 15:37:47 INFO - PROCESS | 690 | __startTimestamp1460155067210__endTimestamp 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | ------- Summary: start ------- 15:37:47 INFO - PROCESS | 690 | Number of tests: 6 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#0] dojo.html Cycles:165 Average:5346.66 Median:5494.56 stddev:580.60 (10.6%) stddev-sans-first:558.39 15:37:47 INFO - PROCESS | 690 | Values: 3241.4 3312.4 3316.0 3356.9 3379.5 5285.7 5287.9 5297.1 5304.4 5315.3 5301.7 5317.7 5325.5 5330.0 5337.3 4828.4 4882.8 4912.2 4960.8 4964.3 4879.5 4896.1 4957.2 4958.6 4966.2 4850.9 4865.5 4934.9 4937.0 4990.6 4950.6 4963.6 4976.1 4977.6 5008.4 4841.8 4898.7 4901.1 4913.2 4964.3 5083.9 5186.3 5214.0 5216.5 5244.1 5730.7 5746.5 5766.2 5768.2 5770.9 5594.6 5670.1 5674.3 5730.9 5734.2 5356.1 5405.8 5407.6 5414.2 5436.5 5943.9 5959.9 5965.4 5965.5 5966.9 5558.7 5640.9 5673.5 5732.4 5746.5 5804.2 5816.7 5819.2 5847.7 5853.6 5743.6 5759.9 5776.9 5780.8 5782.7 5426.4 5547.4 5736.3 5763.1 5765.6 4422.6 4471.4 4476.8 4497.2 4504.5 3945.6 3947.3 3949.3 3972.5 3972.5 5319.6 5361.8 5362.6 5366.2 5400.7 5772.9 5795.4 5797.2 5805.4 5843.8 5326.4 5331.1 5331.3 5333.4 5334.9 4867.0 4869.8 4897.9 4937.2 4959.9 5986.9 5989.9 5990.6 5995.6 6005.0 5788.7 5809.9 5817.8 5819.3 5824.2 5816.5 5832.2 5878.1 5967.3 5970.7 5790.3 5792.2 5795.7 5797.7 5799.3 5798.4 5851.5 5864.1 5867.9 5880.2 5550.1 5564.4 5628.9 5663.2 5711.6 5492.0 5513.2 5516.9 5520.5 5525.6 5457.3 5460.6 5461.5 5470.0 5494.6 5448.2 5520.6 5548.8 5647.5 5679.8 5582.5 5586.9 5599.0 5599.4 5632.3 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#1] ext.html Cycles:180 Average:52868.14 Median:40025.30 stddev:96369.79 (240.8%) stddev-sans-first:96560.05 15:37:47 INFO - PROCESS | 690 | Values: 539.8 555.5 570.1 585.1 590.9 31212.5 39157.2 39756.2 39869.0 39869.2 42204.2 42845.0 42847.4 42871.4 42886.4 8780.9 8933.2 9010.3 9059.5 9063.1 8687.4 8767.6 8825.6 8827.6 9053.2 9055.3 9110.1 9128.1 9128.9 9132.8 8982.9 9009.7 9019.2 9064.4 9071.0 8854.9 8947.5 8972.1 8994.0 8998.3 42849.0 43172.4 43193.0 43230.0 43262.1 3611.1 3700.3 3791.6 3882.5 4336.5 32428.4 32761.0 32774.5 33120.3 34554.0 4137.6 4225.9 4236.0 4238.1 4331.4 354171.0 372220.0 374743.0 376630.0 377233.0 55045.7 68421.3 69672.3 69712.0 69823.7 54348.0 54351.7 54355.5 54366.5 55655.4 18023.9 18078.0 18144.1 18171.5 18172.5 13963.7 14229.6 14271.3 14271.9 14275.1 21446.5 21921.8 21941.6 21980.7 21988.8 8079.3 8304.6 8356.5 8362.2 8430.4 1041.7 1043.7 1128.5 1131.6 1207.9 29495.7 29571.1 30329.5 30678.2 32148.2 1072.5 1105.5 1105.9 1119.4 1194.3 14362.6 14877.8 15236.2 15337.0 17131.4 454778.0 459394.0 460044.0 460760.0 461748.0 58590.7 59215.7 59631.0 59647.0 59678.0 1459.0 1465.1 1472.9 1478.2 1480.5 30982.8 31016.8 31145.8 31279.5 31978.8 46943.8 47934.8 48043.3 52376.7 53712.0 224314.0 224935.0 225355.0 226181.0 226618.0 32905.7 33288.0 33315.0 33337.7 33376.7 46596.0 47921.5 47968.8 48041.3 48442.0 37929.6 38932.6 39449.8 39605.4 40029.0 38273.2 39748.2 40021.6 41216.8 42524.8 41155.4 41337.0 41668.8 41872.0 42029.6 31082.4 32250.5 32721.0 36555.3 37617.8 25394.4 27245.0 27339.2 27578.0 27681.5 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#2] jquery.html Cycles:180 Average:25720.37 Median:403.32 stddev:78824.53 (19543.9%) stddev-sans-first:79022.69 15:37:47 INFO - PROCESS | 690 | Values: 386.6 391.9 398.7 401.5 405.1 13368.7 17261.0 17778.8 17801.4 18461.2 11372.2 11662.1 13550.0 17899.1 17911.6 5232.0 5420.6 5432.4 5436.4 5438.7 5282.4 5366.1 5369.2 5370.9 5373.0 3914.7 4080.2 5546.9 5725.9 6003.0 5625.3 5703.7 5714.3 5740.3 5750.3 5683.7 5684.8 5693.3 5694.7 5697.8 14085.9 18864.3 20907.6 21515.7 21575.6 2181.5 2240.7 2249.4 2289.8 2384.7 10304.0 10876.3 12430.3 13555.9 13980.2 1956.0 1980.9 2021.8 2036.2 2059.4 55990.0 61735.1 61936.7 63376.7 64125.7 10656.5 10892.6 11039.5 11066.5 11095.5 14715.6 14827.0 14883.6 14915.7 14924.3 8457.5 8507.7 8526.6 8533.3 8600.8 8344.7 8356.8 8366.4 8392.0 8483.6 4776.4 4833.2 4856.9 4858.0 4922.4 1934.6 1959.7 1962.4 1985.1 1991.8 688.3 979.1 992.2 1014.9 1063.0 15487.5 15523.8 16022.3 16320.7 17085.4 903.4 933.8 971.3 987.7 1064.7 9302.3 9548.4 10049.6 10053.2 10149.7 408576.0 410131.0 417114.0 567311.0 578777.0 49264.8 49554.8 57447.0 62739.4 67298.7 978.4 1192.6 1199.4 1216.3 1236.2 15520.5 15714.1 15821.7 15864.0 15933.1 22414.0 24626.9 29208.6 34098.0 34403.3 43914.6 44716.8 45919.8 46201.8 49134.3 7140.6 7302.9 7395.7 7661.0 7691.8 10724.3 11528.3 11564.4 11620.2 11774.8 9009.2 9093.2 9904.3 9945.4 10176.2 9179.6 9960.9 10104.1 10530.8 10668.4 8058.4 9778.6 10686.4 11054.9 11167.6 7742.4 7809.5 7812.6 7872.3 7880.1 9508.1 10185.8 10283.8 10373.5 10450.8 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#3] mootools.html Cycles:180 Average:6074.87 Median:5367.95 stddev:3240.14 (60.4%) stddev-sans-first:3230.44 15:37:47 INFO - PROCESS | 690 | Values: 1432.6 1547.1 1591.6 1811.0 1921.7 7292.0 8296.6 8476.8 8484.7 8492.2 8316.4 8491.4 8522.1 8524.1 8528.7 2377.1 2397.3 2399.4 2400.7 2405.0 2403.2 2414.1 2442.3 2448.0 2463.2 2473.8 2482.6 2494.0 2507.8 2510.8 2440.2 2462.2 2468.7 2470.2 2481.6 2413.5 2415.5 2427.9 2428.0 2431.4 8617.7 8671.1 8682.2 8686.2 8693.0 5210.5 5316.9 5369.3 5401.7 5402.3 3408.9 3417.3 3459.3 3489.6 3536.0 1111.3 1137.8 1143.2 1145.8 1174.6 12453.2 12462.4 12465.7 12478.1 12487.1 4884.6 4902.6 4925.2 4931.3 4968.6 10399.7 10434.7 10440.4 10444.2 10447.7 5358.4 5366.6 5418.4 5430.3 5430.7 4309.2 4395.4 4740.3 4837.6 4838.7 4110.1 4121.2 4132.6 4166.7 4167.3 1342.9 1361.7 1362.4 1365.3 1370.9 1435.3 1441.1 1451.8 1470.8 1471.1 8247.1 8275.9 8294.8 8297.9 8336.0 533.1 544.1 548.3 552.6 555.1 5910.4 5981.9 5995.3 5999.1 6005.7 10268.1 10717.7 10797.1 10957.5 10981.7 10445.9 10777.6 10795.8 10801.2 10824.5 8339.7 8371.7 8405.3 8421.9 8434.7 8012.2 8146.0 8149.4 8169.5 8209.1 9489.5 9492.9 9551.0 9695.2 9751.2 9676.4 9751.0 9834.1 9953.9 10023.7 6567.5 6770.8 7395.0 7815.8 7824.1 7804.9 7853.0 7858.1 7869.3 7897.1 7297.6 7513.8 7554.2 7648.3 7722.4 7285.9 7409.0 7424.7 7509.9 7530.0 7825.8 7869.1 7885.1 7888.1 7896.1 6994.1 7091.9 7165.8 7172.9 7200.5 7281.6 7323.2 7329.8 7353.8 7440.7 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#4] prototype.html Cycles:180 Average:5441.25 Median:6189.33 stddev:1620.88 (26.2%) stddev-sans-first:1580.12 15:37:47 INFO - PROCESS | 690 | Values: 370.7 375.9 375.9 379.3 387.8 5954.7 5975.3 6003.9 6019.2 6037.3 5742.2 5797.4 5863.3 5951.1 5987.9 4697.9 4713.6 4722.0 4733.0 4737.0 4511.4 4739.5 4742.1 4746.9 4752.6 4610.2 4620.0 4693.0 4701.6 4707.1 4654.5 4673.3 4673.4 4679.0 4701.7 4171.8 4174.9 4181.6 4185.2 4186.2 5674.3 5731.5 5765.1 5788.7 5800.0 5449.0 5453.0 5459.3 5461.8 5466.1 6471.7 6481.0 6481.0 6482.3 6485.6 4517.8 4571.2 4575.8 4578.3 4579.7 6496.7 6647.9 6670.1 6690.9 6699.0 4668.8 4669.3 4669.7 4670.1 4670.6 4732.6 4734.5 4734.8 4736.6 4739.1 5403.1 5411.2 5415.6 5426.8 5431.0 6249.0 6461.3 6485.3 6498.8 6506.7 1653.6 1672.2 1672.7 1673.3 1674.8 1109.6 1122.4 1122.5 1136.3 1144.0 6271.3 6277.0 6280.4 6281.5 6285.0 6510.7 6620.7 6651.7 6674.9 6684.1 6148.8 6229.9 6254.9 6265.7 6312.4 3598.9 3627.1 3633.5 3638.5 3639.2 6794.5 6945.7 6957.9 6959.4 6960.3 6883.9 6900.4 6907.1 6908.0 6910.0 6945.6 6952.0 6957.8 6962.3 6973.2 6630.8 6692.4 6730.2 6743.4 6754.2 6578.7 6581.9 6593.3 6597.1 6602.3 6946.5 6955.6 6962.0 6962.4 6974.8 4646.0 4723.0 4724.3 4730.0 4730.6 6722.7 6725.8 6740.8 6768.4 6815.7 6556.2 6568.4 6571.3 6573.8 6577.0 6439.5 6544.4 6552.7 6556.1 6558.5 6441.4 6453.6 6459.5 6460.7 6462.5 6500.8 6501.2 6507.2 6508.6 6509.1 6310.1 6406.5 6416.2 6419.3 6429.1 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - PROCESS | 690 | [#5] yui.html Cycles:180 Average:14326.50 Median:4609.47 stddev:16218.34 (351.8%) stddev-sans-first:16232.25 15:37:47 INFO - PROCESS | 690 | Values: 848.7 913.1 918.3 923.0 946.6 13975.5 14145.1 14167.9 14197.6 14281.9 12716.6 12782.9 12799.7 12823.2 12862.8 720.0 728.2 857.0 868.5 875.5 868.8 872.1 874.5 876.3 876.6 920.9 923.5 925.1 926.3 927.6 762.4 774.1 907.1 919.7 925.7 678.2 678.6 679.4 680.0 681.6 13889.5 14019.2 14041.1 14099.7 14132.9 13051.3 13553.6 13631.0 13696.0 13833.9 11272.6 11305.4 11370.4 11555.7 11607.9 3913.3 3942.2 3944.0 3972.8 3989.3 47979.5 48569.8 50037.7 50521.5 50909.0 10759.7 10767.6 10799.9 10818.7 11075.6 18012.5 18238.1 18241.8 18258.9 18260.5 8250.3 8260.3 8371.7 8476.7 8673.5 4560.4 4658.5 4659.6 4702.1 4715.2 3261.9 3266.2 3271.9 3287.6 3295.5 586.3 596.5 603.4 607.3 612.0 670.3 703.4 714.6 728.7 745.7 9491.9 9586.3 9649.0 9690.4 9766.5 559.0 699.5 724.8 732.0 776.6 4298.7 4357.6 4383.5 4428.0 4440.8 57721.0 58220.7 58221.7 58626.0 60301.4 52639.7 53164.0 53613.2 53803.0 53911.2 46765.5 47140.5 47161.8 47453.1 47736.0 8896.4 9504.7 9596.6 9608.0 9643.0 34203.5 34911.3 35369.6 35819.0 35878.5 43279.8 43331.8 45067.8 45095.3 45247.5 11364.5 11631.0 11707.5 11712.9 11890.5 12575.9 12591.7 13192.3 13199.9 13285.5 11717.8 11792.8 12024.5 12218.1 12383.3 12582.8 12614.6 12729.5 12903.5 13421.2 11243.4 11319.7 11545.2 11913.2 12339.9 9997.4 10218.8 10249.7 10533.3 10697.3 9661.8 9795.6 9838.7 9944.2 10032.3 15:37:47 INFO - PROCESS | 690 | -------- Summary: end -------- 15:37:47 INFO - PROCESS | 690 | 15:37:47 INFO - TEST-INFO | 690: exit 0 15:37:47 INFO - TEST-OK | dromaeo_css | took 1110579ms 15:37:47 INFO - TEST-START | kraken 15:37:47 INFO - operating with platform_type : linux_ 15:37:47 INFO - Initialising browser for kraken test... 15:37:47 INFO - TEST-INFO | started process 890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgfs2P1/profile http://localhost:60702/getInfo.html) 15:37:52 INFO - PROCESS | 890 | __metrics Screen width/height:1600/1200 15:37:52 INFO - PROCESS | 890 | colorDepth:24 15:37:52 INFO - PROCESS | 890 | Browser inner width/height: 1024/697 15:37:52 INFO - PROCESS | 890 | __metrics 15:37:52 INFO - PROCESS | 890 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:53 INFO - TEST-INFO | 890: exit 0 15:37:53 INFO - Browser initialized. 15:37:53 INFO - Running cycle 1/1 for kraken test... 15:37:53 INFO - TEST-INFO | started process 978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgfs2P1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:05 INFO - PROCESS | 978 | RSS: Main: 137240576 15:38:05 INFO - PROCESS | 978 | 15:38:07 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60702/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:08 INFO - PROCESS | 978 | RSS: Main: 170606592 15:38:08 INFO - PROCESS | 978 | 15:38:10 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60702/tests/kraken/driver.html?testName=audio-dft) 15:38:11 INFO - PROCESS | 978 | RSS: Main: 168292352 15:38:11 INFO - PROCESS | 978 | 15:38:14 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60702/tests/kraken/driver.html?testName=audio-fft) 15:38:14 INFO - PROCESS | 978 | RSS: Main: 166842368 15:38:14 INFO - PROCESS | 978 | 15:38:16 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60702/tests/kraken/driver.html?testName=audio-oscillator) 15:38:17 INFO - PROCESS | 978 | RSS: Main: 166408192 15:38:17 INFO - PROCESS | 978 | 15:38:19 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:20 INFO - PROCESS | 978 | RSS: Main: 166273024 15:38:20 INFO - PROCESS | 978 | 15:38:22 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60702/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:23 INFO - PROCESS | 978 | RSS: Main: 164741120 15:38:23 INFO - PROCESS | 978 | 15:38:26 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60702/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:27 INFO - PROCESS | 978 | RSS: Main: 165928960 15:38:27 INFO - PROCESS | 978 | 15:38:30 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60702/tests/kraken/driver.html?testName=json-parse-financial) 15:38:30 INFO - PROCESS | 978 | RSS: Main: 166793216 15:38:30 INFO - PROCESS | 978 | 15:38:32 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:32 INFO - PROCESS | 978 | RSS: Main: 170192896 15:38:32 INFO - PROCESS | 978 | 15:38:34 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:35 INFO - PROCESS | 978 | RSS: Main: 169168896 15:38:35 INFO - PROCESS | 978 | 15:38:37 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:37 INFO - PROCESS | 978 | RSS: Main: 172531712 15:38:37 INFO - PROCESS | 978 | 15:38:40 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:40 INFO - PROCESS | 978 | RSS: Main: 175554560 15:38:40 INFO - PROCESS | 978 | 15:38:43 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:43 INFO - PROCESS | 978 | RSS: Main: 175513600 15:38:43 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:60702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60702/tests/kraken/driver.html?testName=ai-astar) 15:38:45 INFO - PROCESS | 978 | RSS: Main: 236785664 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | __start_tp_report 15:38:45 INFO - PROCESS | 978 | _x_x_mozilla_page_load 15:38:45 INFO - PROCESS | 978 | _x_x_mozilla_page_load_details 15:38:45 INFO - PROCESS | 978 | |i|pagename|runs| 15:38:45 INFO - PROCESS | 978 | |0;ai-astar;109;110;103;109;111;108;98;109;109;107 15:38:45 INFO - PROCESS | 978 | |1;audio-beat-detection;154;128;150;164;125;152;144;130;171;126 15:38:45 INFO - PROCESS | 978 | |2;audio-dft;160;160;162;161;162;161;161;163;161;161 15:38:45 INFO - PROCESS | 978 | |3;audio-fft;73;74;73;145;73;73;76;77;149;78 15:38:45 INFO - PROCESS | 978 | |4;audio-oscillator;95;96;138;95;96;95;144;94;96;141 15:38:45 INFO - PROCESS | 978 | |5;imaging-gaussian-blur;108;109;110;109;109;109;108;109;109;109 15:38:45 INFO - PROCESS | 978 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;145;145 15:38:45 INFO - PROCESS | 978 | |7;imaging-desaturate;96;96;96;96;96;95;96;95;95;96 15:38:45 INFO - PROCESS | 978 | |8;json-parse-financial;53;55;54;54;54;55;54;56;52;53 15:38:45 INFO - PROCESS | 978 | |9;json-stringify-tinderbox;64;66;64;64;64;65;64;65;65;64 15:38:45 INFO - PROCESS | 978 | |10;stanford-crypto-aes;77;78;78;78;77;77;78;78;80;78 15:38:45 INFO - PROCESS | 978 | |11;stanford-crypto-ccm;125;111;122;110;116;110;112;114;118;112 15:38:45 INFO - PROCESS | 978 | |12;stanford-crypto-pbkdf2;135;143;139;133;135;138;136;134;132;133 15:38:45 INFO - PROCESS | 978 | |13;stanford-crypto-sha256-iterative;65;64;65;63;62;63;65;64;63;65 15:38:45 INFO - PROCESS | 978 | __end_tp_report 15:38:45 INFO - PROCESS | 978 | __start_cc_report 15:38:45 INFO - PROCESS | 978 | _x_x_mozilla_cycle_collect,916 15:38:45 INFO - PROCESS | 978 | __end_cc_report 15:38:45 INFO - PROCESS | 978 | __startTimestamp1460155125666__endTimestamp 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | ------- Summary: start ------- 15:38:45 INFO - PROCESS | 978 | Number of tests: 14 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.92 (3.6%) stddev-sans-first:4.11 15:38:45 INFO - PROCESS | 978 | Values: 109.0 110.0 103.0 109.0 111.0 108.0 98.0 109.0 109.0 107.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.00 stddev:16.55 (11.0%) stddev-sans-first:17.18 15:38:45 INFO - PROCESS | 978 | Values: 154.0 128.0 150.0 164.0 125.0 152.0 144.0 130.0 171.0 126.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 15:38:45 INFO - PROCESS | 978 | Values: 160.0 160.0 162.0 161.0 162.0 161.0 161.0 163.0 161.0 161.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.50 stddev:30.58 (41.6%) stddev-sans-first:31.88 15:38:45 INFO - PROCESS | 978 | Values: 73.0 74.0 73.0 145.0 73.0 73.0 76.0 77.0 149.0 78.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.14 (23.3%) stddev-sans-first:22.89 15:38:45 INFO - PROCESS | 978 | Values: 95.0 96.0 138.0 95.0 96.0 95.0 144.0 94.0 96.0 141.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 15:38:45 INFO - PROCESS | 978 | Values: 108.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:38:45 INFO - PROCESS | 978 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:38:45 INFO - PROCESS | 978 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.17 15:38:45 INFO - PROCESS | 978 | Values: 53.0 55.0 54.0 54.0 54.0 55.0 54.0 56.0 52.0 53.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 15:38:45 INFO - PROCESS | 978 | Values: 64.0 66.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 15:38:45 INFO - PROCESS | 978 | Values: 77.0 78.0 78.0 78.0 77.0 77.0 78.0 78.0 80.0 78.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:5.21 (4.5%) stddev-sans-first:4.08 15:38:45 INFO - PROCESS | 978 | Values: 125.0 111.0 122.0 110.0 116.0 110.0 112.0 114.0 118.0 112.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:135.50 stddev:3.36 (2.5%) stddev-sans-first:3.55 15:38:45 INFO - PROCESS | 978 | Values: 135.0 143.0 139.0 133.0 135.0 138.0 136.0 134.0 132.0 133.0 15:38:45 INFO - PROCESS | 978 | 15:38:45 INFO - PROCESS | 978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.09 15:38:45 INFO - PROCESS | 978 | Values: 65.0 64.0 65.0 63.0 62.0 63.0 65.0 64.0 63.0 65.0 15:38:45 INFO - PROCESS | 978 | -------- Summary: end -------- 15:38:45 INFO - PROCESS | 978 | 15:38:46 INFO - TEST-INFO | 978: exit 0 15:38:46 INFO - TEST-OK | kraken | took 58678ms 15:38:46 INFO - TEST-START | v8_7 15:38:46 INFO - operating with platform_type : linux_ 15:38:46 INFO - Initialising browser for v8_7 test... 15:38:46 INFO - TEST-INFO | started process 1310 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfFZRJ/profile http://localhost:60702/getInfo.html) 15:38:51 INFO - PROCESS | 1310 | __metrics Screen width/height:1600/1200 15:38:51 INFO - PROCESS | 1310 | colorDepth:24 15:38:51 INFO - PROCESS | 1310 | Browser inner width/height: 1024/697 15:38:51 INFO - PROCESS | 1310 | __metrics 15:38:51 INFO - PROCESS | 1310 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:52 INFO - TEST-INFO | 1310: exit 0 15:38:52 INFO - Browser initialized. 15:38:52 INFO - Running cycle 1/1 for v8_7 test... 15:38:52 INFO - TEST-INFO | started process 1394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfFZRJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:03 INFO - PROCESS | 1394 | RSS: Main: 138178560 15:39:03 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | Cycle 1(1): loaded http://localhost:60702/tests/v8_7/run.html (next: http://localhost:60702/tests/v8_7/run.html) 15:39:26 INFO - PROCESS | 1394 | RSS: Main: 414539776 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | __start_tp_report 15:39:26 INFO - PROCESS | 1394 | _x_x_mozilla_page_load 15:39:26 INFO - PROCESS | 1394 | _x_x_mozilla_page_load_details 15:39:26 INFO - PROCESS | 1394 | |i|pagename|runs| 15:39:26 INFO - PROCESS | 1394 | |0;Richards;166.5278934221482 15:39:26 INFO - PROCESS | 1394 | |1;DeltaBlue;169.89466530750934 15:39:26 INFO - PROCESS | 1394 | |2;Encrypt;279.56388034665923 15:39:26 INFO - PROCESS | 1394 | |3;Decrypt;5175.257731958763 15:39:26 INFO - PROCESS | 1394 | |4;RayTrace;944.2870632672333 15:39:26 INFO - PROCESS | 1394 | |5;Earley;562.7462014631401 15:39:26 INFO - PROCESS | 1394 | |6;Boyer;10691.489361702128 15:39:26 INFO - PROCESS | 1394 | |7;RegExp;40380 15:39:26 INFO - PROCESS | 1394 | |8;Splay;498.00796812749 15:39:26 INFO - PROCESS | 1394 | |9;NavierStokes;4817.307692307692 15:39:26 INFO - PROCESS | 1394 | __end_tp_report 15:39:26 INFO - PROCESS | 1394 | __startTimestamp1460155166525__endTimestamp 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | ------- Summary: start ------- 15:39:26 INFO - PROCESS | 1394 | Number of tests: 10 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 166.5 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#1] DeltaBlue Cycles:1 Average:169.89 Median:169.89 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 169.9 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 279.6 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 5175.3 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#4] RayTrace Cycles:1 Average:944.29 Median:944.29 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 944.3 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#5] Earley Cycles:1 Average:562.75 Median:562.75 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 562.7 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#6] Boyer Cycles:1 Average:10691.49 Median:10691.49 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 10691.5 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#7] RegExp Cycles:1 Average:40380.00 Median:40380.00 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 40380.0 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#8] Splay Cycles:1 Average:498.01 Median:498.01 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 498.0 15:39:26 INFO - PROCESS | 1394 | 15:39:26 INFO - PROCESS | 1394 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 15:39:26 INFO - PROCESS | 1394 | Values: 4817.3 15:39:26 INFO - PROCESS | 1394 | -------- Summary: end -------- 15:39:26 INFO - PROCESS | 1394 | 15:39:27 INFO - TEST-INFO | 1394: exit 0 15:39:27 INFO - TEST-OK | v8_7 | took 40829ms 15:39:27 INFO - SUITE-END | took 1210s 15:39:27 INFO - Completed test suite (00:20:10) 15:39:27 INFO - Working with test: dromaeo_css 15:39:27 INFO - Generating results file: dromaeo_css 15:39:27 INFO - Working with test: kraken 15:39:27 INFO - Generating results file: kraken 15:39:27 INFO - javascript benchmark 15:39:27 INFO - Working with test: v8_7 15:39:27 INFO - Generating results file: v8_7 15:39:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 15:39:27 INFO - process_Request line: dromaeo_css 7240.48 graph.html#tests=[[72,53,35]] 15:39:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:27 INFO - process_Request line: kraken 1472.30 graph.html#tests=[[232,53,35]] 15:39:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:27 INFO - process_Request line: v8_7 22119.09 graph.html#tests=[[230,53,35]] 15:39:27 INFO - RETURN: dromaeo_css: 7240.48 15:39:27 INFO - RETURN: kraken: 1472.30 15:39:27 INFO - RETURN: v8_7: 22119.09 15:39:27 INFO - javascript benchmark 15:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.400340936927, 3312.42032644287, 3316.0217735767947, 3356.916077098072, 3379.509971054197, 5285.735713214338, 5287.867803304919, 5297.073012222865, 5304.416514183436, 5315.310383269714, 5301.7084060376765, 5317.734113294329, 5325.520703136717, 5330.0, 5337.332833395825, 4828.420589529262, 4882.829100981476, 4912.21404575268, 4960.751962401883, 4964.255361695738, 4879.463259041502, 4896.143174944388, 4957.206846904496, 4958.603311735071, 4966.15575352191, 4850.854474365775, 4865.48912364202, 4934.925976110361, 4936.975315123419, 4990.6007519398545, 4950.603951683856, 4963.627727920402, 4976.129177393959, 4977.626677999165, 5008.424031236418, 4841.782119804582, 4898.730569818658, 4901.093297739894, 4913.238448040559, 4964.304997300381, 5083.872903177413, 5186.273921650972, 5214.035403450373, 5216.5305122538775, 5244.108501554745, 5730.68481233532, 5746.540276777848, 5766.163906233614, 5768.192453056576, 5770.855728606776, 5594.552435805126, 5670.121131224667, 5674.262345895048, 5730.9426905730825, 5734.225879506255, 5356.0894647909945, 5405.8107966221, 5407.594430417735, 5414.160805075219, 5436.483534064258, 5943.851403714855, 5959.910601340984, 5965.433283838029, 5965.522758179335, 5966.940330596725, 5558.694271815089, 5640.85897852557, 5673.461021202979, 5732.369439361667, 5746.482816546531, 5804.187413762077, 5816.709164541756, 5819.15622234782, 5847.707614619252, 5853.590248682636, 5743.569232307594, 5759.884802303931, 5776.942230577724, 5780.768769249267, 5782.681952492653, 5426.375966763794, 5547.445255474501, 5736.254286942754, 5763.135529670583, 5765.625234359753, 4422.579854913778, 4471.441069866267, 4476.820927162942, 4497.2129877272, 4504.459464864237, 3945.5659877413464, 3947.269755095259, 3949.3483575210344, 3972.523297204354, 3972.5431575369203, 5319.601029922771, 5361.785528578813, 5362.570994320523, 5366.248725178478, 5400.702961337086, 5772.94227057724, 5795.420457954171, 5797.246357973437, 5805.390434004453, 5843.766249350064, 5326.387465441447, 5331.067063263913, 5331.280277162611, 5333.359996800331, 5334.946650533522, 4866.9513304867205, 4869.829555965524, 4897.877553061202, 4937.21004639256, 4959.90080198394, 5986.880262394728, 5989.940100599026, 5990.5507086968655, 5995.640261584319, 6004.969975150097, 5788.710564471759, 5809.8547536311935, 5817.825465236049, 5819.272590926134, 5824.242848429677, 5816.534677225896, 5832.183494310885, 5878.118282257525, 5967.343592204767, 5970.731317090828, 5790.305163380422, 5792.21805056312, 5795.652260864362, 5797.652140871562, 5799.333076696234, 5798.362180160263, 5851.473367396955, 5864.091065884794, 5867.9413205869105, 5880.176775251382, 5550.139728342114, 5564.360098588552, 5628.85927851807, 5663.207150998781, 5711.600187986801, 5492.038893193755, 5513.173024046425, 5516.917246241229, 5520.503154716095, 5525.613207075467, 5457.317835270591, 5460.645058071213, 5461.535769459481, 5469.972650136724, 5494.560435165097, 5448.210009548672, 5520.585956053232, 5548.833534993957, 5647.519960803378, 5679.772809087755, 5582.49757521825, 5586.888262234814, 5598.972005139948, 5599.440055994368, 5632.267805185464], "unit": "score", "name": "dojo.html", "value": 5310.358058224086}, {"lowerIsBetter": false, "replicates": [539.8191605812053, 555.5083750880469, 570.1362435909598, 585.058056528988, 590.9261342332209, 31212.53181202281, 39157.216855662904, 39756.20487590246, 39869.0, 39869.202615947666, 42204.155916881646, 42845.0, 42847.357289640604, 42871.35692964608, 42886.35670464946, 8780.9023872016, 8933.15135062168, 9010.324225683067, 9059.456432614032, 9063.13900179482, 8687.391882568223, 8767.649294028231, 8825.646974121028, 8827.558622068904, 9053.185213330798, 9055.320850936207, 9110.134537218953, 9128.087191280885, 9128.863067053999, 9132.771680707969, 8982.910170898273, 9009.729708108767, 9019.23336516397, 9064.410813297147, 9071.0, 8854.911450885538, 8947.50788706621, 8972.147645973622, 8993.955030224806, 8998.280137589043, 42849.0, 43172.3524147138, 43193.0, 43230.0, 43262.13475730499, 3611.133328001261, 3700.278445703062, 3791.620837916214, 3882.4758657581147, 4336.522982471925, 32428.351432971445, 32761.017169484952, 32774.50838237428, 33120.33759324824, 34554.0, 4137.627613514768, 4225.87322380326, 4235.97882010588, 4238.131183107455, 4331.371951067109, 354171.0, 372220.0, 374743.0, 376630.0, 377233.0, 55045.724771375884, 68421.3157868415, 69672.30327696759, 69712.0, 69823.65088174527, 54348.0, 54351.72824135933, 54355.45644543583, 54366.45633543614, 55655.443445565834, 18023.909880450778, 18078.0, 18144.09279536018, 18171.454856354067, 18172.45482635523, 13963.720725585634, 14229.64425889361, 14271.286435678383, 14271.857281427261, 14275.072120312147, 21446.46383840385, 21921.780782192294, 21941.561168776534, 21980.670289945665, 21988.780112198994, 8079.272865442138, 8304.584770761438, 8356.53760591894, 8362.205590468895, 8430.40987130895, 1041.739565108723, 1043.6503771236721, 1128.514738662383, 1131.6265632341308, 1207.9490842966675, 29495.705042949296, 29571.112866614036, 30329.545056824165, 30678.233044174074, 32148.19629509281, 1072.5066469423996, 1105.4969988655143, 1105.922585419029, 1119.3955264157428, 1194.2714943884223, 14362.569122926328, 14877.776833347509, 15236.162011089496, 15337.003094798802, 17131.400400985905, 454778.0, 459394.0, 460044.0, 460760.0, 461748.0, 58590.70704646449, 59215.70392148012, 59631.0, 59647.0, 59678.0, 1458.9708205835823, 1465.0916431812132, 1472.8600782925605, 1478.150063713369, 1480.5484327280283, 30982.84508577443, 31016.844915775277, 31145.8442707785, 31279.530807037456, 31978.84010579932, 46943.76528117474, 47934.76032619954, 48043.279350810466, 52376.73811630918, 53712.0, 224314.0, 224935.0, 225355.0, 226181.0, 226618.0, 32905.67094329122, 33288.0, 33315.0, 33337.66662333443, 33376.66623333735, 46596.0, 47921.5207847931, 47968.760156198994, 48041.27938081002, 48442.0, 37929.60868807068, 38932.6106738929, 39449.80275098606, 39605.40591891181, 40029.0, 38273.2345353097, 39748.20503589854, 40021.59978400179, 41216.79391603023, 42524.78737606292, 41155.38266925939, 41337.0, 41668.79165604274, 41872.0, 42029.579704202566, 31082.378352433276, 32250.516242256854, 32721.0, 36555.26889462249, 37617.81191094027, 25394.365140871625, 27245.0, 27339.179824605293, 27578.0, 27681.498829040294], "unit": "score", "name": "ext.html", "value": 19950.81814139102}, {"lowerIsBetter": false, "replicates": [386.57090629401375, 391.9314120028996, 398.6969902873816, 401.51216272229243, 405.12695141969067, 13368.732625347511, 17261.0, 17778.82221177788, 17801.37695180669, 18461.169247383867, 11372.203945723802, 11662.125340599447, 13550.0, 17899.105044747743, 17911.55221119473, 5231.999999999991, 5420.5934554908345, 5432.375276843154, 5436.429174936634, 5438.7280635968245, 5282.418933917266, 5366.087765079927, 5369.167778994262, 5370.865728356803, 5373.0, 3914.725969182158, 4080.204360149772, 5546.91679624806, 5725.942740572604, 6002.969985150068, 5625.324961004665, 5703.74333155009, 5714.342850572196, 5740.282464691913, 5750.281214848144, 5683.687397193153, 5684.8010319638615, 5693.259876216065, 5694.6867922264255, 5697.800576979827, 14085.85914140866, 18864.33974810875, 20907.58184836295, 21515.67726484104, 21575.56848863014, 2181.472968921745, 2240.6526988316673, 2249.426396268941, 2289.7907260981233, 2384.6899903012672, 10304.0, 10876.347419154876, 12430.316332601704, 13555.932220338835, 13980.161190328612, 1955.9511012224666, 1980.8514361422806, 2021.848361372903, 2036.2262340310735, 2059.4336557446672, 55989.99999999959, 61735.07397389043, 61936.69031654858, 63376.68311658458, 64125.67937160331, 10656.467176641137, 10892.61875834342, 11039.503222355013, 11066.502007409525, 11095.50070246841, 14715.55853324402, 14827.0, 14883.553493395215, 14915.70168596622, 14924.328405221791, 8457.534835584102, 8507.702230421906, 8526.616302266413, 8533.317334613215, 8600.78498037554, 8344.749657510285, 8356.832863342699, 8366.414350995494, 8391.95804020976, 8483.618237179342, 4776.426828780569, 4833.178359678863, 4856.927146092811, 4857.975710121497, 4922.409310882717, 1934.6034063017048, 1959.6864501679947, 1962.4210857796984, 1985.057097878496, 1991.820736133755, 688.3247623345547, 979.1432496565506, 992.1864071461332, 1014.8579198912158, 1062.984055239172, 15487.457938972082, 15523.767143492856, 16022.278997445143, 16320.673586528203, 17085.402010929556, 903.385697725553, 933.780561568031, 971.2861047130353, 987.7382493639192, 1064.669952314785, 9302.25581953442, 9548.37935534188, 10049.598016079275, 10053.195744340435, 10149.695509134737, 408576.0, 410131.0, 417114.0, 567311.0, 578777.0, 49264.7536762321, 49554.75222623864, 57447.0, 62739.372606274264, 67298.66350668215, 978.3885071830106, 1192.6064398748392, 1199.3763243113533, 1216.3067051780577, 1236.2397125767768, 15520.456784012506, 15714.135722534913, 15821.683566328838, 15864.0, 15933.123678197348, 22414.0, 24626.87686561556, 29208.561871571517, 34098.0, 34403.31193376169, 43914.56085439232, 44716.77641611771, 45919.77040114778, 46201.76899115483, 49134.26298605452, 7140.571565706075, 7302.853942921006, 7395.667194976131, 7661.0, 7691.807704807425, 10724.302920310154, 11528.308301501937, 11564.363959981945, 11620.186586939171, 11774.764504710029, 9009.189172974464, 9093.181613654802, 9904.306698531034, 9945.353552019096, 10176.236782241509, 9179.586918588546, 9960.900390995997, 10104.141148002502, 10530.842037369599, 10668.359898406121, 8058.435909486279, 9778.608855645694, 10686.358818470917, 11054.944725276322, 11167.553297867995, 7742.4193185510185, 7809.453338266494, 7812.648430820513, 7872.330851877655, 7880.133185349721, 9508.09673081084, 10185.796284074426, 10283.794324113625, 10373.481325933522, 10450.790984180427], "unit": "score", "name": "jquery.html", "value": 8438.002674349096}, {"lowerIsBetter": false, "replicates": [1432.6131944375013, 1547.0794877048156, 1591.5861875912267, 1810.9637807243855, 1921.6637088509508, 7292.0, 8296.626651800669, 8476.830463390728, 8484.66061357545, 8492.235698787108, 8316.41785075045, 8491.363147763912, 8522.062573116968, 8524.06235314115, 8528.74413767588, 2377.132346693453, 2397.2927986244013, 2399.3881560202126, 2400.7479214682467, 2404.95190096198, 2403.158894386959, 2414.058517178302, 2442.25511219079, 2448.045262347686, 2463.15021317646, 2473.8392004519646, 2482.640017197505, 2494.0273293415585, 2507.849529028264, 2510.786583140426, 2440.1581454398206, 2462.249014050705, 2468.6543883856275, 2470.197185914585, 2481.553320402327, 2413.481101563172, 2415.4685969086772, 2427.890744916483, 2427.9514409711883, 2431.3556907419547, 8617.698380556712, 8671.13288671134, 8682.175193356685, 8686.174813392718, 8693.0, 5210.452902445227, 5316.867078323035, 5369.328833895763, 5401.7299135043095, 5402.324709411324, 3408.880689175867, 3417.333619944112, 3459.290845376717, 3489.59869614995, 3536.0275924120815, 1111.2554588425774, 1137.8463907372482, 1143.2054721968236, 1145.7651181507854, 1174.6006357838376, 12453.1905426147, 12462.376881155906, 12465.688357791038, 12478.126531142823, 12487.06347023977, 4884.584810291094, 4902.607791376681, 4925.236588328815, 4931.334269873521, 4968.6025117990475, 10399.740006499898, 10434.739131521621, 10440.42577658236, 10444.21668374875, 10447.738806529898, 5358.356997160366, 5366.570674346043, 5418.4039755626845, 5430.294061772023, 5430.728463576806, 4309.159713855768, 4395.362672412482, 4740.336352910595, 4837.612990960714, 4838.685485443435, 4110.116324990082, 4121.155163191538, 4132.607402296777, 4166.66666666666, 4167.291560434734, 1342.912710673803, 1361.659585103724, 1362.4263975108765, 1365.2968721108637, 1370.9314534273246, 1435.3253970633784, 1441.099312929419, 1451.8330392005055, 1470.8382077971414, 1471.146734893759, 8247.134050924567, 8275.875861862078, 8294.792630184294, 8297.917020829835, 8336.0, 533.1469648562347, 544.1348256272466, 548.2543740512899, 552.5938435250088, 555.1367623345656, 5910.438508341701, 5981.910271345933, 5995.250593675791, 5999.100134979788, 6005.729742161613, 10268.127209187154, 10717.678469645924, 10797.082248009006, 10957.50691218897, 10981.670549883516, 10445.947770261251, 10777.568897244022, 10795.83806242907, 10801.189910756724, 10824.5128969195, 8339.708110216234, 8371.748847534462, 8405.327573794082, 8421.915780842113, 8434.704785332606, 8012.158723334199, 8145.959270203611, 8149.388795840217, 8169.468984515987, 8209.138040505899, 9489.525523723923, 9492.85760713576, 9551.044895510393, 9695.175910047725, 9751.171150452292, 9676.419414835133, 9751.0, 9834.065763752433, 9953.900460995297, 10023.69928902134, 6567.540272181092, 6770.763023294161, 7394.963025184839, 7815.804604884696, 7824.061112666516, 7804.921950780419, 7853.0, 7858.096318923397, 7869.331106855752, 7897.05235371759, 7297.635118244173, 7513.774586762406, 7554.169041405551, 7648.273414025659, 7722.382209423345, 7285.854282914418, 7409.0, 7424.703011879465, 7509.88735168962, 7530.0, 7825.843483130419, 7869.0950540688555, 7885.093214280431, 7888.132305446282, 7896.052473703192, 6994.125734283215, 7091.893621595577, 7165.820854478679, 7172.856542869009, 7200.49596528238, 7281.5631062136445, 7323.194448610755, 7329.816754581178, 7353.816154595964, 7440.665170067468], "unit": "score", "name": "mootools.html", "value": 4887.900369889619}, {"lowerIsBetter": false, "replicates": [370.70528929501046, 375.8552957111512, 375.8722034508268, 379.3266951161686, 387.7673395962421, 5954.702264886754, 5975.25309336333, 6003.879922401549, 6019.157317975476, 6037.275526936763, 5742.196092547037, 5797.420257974211, 5863.2670916135485, 5951.077582974646, 5987.850303742409, 4697.9060418791605, 4713.5993440557595, 4722.0, 4732.9526704733025, 4736.952630473703, 4511.4135162429, 4739.530745468898, 4742.09900118978, 4746.857594272177, 4752.643551733634, 4610.178979303173, 4619.976900115512, 4692.953070469286, 4701.576858082772, 4707.082118986799, 4654.488006319302, 4673.252279635276, 4673.415823022122, 4679.040796636698, 4701.7414042227665, 4171.812268447927, 4174.853880114181, 4181.60274773896, 4185.204811085884, 4186.204621121977, 5674.347450043257, 5731.455511726379, 5765.1352297155345, 5788.710564471759, 5800.0, 5449.01917654822, 5452.972735136339, 5459.262999495097, 5461.754221060022, 5466.070767969415, 6471.741130354827, 6480.967595161994, 6480.967595161994, 6482.286948435668, 6485.643289619069, 4517.751523666197, 4571.22289210835, 4575.771211439414, 4578.2903649934315, 4579.67942244043, 6496.707648155844, 6647.900281495781, 6670.099536562599, 6690.933090669128, 6698.966505167492, 4668.766561671903, 4669.299605059268, 4669.7431641260055, 4670.1126785910565, 4670.556297151765, 4732.574068333866, 4734.455537613149, 4734.810607575727, 4736.550027747358, 4739.146953548326, 5403.054465468527, 5411.161270003156, 5415.646088477881, 5426.755795989111, 5430.972845135828, 6249.0, 6461.256955450183, 6485.254195767453, 6498.8228943303575, 6506.739730410731, 1653.619667476463, 1672.1722747240194, 1672.690552247838, 1673.2888522378184, 1674.8157702652697, 1109.5617231193633, 1122.3882983773863, 1122.4780477078198, 1136.267107715519, 1144.0332918683698, 6271.310155882849, 6276.968615156895, 6280.403361680725, 6281.466075383552, 6284.968575157095, 6510.674466276667, 6620.668966551653, 6651.66741662915, 6674.933250667528, 6684.131062961881, 6148.78479253224, 6229.875402492015, 6254.874902501924, 6265.686715664198, 6312.368763123743, 3598.9280214395567, 3627.093226693327, 3633.4913112164318, 3638.472421498868, 3639.1629925117372, 6794.45644348451, 6945.722171113099, 6957.9215221640725, 6959.373656370951, 6960.338767817049, 6883.862322753517, 6900.413464855544, 6907.102076730093, 6908.0, 6909.998050282681, 6945.610877824354, 6951.965240173767, 6957.826054348682, 6962.303769623099, 6973.198082220508, 6630.7679231226675, 6692.431143352869, 6730.226024007302, 6743.35938085881, 6754.155730533684, 6578.671066446755, 6581.934180658132, 6593.274739778716, 6597.109390232449, 6602.306757790363, 6946.548474349152, 6955.582665040114, 6962.025316455599, 6962.363844496641, 6974.79075627732, 4645.953540464688, 4723.0081682846985, 4724.267738500538, 4730.030343779448, 4730.574248317668, 6722.731090756315, 6725.764598239038, 6740.831479213059, 6768.424683901727, 6815.693293801692, 6556.213254409501, 6568.376004279586, 6571.277159512354, 6573.835654108686, 6577.046328282468, 6439.484841212786, 6544.411003009752, 6552.737890484518, 6556.114924485133, 6558.475321974326, 6441.3880681335195, 6453.580517266362, 6459.515536334888, 6460.709268082854, 6462.4506916910705, 6500.804975850732, 6501.2198536175965, 6507.219133703986, 6508.642024688687, 6509.088727578048, 6310.11658367838, 6406.519511036598, 6416.230052393743, 6419.26178489461, 6429.067785171031], "unit": "score", "name": "prototype.html", "value": 4926.549861864073}, {"lowerIsBetter": false, "replicates": [848.7241646464897, 913.1416468519591, 918.2883265469261, 922.97692557686, 946.5654888941584, 13975.510857120003, 14145.080569762971, 14167.929160354197, 14197.645058873533, 14281.857181428182, 12716.554920577782, 12782.872171278308, 12799.680007999781, 12823.230606163614, 12862.807057894115, 720.020771750419, 728.2280782370677, 856.9700060497884, 868.4702331577748, 875.5097145598453, 868.8045189832301, 872.075599864146, 874.5190145419994, 876.3033388456192, 876.6405773632812, 920.8618707193907, 923.5382308845577, 925.1303774451993, 926.2913870888775, 927.5964955244457, 762.439606888939, 774.0904437286194, 907.1427501011547, 919.6689191890914, 925.7222833150028, 678.1726293921457, 678.6437120511722, 679.3953381490477, 680.0105845994067, 681.6148875885109, 13889.513867014706, 14019.158850469004, 14041.087329323562, 14099.718005639932, 14132.92933535336, 13051.282179480124, 13553.59339219825, 13631.0, 13695.9999999999, 13833.930830345884, 11272.605458808903, 11305.378204198765, 11370.431478426046, 11555.653330400102, 11607.941960290229, 3913.3151698452943, 3942.1918506706056, 3943.9802800985813, 3972.82122304497, 3989.261986532472, 47979.52020479785, 48569.75715121437, 50037.74981125107, 50521.49478505205, 50909.0, 10759.65504311961, 10767.569297228023, 10799.946000270105, 10818.729531761768, 11075.612353567587, 18012.549686257687, 18238.08809559517, 18241.817581824278, 18258.908705456386, 18260.543486412946, 8250.339972802161, 8260.29787468072, 8371.748847534584, 8476.703315384055, 8673.52295623734, 4560.4071470708595, 4658.534146585314, 4659.603933665609, 4702.130105930414, 4715.198416269242, 3261.934761304808, 3266.2161081340782, 3271.9018429447156, 3287.589051368579, 3295.489199174132, 586.3169407640052, 596.5436441122545, 603.3724926076831, 607.2743072028971, 612.0268772651506, 670.3196255800367, 703.395080231001, 714.6141083814682, 728.730369763191, 745.7129005332878, 9491.857622135674, 9586.328956973084, 9649.0, 9690.418574885529, 9766.46284454362, 558.9804356847491, 699.5068476723999, 724.7753196508994, 731.974380896666, 776.6466257852663, 4298.699091063658, 4357.607815296575, 4383.539728328479, 4428.036946681695, 4440.777961101997, 57721.0, 58220.708896455246, 58221.70889145527, 58626.0, 60301.39698603046, 52639.73680131575, 53164.0, 53613.19580206222, 53803.0, 53911.19133213005, 46765.5323446768, 47140.5285947143, 47161.76419117882, 47453.050938981716, 47736.04527909422, 8896.377253592187, 9504.667336643184, 9596.568154433207, 9608.039196080335, 9642.987486314116, 34203.4869476963, 34911.301773964886, 35369.64630353663, 35819.0, 35878.46182307215, 43279.78360108179, 43331.78334108309, 45067.77466112648, 45095.32357014582, 45247.54752452565, 11364.54541818318, 11631.0, 11707.531698732297, 11712.88287117118, 11890.464929078385, 12575.874241257836, 12591.748165036464, 13192.274424906722, 13199.934000329937, 13285.53500627512, 11717.824232636687, 11792.823107653221, 12024.458899349374, 12218.144729868824, 12383.257004579755, 12582.811257831323, 12614.55849045279, 12729.490820367451, 12903.548375806802, 13421.194728316332, 11243.437828108725, 11319.660410187707, 11545.191836571359, 11913.16607837443, 12339.93830030844, 9997.404308847279, 10218.795624087625, 10249.692509224735, 10533.262671612914, 10697.304675196086, 9661.758456038655, 9795.608175673178, 9838.704838854846, 9944.204463643036, 10032.347897386646], "unit": "score", "name": "yui.html", "value": 6692.34439294863}], "name": "dromaeo_css", "value": 7240.481540910876}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 109.0, 111.0, 108.0, 98.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 150.0, 164.0, 125.0, 152.0, 144.0, 130.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 145.0, 73.0, 73.0, 76.0, 77.0, 149.0, 78.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 95.0, 96.0, 95.0, 144.0, 94.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 56.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.9}, {"lowerIsBetter": true, "replicates": [125.0, 111.0, 122.0, 110.0, 116.0, 110.0, 112.0, 114.0, 118.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 139.0, 133.0, 135.0, 138.0, 136.0, 134.0, 132.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 63.0, 62.0, 63.0, 65.0, 64.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1472.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [169.89466530750934], "unit": "score", "name": "DeltaBlue", "value": 389.1705480000001}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [944.2870632672333], "unit": "score", "name": "RayTrace", "value": 783.6483509999999}, {"lowerIsBetter": false, "replicates": [562.7462014631401], "unit": "score", "name": "Earley", "value": 1184.3047510000004}, {"lowerIsBetter": false, "replicates": [10691.489361702128], "unit": "score", "name": "Boyer", "value": 62.335842786069605}, {"lowerIsBetter": false, "replicates": [40380.0], "unit": "score", "name": "RegExp", "value": 22.560302129767216}, {"lowerIsBetter": false, "replicates": [498.00796812749], "unit": "score", "name": "Splay", "value": 163.63392800000005}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22119.087863571538}]} 15:39:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22119.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7240.48"}}} 15:39:27 INFO - Return code: 0 15:39:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:39:28 INFO - # TBPL SUCCESS # 15:39:28 INFO - Running post-action listener: _resource_record_post_action 15:39:28 INFO - Running post-run listener: _resource_record_post_run 15:39:29 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 460689408; Read time: 184; Write time: 362556 15:39:29 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234676224; Read time: 0; Write time: 247008 15:39:29 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 226013184; Read time: 184; Write time: 115548 15:39:29 INFO - Running post-run listener: _upload_blobber_files 15:39:29 INFO - Blob upload gear active. 15:39:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:39:29 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:39:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Beta -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:39:29 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:30 INFO - (blobuploader) - INFO - Done attempting. 15:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:31 INFO - (blobuploader) - INFO - Done attempting. 15:39:31 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:31 INFO - Return code: 0 15:39:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:39:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37244889d554b6750b5460b6100b2831725e79653bc6edeea3c48c4eeba3d75eaa687b174f1fa72145f89a20ace0dcc3005bfadf7ef2eb65fb48aa5839f136cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/561035100039bb4f2f31076caf8957ef24ab1402fb5c01474b0a07cae62dcf31ecbe86d93e1e8c8891e717b611285f7a6e0aa4b0f6cdd120078af21215e7a5f6"} 15:39:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:39:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:39:31 INFO - Contents: 15:39:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37244889d554b6750b5460b6100b2831725e79653bc6edeea3c48c4eeba3d75eaa687b174f1fa72145f89a20ace0dcc3005bfadf7ef2eb65fb48aa5839f136cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/561035100039bb4f2f31076caf8957ef24ab1402fb5c01474b0a07cae62dcf31ecbe86d93e1e8c8891e717b611285f7a6e0aa4b0f6cdd120078af21215e7a5f6"} 15:39:31 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:31 INFO - Copying logs to upload dir... 15:39:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:39:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.136895 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-08 15:39:30.735728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 15:39:30.739053) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37244889d554b6750b5460b6100b2831725e79653bc6edeea3c48c4eeba3d75eaa687b174f1fa72145f89a20ace0dcc3005bfadf7ef2eb65fb48aa5839f136cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/561035100039bb4f2f31076caf8957ef24ab1402fb5c01474b0a07cae62dcf31ecbe86d93e1e8c8891e717b611285f7a6e0aa4b0f6cdd120078af21215e7a5f6"} build_url:https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/S1mB5ikITQq6MiCiCxIc5g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37244889d554b6750b5460b6100b2831725e79653bc6edeea3c48c4eeba3d75eaa687b174f1fa72145f89a20ace0dcc3005bfadf7ef2eb65fb48aa5839f136cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/561035100039bb4f2f31076caf8957ef24ab1402fb5c01474b0a07cae62dcf31ecbe86d93e1e8c8891e717b611285f7a6e0aa4b0f6cdd120078af21215e7a5f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 15:39:30.766472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:39:30.767106) ========= 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-1460152509.459411-354946931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 15:39:30.850000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 15:39:30.850708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 15:39:30.851319) ========= ========= Total master_lag: 0.33 =========