builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1458174365.63 results: success (0) buildid: 20160316144743 builduid: 056b850040f04521ab11d88010a5cfd0 revision: d574b8fcd20f2bea547228ce4dc85c7d13313c5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.625972) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.626469) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.626800) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006477 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.654889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.655654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.683109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.683809) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004863 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.735918) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.736591) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.737292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.737844) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 17:26:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2016-03-16 17:26:06 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.920793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:05.921580) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.106722 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.041674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.042034) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d574b8fcd20f2bea547228ce4dc85c7d13313c5f --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 d574b8fcd20f2bea547228ce4dc85c7d13313c5f --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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 17:26:06,588 truncating revision to first 12 chars 2016-03-16 17:26:06,588 Setting DEBUG logging. 2016-03-16 17:26:06,588 attempt 1/10 2016-03-16 17:26:06,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d574b8fcd20f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:26:06,866 unpacking tar archive at: mozilla-beta-d574b8fcd20f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.663705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.664095) ========= echo d574b8fcd20f2bea547228ce4dc85c7d13313c5f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd574b8fcd20f2bea547228ce4dc85c7d13313c5f'] 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d574b8fcd20f2bea547228ce4dc85c7d13313c5f program finished with exit code 0 elapsedTime=0.003560 script_repo_revision: 'd574b8fcd20f2bea547228ce4dc85c7d13313c5f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.712694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.713035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:26:06.724420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-03-16 17:26:06.724736) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:07 INFO - MultiFileLogger online at 20160316 17:26:07 in /builds/slave/test-pgo 17:26:07 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 17:26:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:26:07 INFO - {'append_to_log': False, 17:26:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:26:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:26:07 INFO - 'branch': 'Mozilla-Beta', 17:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:07 INFO - 'config_files': ('talos/linux_config.py',), 17:26:07 INFO - 'default_actions': ('clobber', 17:26:07 INFO - 'read-buildbot-config', 17:26:07 INFO - 'download-and-extract', 17:26:07 INFO - 'populate-webroot', 17:26:07 INFO - 'create-virtualenv', 17:26:07 INFO - 'install', 17:26:07 INFO - 'run-tests'), 17:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:07 INFO - 'download_minidump_stackwalk': True, 17:26:07 INFO - 'download_symbols': 'ondemand', 17:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:07 INFO - 'installer_path': 'installer.exe', 17:26:07 INFO - 'log_level': 'info', 17:26:07 INFO - 'log_name': 'talos', 17:26:07 INFO - 'log_to_console': True, 17:26:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:07 INFO - 'opt_config_files': (), 17:26:07 INFO - 'pip_index': False, 17:26:07 INFO - 'sps_profile': False, 17:26:07 INFO - 'sps_profile_interval': 0, 17:26:07 INFO - 'suite': 'dromaeojs', 17:26:07 INFO - 'system_bits': '32', 17:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:07 INFO - 'title': 'talos-linux64-ix-064', 17:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:07 INFO - 'use_talos_json': True, 17:26:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:07 INFO - 'work_dir': 'build'} 17:26:07 INFO - ##### 17:26:07 INFO - ##### Running clobber step. 17:26:07 INFO - ##### 17:26:07 INFO - Running pre-action listener: _resource_record_pre_action 17:26:07 INFO - Running main action method: clobber 17:26:07 INFO - rmtree: /builds/slave/test-pgo/build 17:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:26:08 INFO - Running post-action listener: _resource_record_post_action 17:26:08 INFO - ##### 17:26:08 INFO - ##### Running read-buildbot-config step. 17:26:08 INFO - ##### 17:26:08 INFO - Running pre-action listener: _resource_record_pre_action 17:26:08 INFO - Running main action method: read_buildbot_config 17:26:08 INFO - Using buildbot properties: 17:26:08 INFO - { 17:26:08 INFO - "project": "", 17:26:08 INFO - "product": "firefox", 17:26:08 INFO - "script_repo_revision": "production", 17:26:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:26:08 INFO - "repository": "", 17:26:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:26:08 INFO - "buildid": "20160316144743", 17:26:08 INFO - "pgo_build": "True", 17:26:08 INFO - "basedir": "/builds/slave/test-pgo", 17:26:08 INFO - "buildnumber": 128, 17:26:08 INFO - "slavename": "talos-linux64-ix-064", 17:26:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:26:08 INFO - "platform": "ubuntu64_hw", 17:26:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:26:08 INFO - "branch": "mozilla-beta", 17:26:08 INFO - "repo_path": "releases/mozilla-beta", 17:26:08 INFO - "revision": "d574b8fcd20f2bea547228ce4dc85c7d13313c5f", 17:26:08 INFO - "stage_platform": "linux64-pgo", 17:26:08 INFO - "builduid": "056b850040f04521ab11d88010a5cfd0", 17:26:08 INFO - "slavebuilddir": "test" 17:26:08 INFO - } 17:26:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 17:26:08 INFO - Running post-action listener: _resource_record_post_action 17:26:08 INFO - ##### 17:26:08 INFO - ##### Running download-and-extract step. 17:26:08 INFO - ##### 17:26:08 INFO - Running pre-action listener: _resource_record_pre_action 17:26:08 INFO - Running main action method: download_and_extract 17:26:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:26:08 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')]} 17:26:08 INFO - https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/test_packages.json 17:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/test_packages.json 17:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:26:16 INFO - Downloaded 1412 bytes. 17:26:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:26:16 INFO - Using the following test package requirements: 17:26:16 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:26:16 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:26:16 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 17:26:16 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'jsshell-linux-x86_64.zip'], 17:26:16 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:26:16 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:26:16 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 17:26:16 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 17:26:16 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:26:16 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 17:26:16 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 17:26:16 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:26:16 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:16 INFO - https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:20 INFO - Downloaded 23105565 bytes. 17:26: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'] 17:26: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 17:26:22 INFO - Return code: 0 17:26:22 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 17:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:22 INFO - https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 17:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:28 INFO - Downloaded 23105565 bytes. 17:26:28 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'] 17:26:28 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 17:26:29 INFO - Return code: 0 17:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:29 INFO - https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 17:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 17:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:31 INFO - Downloaded 10801536 bytes. 17:26:31 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'] 17:26:31 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 17:26:31 INFO - Return code: 0 17:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:31 INFO - https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/We3Fln4STWOwyi3Mnn4YMg/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 17:26:32 INFO - Downloaded 52859714 bytes. 17:26:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:26:32 INFO - mkdir: /builds/slave/test-pgo/properties 17:26:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:26:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:26:32 INFO - Contents: 17:26:32 INFO - build_url:https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - Running post-action listener: set_extra_try_arguments 17:26:33 INFO - ##### 17:26:33 INFO - ##### Running populate-webroot step. 17:26:33 INFO - ##### 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: populate_webroot 17:26:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:33 INFO - '--tppagecycles', 17:26:33 INFO - '7'], 17:26:33 INFO - 'tests': ['tsvgm']}}, 17:26:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:26:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:26:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:26:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'tests': ['damp', 'tps']}, 17:26:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['damp', 'tps']}, 17:26:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:26:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:33 INFO - 'other': {'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'other_l64': {'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'other_nol64': {'tests': ['a11yr', 17:26:33 INFO - 'ts_paint', 17:26:33 INFO - 'tpaint', 17:26:33 INFO - 'sessionrestore', 17:26:33 INFO - 'sessionrestore_no_auto_restore']}, 17:26:33 INFO - 'svgr': {'tests': ['tsvgx', 17:26:33 INFO - 'tsvgr_opacity', 17:26:33 INFO - 'tart', 17:26:33 INFO - 'tscrollx', 17:26:33 INFO - 'cart']}, 17:26:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['tsvgx', 17:26:33 INFO - 'tsvgr_opacity', 17:26:33 INFO - 'tart', 17:26:33 INFO - 'tscrollx', 17:26:33 INFO - 'cart']}, 17:26:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'tests': ['tp5o']}, 17:26:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'talos_options': ['--e10s'], 17:26:33 INFO - 'tests': ['tp5o']}, 17:26:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'talos_options': ['--xperf_path', 17:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:33 INFO - 'tests': ['tp5n']}, 17:26:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:33 INFO - 'talos_options': ['--e10s', 17:26:33 INFO - '--xperf_path', 17:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:33 INFO - 'tests': ['tp5n']}}, 17:26:33 INFO - 'talos.zip': {'path': '', 17:26:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - ##### 17:26:33 INFO - ##### Running create-virtualenv step. 17:26:33 INFO - ##### 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: create_virtualenv 17:26:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:26:33 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 17:26:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:26:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:33 INFO - Using real prefix '/usr' 17:26:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:26:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:35 INFO - Installing pip.................done. 17:26:35 INFO - Return code: 0 17:26:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:35 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:35 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 17:26:35 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 17:26:35 INFO - Using env: {'DISPLAY': ':0', 17:26:35 INFO - 'HOME': '/home/cltbld', 17:26:35 INFO - 'LANG': 'en_US.UTF-8', 17:26:35 INFO - 'LANGUAGE': 'en_US:en', 17:26:35 INFO - 'LOGNAME': 'cltbld', 17:26:35 INFO - 'MAIL': '/var/mail/cltbld', 17:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:35 INFO - 'MOZ_NO_REMOTE': '1', 17:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:35 INFO - 'NO_EM_RESTART': '1', 17:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:35 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:35 INFO - 'SHELL': '/bin/bash', 17:26:35 INFO - 'SHLVL': '1', 17:26:35 INFO - 'TERM': 'linux', 17:26:35 INFO - 'TMOUT': '86400', 17:26:35 INFO - 'USER': 'cltbld', 17:26:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:35 INFO - '_': '/tools/buildbot/bin/python'} 17:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:36 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 17:26:36 INFO - Cleaning up... 17:26:36 INFO - Return code: 0 17:26:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:36 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 17:26:36 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 17:26:36 INFO - Using env: {'DISPLAY': ':0', 17:26:36 INFO - 'HOME': '/home/cltbld', 17:26:36 INFO - 'LANG': 'en_US.UTF-8', 17:26:36 INFO - 'LANGUAGE': 'en_US:en', 17:26:36 INFO - 'LOGNAME': 'cltbld', 17:26:36 INFO - 'MAIL': '/var/mail/cltbld', 17:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:36 INFO - 'MOZ_NO_REMOTE': '1', 17:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:36 INFO - 'NO_EM_RESTART': '1', 17:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:36 INFO - 'SHELL': '/bin/bash', 17:26:36 INFO - 'SHLVL': '1', 17:26:36 INFO - 'TERM': 'linux', 17:26:36 INFO - 'TMOUT': '86400', 17:26:36 INFO - 'USER': 'cltbld', 17:26:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:36 INFO - '_': '/tools/buildbot/bin/python'} 17:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:36 INFO - Downloading/unpacking psutil>=0.7.1 17:26:36 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 17:26:36 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 17:26:36 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 17:26:36 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 17:26:36 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 17:26:36 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 17:26:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:38 INFO - Installing collected packages: psutil 17:26:38 INFO - Running setup.py install for psutil 17:26:38 INFO - building 'psutil._psutil_linux' extension 17:26:38 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 17:26:38 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 17:26:38 INFO - building 'psutil._psutil_posix' extension 17:26:38 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 17:26:38 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 17:26:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:38 INFO - Successfully installed psutil 17:26:38 INFO - Cleaning up... 17:26:38 INFO - Return code: 0 17:26:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:38 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:38 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 17:26:38 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 17:26:38 INFO - Using env: {'DISPLAY': ':0', 17:26:38 INFO - 'HOME': '/home/cltbld', 17:26:38 INFO - 'LANG': 'en_US.UTF-8', 17:26:38 INFO - 'LANGUAGE': 'en_US:en', 17:26:38 INFO - 'LOGNAME': 'cltbld', 17:26:38 INFO - 'MAIL': '/var/mail/cltbld', 17:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:38 INFO - 'MOZ_NO_REMOTE': '1', 17:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:38 INFO - 'NO_EM_RESTART': '1', 17:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:38 INFO - 'SHELL': '/bin/bash', 17:26:38 INFO - 'SHLVL': '1', 17:26:38 INFO - 'TERM': 'linux', 17:26:38 INFO - 'TMOUT': '86400', 17:26:38 INFO - 'USER': 'cltbld', 17:26:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:38 INFO - '_': '/tools/buildbot/bin/python'} 17:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:26:39 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 17:26:39 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 17:26:39 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 17:26:39 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 17:26:39 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 17:26:39 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 17:26:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:26:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:26:41 INFO - Installing collected packages: mozsystemmonitor 17:26:41 INFO - Running setup.py install for mozsystemmonitor 17:26:41 INFO - Successfully installed mozsystemmonitor 17:26:41 INFO - Cleaning up... 17:26:41 INFO - Return code: 0 17:26:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', '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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:26: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 blobuploader==1.2.4 17:26:41 INFO - Using env: {'DISPLAY': ':0', 17:26:41 INFO - 'HOME': '/home/cltbld', 17:26:41 INFO - 'LANG': 'en_US.UTF-8', 17:26:41 INFO - 'LANGUAGE': 'en_US:en', 17:26:41 INFO - 'LOGNAME': 'cltbld', 17:26:41 INFO - 'MAIL': '/var/mail/cltbld', 17:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:41 INFO - 'MOZ_NO_REMOTE': '1', 17:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:41 INFO - 'NO_EM_RESTART': '1', 17:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:41 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:41 INFO - 'SHELL': '/bin/bash', 17:26:41 INFO - 'SHLVL': '1', 17:26:41 INFO - 'TERM': 'linux', 17:26:41 INFO - 'TMOUT': '86400', 17:26:41 INFO - 'USER': 'cltbld', 17:26:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:41 INFO - '_': '/tools/buildbot/bin/python'} 17:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:26:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - Downloading docopt-0.6.1.tar.gz 17:26:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:44 INFO - Running setup.py install for blobuploader 17:26:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:26:44 INFO - Running setup.py install for requests 17:26:44 INFO - Running setup.py install for docopt 17:26:44 INFO - Successfully installed blobuploader requests docopt 17:26:44 INFO - Cleaning up... 17:26:44 INFO - Return code: 0 17:26:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:44 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:44 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 17:26:44 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 17:26:44 INFO - Using env: {'DISPLAY': ':0', 17:26:44 INFO - 'HOME': '/home/cltbld', 17:26:44 INFO - 'LANG': 'en_US.UTF-8', 17:26:44 INFO - 'LANGUAGE': 'en_US:en', 17:26:44 INFO - 'LOGNAME': 'cltbld', 17:26:44 INFO - 'MAIL': '/var/mail/cltbld', 17:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:44 INFO - 'MOZ_NO_REMOTE': '1', 17:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:44 INFO - 'NO_EM_RESTART': '1', 17:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:44 INFO - 'SHELL': '/bin/bash', 17:26:44 INFO - 'SHLVL': '1', 17:26:44 INFO - 'TERM': 'linux', 17:26:44 INFO - 'TMOUT': '86400', 17:26:44 INFO - 'USER': 'cltbld', 17:26:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:44 INFO - '_': '/tools/buildbot/bin/python'} 17:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:44 INFO - Running setup.py (path:/tmp/pip-_NV2iP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:44 INFO - Running setup.py (path:/tmp/pip-eYJZVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:44 INFO - Running setup.py (path:/tmp/pip-CUYJ8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:45 INFO - Running setup.py (path:/tmp/pip-4ZWlB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:45 INFO - Running setup.py (path:/tmp/pip-ln2eZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:45 INFO - Running setup.py (path:/tmp/pip-h_eIFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:45 INFO - Running setup.py (path:/tmp/pip-su6Upl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:45 INFO - Running setup.py (path:/tmp/pip-LwxRzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:45 INFO - Running setup.py (path:/tmp/pip-aRUfcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:45 INFO - Running setup.py (path:/tmp/pip-ANuWld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:45 INFO - Running setup.py (path:/tmp/pip-P_p6rt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:45 INFO - Running setup.py (path:/tmp/pip-12iKeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:45 INFO - Running setup.py (path:/tmp/pip-L8ni2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:45 INFO - Running setup.py (path:/tmp/pip-i_uzCp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:45 INFO - Running setup.py (path:/tmp/pip-w3HSig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:45 INFO - Running setup.py (path:/tmp/pip-ImVU0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:45 INFO - Running setup.py (path:/tmp/pip-0jnWGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:46 INFO - Running setup.py install for manifestparser 17:26:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Running setup.py install for mozcrash 17:26:46 INFO - Running setup.py install for mozdebug 17:26:46 INFO - Running setup.py install for mozdevice 17:26:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Running setup.py install for mozfile 17:26:46 INFO - Running setup.py install for mozhttpd 17:26:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Running setup.py install for mozinfo 17:26:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Running setup.py install for mozInstall 17:26:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:26:46 INFO - Running setup.py install for mozleak 17:26:47 INFO - Running setup.py install for mozlog 17:26:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Running setup.py install for moznetwork 17:26:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Running setup.py install for mozprocess 17:26:47 INFO - Running setup.py install for mozprofile 17:26:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Running setup.py install for mozrunner 17:26:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Running setup.py install for mozscreenshot 17:26:47 INFO - Running setup.py install for moztest 17:26:47 INFO - Running setup.py install for mozversion 17:26:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:26:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:47 INFO - Cleaning up... 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:47 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')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 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')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:47 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 17:26:47 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 17:26:47 INFO - Using env: {'DISPLAY': ':0', 17:26:47 INFO - 'HOME': '/home/cltbld', 17:26:47 INFO - 'LANG': 'en_US.UTF-8', 17:26:47 INFO - 'LANGUAGE': 'en_US:en', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MAIL': '/var/mail/cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SHLVL': '1', 17:26:47 INFO - 'TERM': 'linux', 17:26:47 INFO - 'TMOUT': '86400', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - '_': '/tools/buildbot/bin/python'} 17:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:48 INFO - Running setup.py (path:/tmp/pip-A69Uc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:48 INFO - Running setup.py (path:/tmp/pip-O1dNyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:48 INFO - Running setup.py (path:/tmp/pip-8gRCQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:48 INFO - Running setup.py (path:/tmp/pip-7cZ6OV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:48 INFO - Running setup.py (path:/tmp/pip-ADOA29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:48 INFO - Running setup.py (path:/tmp/pip-gnrdaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:48 INFO - Running setup.py (path:/tmp/pip-tIFnqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:48 INFO - Running setup.py (path:/tmp/pip-jlsPI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:48 INFO - Running setup.py (path:/tmp/pip-HlIPTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:48 INFO - Running setup.py (path:/tmp/pip-CdYeZl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:48 INFO - Running setup.py (path:/tmp/pip-TUkBg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:48 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)) 17:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:48 INFO - Running setup.py (path:/tmp/pip-7yy4lj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:49 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)) 17:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:49 INFO - Running setup.py (path:/tmp/pip-3dkxES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:49 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)) 17:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:49 INFO - Running setup.py (path:/tmp/pip-6I9zr6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:49 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)) 17:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:49 INFO - Running setup.py (path:/tmp/pip-WAtmb2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:49 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)) 17:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:49 INFO - Running setup.py (path:/tmp/pip-ZmTIVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:49 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)) 17:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:49 INFO - Running setup.py (path:/tmp/pip-HdRaA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:49 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)) 17:26:49 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)) 17:26:49 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)) 17:26:49 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)) 17:26:49 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)) 17:26:49 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)) 17:26:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:51 INFO - Downloading blessings-1.6.tar.gz 17:26:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:51 INFO - Installing collected packages: blessings 17:26:51 INFO - Running setup.py install for blessings 17:26:51 INFO - Successfully installed blessings 17:26:51 INFO - Cleaning up... 17:26:51 INFO - Return code: 0 17:26:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:26:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:51 INFO - Reading from file tmpfile_stdout 17:26:51 INFO - Current package versions: 17:26:51 INFO - argparse == 1.2.1 17:26:51 INFO - blessings == 1.6 17:26:51 INFO - blobuploader == 1.2.4 17:26:51 INFO - docopt == 0.6.1 17:26:51 INFO - manifestparser == 1.1 17:26:51 INFO - mozInstall == 1.12 17:26:51 INFO - mozcrash == 0.16 17:26:51 INFO - mozdebug == 0.1 17:26:51 INFO - mozdevice == 0.48 17:26:51 INFO - mozfile == 1.2 17:26:51 INFO - mozhttpd == 0.7 17:26:51 INFO - mozinfo == 0.9 17:26:51 INFO - mozleak == 0.1 17:26:51 INFO - mozlog == 3.1 17:26:51 INFO - moznetwork == 0.27 17:26:51 INFO - mozprocess == 0.22 17:26:51 INFO - mozprofile == 0.28 17:26:51 INFO - mozrunner == 6.11 17:26:51 INFO - mozscreenshot == 0.1 17:26:51 INFO - mozsystemmonitor == 0.0 17:26:51 INFO - moztest == 0.7 17:26:51 INFO - mozversion == 1.4 17:26:51 INFO - psutil == 3.1.1 17:26:51 INFO - requests == 1.2.3 17:26:51 INFO - wsgiref == 0.1.2 17:26:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:51 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 17:26:51 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 17:26:51 INFO - Using env: {'DISPLAY': ':0', 17:26:51 INFO - 'HOME': '/home/cltbld', 17:26:51 INFO - 'LANG': 'en_US.UTF-8', 17:26:51 INFO - 'LANGUAGE': 'en_US:en', 17:26:51 INFO - 'LOGNAME': 'cltbld', 17:26:51 INFO - 'MAIL': '/var/mail/cltbld', 17:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:51 INFO - 'MOZ_NO_REMOTE': '1', 17:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:51 INFO - 'NO_EM_RESTART': '1', 17:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:51 INFO - 'SHELL': '/bin/bash', 17:26:51 INFO - 'SHLVL': '1', 17:26:51 INFO - 'TERM': 'linux', 17:26:51 INFO - 'TMOUT': '86400', 17:26:51 INFO - 'USER': 'cltbld', 17:26:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:51 INFO - '_': '/tools/buildbot/bin/python'} 17:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 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)) 17:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:26:51 INFO - Cleaning up... 17:26:51 INFO - Return code: 0 17:26:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:51 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:51 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 17:26:51 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 17:26:51 INFO - Using env: {'DISPLAY': ':0', 17:26:51 INFO - 'HOME': '/home/cltbld', 17:26:51 INFO - 'LANG': 'en_US.UTF-8', 17:26:51 INFO - 'LANGUAGE': 'en_US:en', 17:26:51 INFO - 'LOGNAME': 'cltbld', 17:26:51 INFO - 'MAIL': '/var/mail/cltbld', 17:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:51 INFO - 'MOZ_NO_REMOTE': '1', 17:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:51 INFO - 'NO_EM_RESTART': '1', 17:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:51 INFO - 'SHELL': '/bin/bash', 17:26:51 INFO - 'SHLVL': '1', 17:26:51 INFO - 'TERM': 'linux', 17:26:51 INFO - 'TMOUT': '86400', 17:26:51 INFO - 'USER': 'cltbld', 17:26:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:51 INFO - '_': '/tools/buildbot/bin/python'} 17:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:52 INFO - Downloading/unpacking jsonschema 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:53 INFO - Downloading/unpacking functools32 (from jsonschema) 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:54 INFO - warning: no files found matching '*.txt' 17:26:54 INFO - no previously-included directories found matching 'build' 17:26:54 INFO - no previously-included directories found matching 'dist' 17:26:54 INFO - no previously-included directories found matching '.git*' 17:26:54 INFO - Installing collected packages: jsonschema, functools32 17:26:54 INFO - Running setup.py install for functools32 17:26:54 INFO - warning: no files found matching '*.txt' 17:26:54 INFO - no previously-included directories found matching 'build' 17:26:54 INFO - no previously-included directories found matching 'dist' 17:26:54 INFO - no previously-included directories found matching '.git*' 17:26:54 INFO - Successfully installed jsonschema functools32 17:26:54 INFO - Cleaning up... 17:26:54 INFO - Return code: 0 17:26:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:54 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 0x7fa216762f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fe290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', '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 17:26:54 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 17:26:54 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 17:26:54 INFO - Using env: {'DISPLAY': ':0', 17:26:54 INFO - 'HOME': '/home/cltbld', 17:26:54 INFO - 'LANG': 'en_US.UTF-8', 17:26:54 INFO - 'LANGUAGE': 'en_US:en', 17:26:54 INFO - 'LOGNAME': 'cltbld', 17:26:54 INFO - 'MAIL': '/var/mail/cltbld', 17:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:54 INFO - 'MOZ_NO_REMOTE': '1', 17:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:54 INFO - 'NO_EM_RESTART': '1', 17:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:54 INFO - 'SHELL': '/bin/bash', 17:26:54 INFO - 'SHLVL': '1', 17:26:54 INFO - 'TERM': 'linux', 17:26:54 INFO - 'TMOUT': '86400', 17:26:54 INFO - 'USER': 'cltbld', 17:26:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:54 INFO - '_': '/tools/buildbot/bin/python'} 17:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:54 INFO - Downloading/unpacking flake8 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:26:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:26:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:26:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:57 INFO - no previously-included directories found matching 'docs/_build' 17:26:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:26:57 INFO - Running setup.py install for pep8 17:26:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:57 INFO - no previously-included directories found matching 'docs/_build' 17:26:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:26:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:26:57 INFO - Cleaning up... 17:26:57 INFO - Return code: 0 17:26:57 INFO - Running post-action listener: _resource_record_post_action 17:26:57 INFO - Running post-action listener: _start_resource_monitoring 17:26:57 INFO - Starting resource monitoring. 17:26:57 INFO - ##### 17:26:57 INFO - ##### Running install step. 17:26:57 INFO - ##### 17:26:57 INFO - Running pre-action listener: _resource_record_pre_action 17:26:57 INFO - Running main action method: install 17:26:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:57 INFO - Reading from file tmpfile_stdout 17:26:57 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:26:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:26:57 INFO - Reading from file tmpfile_stdout 17:26:57 INFO - Output received: 17:26:57 INFO - Usage: mozinstall [options] installer 17:26:57 INFO - Options: 17:26:57 INFO - -h, --help show this help message and exit 17:26:57 INFO - -d DEST, --destination=DEST 17:26:57 INFO - Directory to install application into. [default: 17:26:57 INFO - "/builds/slave/test-pgo"] 17:26:57 INFO - --app=APP Application being installed. [default: firefox] 17:26:57 INFO - mkdir: /builds/slave/test-pgo/build/application 17:26:57 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'] 17:26:57 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 17:27:10 INFO - Reading from file tmpfile_stdout 17:27:10 INFO - Output received: 17:27:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:27:10 INFO - Running post-action listener: _resource_record_post_action 17:27:10 INFO - ##### 17:27:10 INFO - ##### Running run-tests step. 17:27:10 INFO - ##### 17:27:10 INFO - Running pre-action listener: _resource_record_pre_action 17:27:10 INFO - Running main action method: run_tests 17:27:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:27:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:27:10 INFO - Python 2.7.3 17:27:10 INFO - Return code: 0 17:27:10 INFO - grabbing minidump binary from tooltool 17:27:10 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')]} 17:27:10 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 0x1490850>, '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 0x13fc330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fc7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:27:10 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 17:27:10 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 17:27:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:10 INFO - Return code: 0 17:27:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:27:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:27:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:27:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:27:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:27:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:27:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:27:11 INFO - Return code: 0 17:27:11 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/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:27:11 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/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 17:27:11 INFO - Using env: {'DISPLAY': ':0', 17:27:11 INFO - 'HOME': '/home/cltbld', 17:27:11 INFO - 'LANG': 'en_US.UTF-8', 17:27:11 INFO - 'LANGUAGE': 'en_US:en', 17:27:11 INFO - 'LOGNAME': 'cltbld', 17:27:11 INFO - 'MAIL': '/var/mail/cltbld', 17:27:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:27:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:11 INFO - 'MOZ_NO_REMOTE': '1', 17:27:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:11 INFO - 'NO_EM_RESTART': '1', 17:27:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:27:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:27:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:27:11 INFO - 'SHELL': '/bin/bash', 17:27:11 INFO - 'SHLVL': '1', 17:27:11 INFO - 'TERM': 'linux', 17:27:11 INFO - 'TMOUT': '86400', 17:27:11 INFO - 'USER': 'cltbld', 17:27:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533', 17:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:11 INFO - '_': '/tools/buildbot/bin/python'} 17:27:11 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/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:27:11 INFO - mozversion application_buildid: 20160316144743 17:27:11 INFO - mozversion application_changeset: d574b8fcd20f2bea547228ce4dc85c7d13313c5f 17:27:11 INFO - mozversion application_display_name: Firefox 17:27:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:11 INFO - mozversion application_name: Firefox 17:27:11 INFO - mozversion application_remotingname: firefox 17:27:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:27:11 INFO - mozversion application_vendor: Mozilla 17:27:11 INFO - mozversion application_version: 46.0 17:27:11 INFO - mozversion platform_buildid: 20160316144743 17:27:11 INFO - mozversion platform_changeset: d574b8fcd20f2bea547228ce4dc85c7d13313c5f 17:27:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:27:11 INFO - mozversion platform_version: 46.0 17:27:11 INFO - using testdate: 1458174431 17:27:11 INFO - actual date: 1458174431 17:27:11 INFO - starting webserver on 'localhost:42386' 17:27:11 INFO - SUITE-START | Running 3 tests 17:27:11 INFO - TEST-START | dromaeo_css 17:27:11 INFO - operating with platform_type : linux_ 17:27:11 INFO - Initialising browser for dromaeo_css test... 17:27:11 INFO - TEST-INFO | started process 32011 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw48RF9/profile http://localhost:42386/getInfo.html) 17:27:15 INFO - PROCESS | 32011 | __metrics Screen width/height:1600/1200 17:27:15 INFO - PROCESS | 32011 | colorDepth:24 17:27:15 INFO - PROCESS | 32011 | Browser inner width/height: 1024/697 17:27:15 INFO - PROCESS | 32011 | __metrics 17:27:16 INFO - PROCESS | 32011 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:17 INFO - TEST-INFO | 32011: exit 0 17:27:17 INFO - Browser initialized. 17:27:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:17 INFO - TEST-INFO | started process 32097 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw48RF9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:28 INFO - PROCESS | 32097 | RSS: Main: 137859072 17:27:28 INFO - PROCESS | 32097 | 17:28:20 INFO - PROCESS | 32097 | 1458174500488 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] 17:30:27 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42386/tests/dromaeo/cssquery-ext.html) 17:30:28 INFO - PROCESS | 32097 | RSS: Main: 243113984 17:30:28 INFO - PROCESS | 32097 | 17:33:30 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-ext.html (next: http://localhost:42386/tests/dromaeo/cssquery-jquery.html) 17:33:31 INFO - PROCESS | 32097 | RSS: Main: 217968640 17:33:31 INFO - PROCESS | 32097 | 17:36:33 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42386/tests/dromaeo/cssquery-mootools.html) 17:36:33 INFO - PROCESS | 32097 | RSS: Main: 225677312 17:36:33 INFO - PROCESS | 32097 | 17:39:35 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42386/tests/dromaeo/cssquery-prototype.html) 17:39:36 INFO - PROCESS | 32097 | RSS: Main: 204025856 17:39:36 INFO - PROCESS | 32097 | 17:42:38 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42386/tests/dromaeo/cssquery-yui.html) 17:42:39 INFO - PROCESS | 32097 | RSS: Main: 205205504 17:42:39 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:42386/tests/dromaeo/cssquery-yui.html (next: http://localhost:42386/tests/dromaeo/cssquery-dojo.html) 17:45:41 INFO - PROCESS | 32097 | RSS: Main: 252891136 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | __start_tp_report 17:45:41 INFO - PROCESS | 32097 | _x_x_mozilla_page_load 17:45:41 INFO - PROCESS | 32097 | _x_x_mozilla_page_load_details 17:45:41 INFO - PROCESS | 32097 | |i|pagename|runs| 17:45:41 INFO - PROCESS | 32097 | |0;dojo.html;3183.7612179086573;3226.5644138041357;3247.902562923112;3250.7724459287842;3268.166617512534;5079.949200507994;5082.136036873736;5090.694558326503;5118.6416950813455;5130.256112863633;5093.719845408501;5111.7699703513335;5115.488451154883;5118.206677964912;5142.614303927202;4681.602063824562;4728.385309909707;4731.503192164816;4781.139394908915;4804.735739534324;4712.6229901607785;4737;4754.310624959378;4759.190937540609;4759.690620109682;4680.3447517347595;4730.574248317651;4739.90520189596;4750.144973904696;4802.711837289757;4798.712077275374;4819.95180048202;4835.540623640766;4836.177849765549;4865.245886887538;4752.833650822239;4793;4800.447948485934;4818.301346304801;4823.614110871157;4996.9500304996845;5013.924791128136;5028.974855125737;5105.566026887719;5139.794408223666;5561.972190139064;5562.3881373048935;5562.916556251659;5568.053430916713;5578.609497335188;5549.694766787825;5598.776048958037;5612.887742245132;5614.129809879475;5618.6628802272;5155.845324640267;5234.555062819665;5234.947650523484;5274.103402421598;5298.231756395301;5727.198192253088;5767.336756273083;5773.74018169175;5775.740091695884;5777.740001699934;5376.166694162411;5544.86137846549;5547.223388725582;5552.08390615552;5554.111342185231;5481.205225242317;5575.637583557137;5641.407652196543;5644.379118296984;5675.716214189274;5506.972465137729;5518.33779946409;5520.282363292747;5520.503154716095;5523.502884740393;5469.097598896217;5511;5518.586106042063;5544.140658197985;5548.140038294071;4289.785510724451;4292.270314046557;4295.312749960054;4297.72064815786;4299.011227417712;3856.1130939883983;3877.2827027000094;3895.6299151580556;3908.159745654698;3945.861894833667;5289;5309.814156504503;5312.654677445954;5313.946860531422;5343.19852022192;5542.695151766611;5573.5819813514145;5596.1605759136455;5598.384177740445;5602.85992850182;5198.9861976914135;5255.500727430888;5270.789168433296;5320.600954928396;5334.093204155225;4808.759562021885;4837.105135549864;4843;4843;4862.6839255448285;5648.039833228361;5725.770969161187;5758.395368486249;5782;5784.681842498619;5480.534154596745;5522.9447705523235;5539.861503462445;5555.166724991283;5577.44225577439;5638.323401191719;5644.689542075061;5651.378348381757;5652.915206271827;5660.377358490645;5340.839774806762;5428.348598168245;5447.319085114361;5447.891042179213;5463.153211252262;5663.66018038919;5722.885542289214;5724.74238659253;5729.68486733217;5748.856278592902;5390.757415916215;5420.13277875538;5434.483724046209;5440.156775699773;5445.401005889428;5343.732813359239;5411.080116380146;5454.945450545602;5469.699166545719;5470.042742519963;5361.678299302054;5392.595555333287;5394.163904594794;5395.3525576931015;5397.946020539902;5441.350076459766;5458.863528411663;5471.6169868108855;5508;5513.255710479034;5270.631055826056;5327.067763141512;5335.706536140549;5362.731863406892;5415.296011518635 17:45:41 INFO - PROCESS | 32097 | |1;ext.html;549.7361266592036;559.5411762354868;571.0064487791242;572.7136431784108;581.9214406055183;30335.696643033563;30728.38543229134;38377.61622383779;38894;38908.80545597268;46713.532864671346;47312.76343618277;47443.76278118613;47445.288320675216;47450.050998980085;9069.501177435255;9264.861027084598;9269.629214831399;9273.58268877902;9276.582553785096;9012.098790121001;9138.862917056249;9190.21883139934;9190.540472976358;9194.034626364235;9150.267978561698;9226.031266716998;9228.26173906086;9230.307726920475;9231.630734770635;9100;9171.44971301724;9172.082791720775;9182.816343673156;9203.861942070875;8962.058983806737;9119.088091190893;9125.954370228174;9135.040820713795;9136.725898223063;43041.56958430407;43526;43597;43610.56389436097;43654.78172609117;3629.564452265745;3646.5806432260365;3708.981455092707;3753.6997040236715;3755.267722794056;29572.260693482836;29585;29738.256543586584;33498.832505837556;33978.49032264518;4101.282275601758;4128.772917489537;4177.227212965611;4182.56083111275;4203.936940945889;293190;295022;296057;296083;297136.5143174292;61842;62897;68866.65566672134;69313;70204.64897675479;61590.69204653948;62005.68997154985;62134.689326553984;62255.377446225866;62294.377056229765;18116.365927192484;18352.541186470444;18355.908220458812;18391.080445977914;18393.172307246205;13796.724065518634;13868.791968120486;13874.86125138756;13894.166350019032;13997.30013499321;22495.100195991978;22760.544789104126;22944.4263893404;23021.84890755489;23027.654585181237;7937.404694647925;8305.211004954519;8421.95789021051;8546.359023073295;8561.914380856237;1011.3906122204841;1115.1803424482998;1119.2822254198593;1186.596557170549;1189.2745425290566;29428.264293392407;29745.85127074394;29984.700152998626;30457.543136852964;30561.930332438256;1147.6671765188169;1241.7392347606924;1261.65935197498;1267;1294.087668193921;13533.661658458617;15687.450939217073;15771;15989.840101599068;16466.917665411594;350268.24865876016;350745;350774;351203;355763;57448.138277925864;57617;57879.4212057874;57882;57988.71005645029;1361.271719630013;1457.3441951122038;1458.941642334316;1486.1677460622086;1487.6652753130459;23734.762652373254;29986.400271994;30444.39111217719;31148;31224.531632025082;53782.19326710181;53976.19035714546;54085;54133.45866541284;54177.45822541882;288353;291994;308880;308933;317503;33547.65809367598;33601.66398335985;33640.66359336375;33780.3243935115;34153;46225;47595.524044759106;47675;48014.27978580394;48203.75898120487;38906.80546597362;39206.803965981126;39567.02164891802;40006.1998760029;40585.59414405818;39166.216675666896;40293.59706402898;40438.1912361757;40559.21069014774;40887.795561022;39418.40872386859;39630;40355;40370.79814601026;40451.59548404478;35084.64915350916;35969.28061438809;36005.27989440249;36201.45697814482;36327.455088174225;26318.473630527664;26549.469010620065;26765.598516022666;27349.453010939273;27966.95427220604 17:45:41 INFO - PROCESS | 32097 | |2;jquery.html;372.94965179700733;399.161760303363;402.42453291792737;403.1252182763405;407.4438391595472;12716.809247861267;16521.17394130293;17131.229094690738;17131.314747410102;19548.413547593558;17837.82162178378;18067.72898406525;18091.547711307223;18103.456896293133;18187.454376368696;6205.813825585228;6407.935920640781;6411.294757576663;6411.455026322768;6415.390537898892;6100.389961003909;6247.625142491443;6318.988961766118;6339.207599050119;6354.2692590352235;4514.345419914127;4643.466001409831;4986.950130498703;6340.492760579143;6342.048692696087;6897.1033765610655;7120.074390329276;7130.893036604429;7140.357367836894;7157.964210178942;6569.408753212186;6785.2196997345445;6800.08198893153;6802.115724955774;6805.625690587016;21398.679019814714;21997.780022199735;22189;22225.333240002827;22228;2514.57252267115;2520.092766604021;2532.278300684296;2553.9233822985157;2571.996921200733;14039.227842468661;14148.434062637481;14265.28673566328;14613.050151740103;14668.706625867422;1984.6725290327079;2027.858049936505;2048.94877628059;2076.844236682255;2108.862923909941;63732.36267637357;64604.353956460305;65211.67394163046;65778.67110664464;66888.99666505055;14520.63698407527;15482.767758483631;15495.84504154944;15545.689086218212;15587.454439094805;23801.166959156693;23850.7614923852;24214.63678044831;24238;24257;7999.120096789348;8400.411971162082;8528.829423411496;8571.142885711379;9576.521173941275;8288.70989515364;8329.08380078191;8348.123447038095;8348.540830254395;8348.624311905978;4742.407199100113;4759.666823322404;4802.615790736802;4810.5670489656095;4853.563179313879;1698.9585688512022;1913.6938089905548;1975.4962484566631;1984.6130004648955;1999.5101200206043;459.6139243035866;460.56016504238374;465.3299249081312;465.72289487754733;482.0431443584482;10817.242793004414;10993.945030274797;11445.427728613537;16332.591685207964;16506.42227522031;958.4201558057414;972.8589354543551;1013.6958912326272;1023.4064242739194;1054.1672079057612;9655.613775449045;9856.704298871045;9896.703098907044;9924;9930.851037234448;171924.14037929982;172181;397150;533022;570178;74547.62726186334;77251;78668.21331786724;79989.60005199937;81397.18602814015;1133.2010932292715;1184.3367714080143;1185.4309931233056;1200.5557943560764;1212.1333246728632;15629.76555351648;15770.211489425254;15771.526854194393;16034.198290085682;16040.278187481357;32309.838450807594;32706.83646581752;34716;36637.26725465529;36801.447978279815;42742;42971;43698.378097314264;45286.77356613196;47167.76416117897;7297.963510182415;7330.926690733238;7574.235404077583;7619.809504762426;7716.5370077795515;8935.597898094471;10734.463276836283;11548;11551.595694150665;11762.647120586396;7924;9253.014915899917;9507.239420846454;9930.751731206778;9994.850077248993;9992.500374981368;10089.142422893843;10166.390016599027;10522.947385263025;10619.415932123808;9315.72052838416;9653.227741780782;9706.320557560903;9723.319367644197;9746.512674366395;7071.186813516511;7624.466287359832;7735;7750.302472777477;7916.762497125095;8829.60266788009;9093.636254549743;9254.676086336945;9668.37155584913;9766.658166964122 17:45:41 INFO - PROCESS | 32097 | |3;mootools.html;1425.9358328875212;1594.2268000019992;1604.2139351717658;1850.3893715074028;1952.6973319135539;7401.70393184272;8073.798155046126;8209.973753280847;8226;8228.794280143;8131.552764597959;8346.624401901914;8375.539345336005;8378.12029736878;8388.496690198592;2445.29086564896;2478.983616717146;2481.392058945561;2485.3413845331;2485.72657007729;2391.270662447953;2406.097713357491;2472.6538284640164;2487.067349743846;2493.002798880444;2464.199135281032;2472.81453890958;2473.6536884836137;2475.8390704604235;2497.687789026372;2439.1219161102076;2451.754824517543;2461.9876900615473;2516.7860731837814;2519.9370015749755;2451.154351748644;2462.56905041617;2477.7893879020125;2488.589382751844;2491.6262560615874;8270.917290827076;8298.419110662197;8300;8317;8317.376196785266;5261.158214685632;5369.24830523727;5373.355197376301;5373.946260537423;5379.139337705988;3224.2423030587793;3262.869485220588;3304.5704058472484;3317.419451595961;3323.551320571716;1074.8495210670512;1120.6077872744474;1124.5951457475303;1126.8929451702074;1147.0651419093413;11738.882611173864;11754.23597466162;11759.58841440554;11761.353125578089;11776.11679124069;4568.840090596813;4580.748058856728;4603.976980115078;4625.838095666635;4633.884152896205;10019.899801002042;10034.949825250827;10035.498225088717;10060.094591486655;10067.748306292402;5171.870703232449;5198.81804136861;5199.246109314204;5207.557357624569;5212.530872221519;4023.91952160961;4077.734947228421;4738.407699037621;4790.688605240648;4828.637852161102;4015.578364271768;4029.274730548471;4042.110735638155;4055.310597198424;4081.0409553754844;1284.1203775413871;1320.4058173821627;1323.530146797892;1334.2794890759076;1338.3508998135896;1411.7176564687104;1448.3554818106052;1469.169918995764;1470.5661829760247;1479.4821812365585;7777.727779527802;7813.062432508135;7833.843323133619;7849.803754906059;8005.039395272488;522.7569180331088;525.1309083466869;525.9316288882421;534.3427584071613;539.541389818651;5431.646942948775;5455.809046683347;5481.123020316731;5490.560755139659;5552.666839989613;9730.902690973142;10115.494225288707;10292.742681432874;10391.064804167661;10434.895651043544;10087.899121008695;10177.898221017844;10290.073893349634;10334.379937203792;10347.534360953776;7652.65563049653;8125.878111828328;8137.674493020331;8139.1453897339925;8159.306458951056;7664.616769161631;7699.61406946755;7781.338586220235;7783.260590244145;7791.298783109547;8926.86609700868;9181.311401644769;9404.106609872051;9437.716868493957;9438.669646562612;9028.27773778083;9209.17117459432;9368.39105458143;9593.328467007243;9595.328327017041;6523.510736694672;6714.227863795726;6725.697343619451;7415.740449084256;7541.170471248268;7768;7903.723369682263;7937.563434011185;7954.125046245024;7964.402669799904;7287.963560182166;7506.024216851774;7523.774286771406;7594.430417718803;7621.123570789208;7434.405247580073;7581.658825352762;7592.202818703957;7696.384289256958;7712.691492340468;7371.668274927534;7430.442716796154;7447.813804654927;7454.217307182885;7464.738734144279;6587.80236592903;6655.933440665725;6787.5588086774205;6802.387785099365;6850.862982740417;6943.340382663639;6952.165740111219;6957.79126626202;7008.579485230903;7009 17:45:41 INFO - PROCESS | 32097 | |4;prototype.html;366.2455341995488;374.8013552817007;381.2470371017241;382.31947134101307;393.7302947480974;5992;6065.36313687062;6074.362191969846;6080.72636731347;6082.8479288017825;5724.942750572493;5857.47282744554;5871.559633027529;6014.578979471439;6030.849228769283;4704.082703872747;4708.152532544141;4718.127146477896;4729.645276604251;4732.793137749877;4500.099980004013;4740.6918550294295;4741.146593613148;4746.908211111447;4759.428868535763;4551.772411379435;4580.358749775034;4650.4186976627925;4657.115148121863;4685.0395668887795;4644.814207431698;4656.068786242765;4664.230401983668;4666.463356713971;4670.953290467103;4174.227767862955;4184.4351012613215;4187.183499217654;4188.539260681323;4192.140611174702;5584.664920104807;5639.548836093103;5663.801766938179;5665.1502274658715;5698.943010569924;5398.325209348832;5402.37872644647;5410.621256512046;5417.052015897202;5430.239766432703;6484.416402523795;6486.416222539994;6486.740530378779;6490.545661803676;6493.383128602775;4512.9774351128035;4513.074819661962;4516.864494065183;4519.231730605805;4521.208788462006;6590.999999999952;6637.73449062037;6711.362420570087;6713.597184168965;6726.360995705449;4677.298405239173;4702.31816386622;4706.987997580468;4707.74028466338;4710.364100846342;4769.451513075971;4772.0455908817685;4775.355327030876;4778.689385189951;4780.067886762048;5331.333583302087;5424.430434804368;5430.348358196962;5437.34751829783;5447.891042179213;6453.709583068773;6458.515611329169;6471.514636402195;6478.935210647927;6481.805545833632;1647.8599319057776;1676.5389517882436;1676.7484877268264;1680.80670722866;1681.0838093239213;1089.215764649451;1093.8906109388997;1100.1638754546602;1117.1788735279563;1127.5997021057572;6249.9062514062325;6254.312025677172;6256.968715156395;6259.530535209878;6263.404976527223;6431.903521447182;6647.135872336566;6650.135482387259;6650.900236496456;6651.33486651331;6134.38656134383;6181.134641150243;6291.937080629226;6321.841953951188;6371.681415929278;3568.678818906311;3585.6772890439984;3597.424412094105;3597.4603809428795;3608;6750.932490675129;6918.723251070001;6919.515633905578;6920.653967301615;6930.826729331807;6863.759768408082;6870.416014638811;6879.58722476653;6880.862382752317;6886.724531018804;6917.377436030681;6926.61903595297;6927.5452155047;6930.757423490154;6934.410575101173;6564.8358791030605;6608;6679.899801503078;6680.665966701548;6686.632235226914;6554.344565543408;6565.409113179837;6584.407403333723;6591.604503729792;6592.340765923369;6876.965615172092;6906.93093069083;6914.896276555956;6917.7232910685025;6925.238223795278;4535.229011068061;4595.632349411972;4600.539946005507;4601.907961840678;4606.055758569418;6654.667266636552;6708.161479815023;6716.126903502709;6717.0520549042185;6722.630255335808;6489.351064893662;6537.084808126961;6548.770793022221;6566.474682025522;6570.474362050929;6372.87254254903;6548.0832683423405;6594.8351291218105;6610;6619.437347825488;6451.935480645134;6455.419012288917;6455.580387274812;6457.515686323451;6463.192100987377;6543.934560654333;6544.116544266463;6546.24718157418;6552.6723663817575;6586.1438013058;6295.18162638854;6406.519511036598;6418.1656384669695;6427.389398007182;6433.5496515243485 17:45:41 INFO - PROCESS | 32097 | |5;yui.html;761.0030859573958;863.3050394432481;894.2041582991139;944.2304521814716;944.5182956692084;12237.510499580017;12326.691832704175;12330.383480825956;12345.444454999524;12346.382680865965;11879.70300742482;11951.46218420171;13879.097858639181;14254.358553865075;14288.142711437322;753.7663324369463;755.207032615754;887.7381172554096;908.609298001859;910.8906931168269;893.5666201892077;900.6892622045384;904.2178515584038;907.664164259225;907.6777743900919;958.5399008475936;959.491469521155;960.1118964957421;960.4093482508277;960.433344326847;778.6301506784289;781.0081196879959;924.1036194890945;936.283742936654;949.4872768704926;686.080651926416;692.0829900381964;692.5671455340412;692.930706929308;693.1612748574231;12583.874161258362;12591.622251332476;12618.432170552256;12658.367081645973;12674.936625316906;11739.413029348498;12074.637760867188;12671.493140274379;12713.682157946032;13571.59285221445;10481.895181048245;10593.925937673488;10624.893751062467;10723.946380268128;10753.56985720578;3832.6550610445192;3851.84592616295;3854.5181852268465;3855.055511399697;3856.1709232514863;50863;51045;52775;52978.20532692013;53007.46992530064;9477;10169.796604067877;10255.128314093236;10342.896571034193;10432;18864.622707545772;18921.621567568847;18962;19449.12478938451;19453.610927781367;7555.09338879338;7570.394368450511;7710.845783084307;7826.647800848976;8180.6318715657935;4075.7350772200307;4079.755214687128;4094.549599544048;4112.259793237186;4128.823285363657;3000.4149190908;3011.2020314616643;3028.9394212115635;3035.1501579557757;3044.0867739678006;555.2753656478335;583.9620424672468;587.9235699359056;589.628534023571;591;657.5200103924162;665.3147258323934;671.6306031682556;679.6228093408206;690.2166041542885;8383.580820958927;8941.418807777474;8955.552222388855;9139.81720365589;9217.308701847389;650.5348675696805;713.115736486763;742.3170682971679;754.3927138653327;763.1452772894394;3953.3872249801325;4048.2713111640187;4150.91698166041;4203.327467605169;4246.723962942398;56341.7182914091;56985.43014569884;57459.13811292834;59196;59335.40664593385;48572.757136214095;49699.75150124226;50009.24986125211;50010.49989500058;50246.497535024915;44870.32694509585;44922.10155796866;45271;45335.31997019982;46782.298265526726;8304.833903321778;8427.494350338999;8590.613422396133;8643.265322447662;8762.342824288331;33890.66109338875;34679.479807802396;35092.473612895315;36154.27691446209;36402.45396319004;44477.777611111735;44679.32981005222;44898.551014490746;44912.32631510465;45599.31601025921;11591.88408115908;11816.645500634995;11918.761624767283;11972.940135299268;12295.877041229473;11823.76352472963;11831.40842957866;12268.202566833128;12552.05859560555;12982.350882456029;10845.349279043283;11436.885631143914;11571.479283432098;11632.069434445393;12001.1599188056;11466;11470.483828227583;11527.135464840003;11751;12002.519899203933;10433.530491127765;10718.24972251935;11032.393218373067;11138.498767555642;11409.771804564029;9320.487373194539;9723;9742.366746161477;9845.409275443497;10174;9623.518824058629;9805.21558275322;9888.307818452928;9898.257630677585;9934.354266972623 17:45:41 INFO - PROCESS | 32097 | __end_tp_report 17:45:41 INFO - PROCESS | 32097 | __start_cc_report 17:45:41 INFO - PROCESS | 32097 | _x_x_mozilla_cycle_collect,781 17:45:41 INFO - PROCESS | 32097 | __end_cc_report 17:45:41 INFO - PROCESS | 32097 | __startTimestamp1458175541589__endTimestamp 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | ------- Summary: start ------- 17:45:41 INFO - PROCESS | 32097 | Number of tests: 6 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#0] dojo.html Cycles:165 Average:5182.70 Median:5376.17 stddev:549.50 (10.2%) stddev-sans-first:528.34 17:45:41 INFO - PROCESS | 32097 | Values: 3183.8 3226.6 3247.9 3250.8 3268.2 5079.9 5082.1 5090.7 5118.6 5130.3 5093.7 5111.8 5115.5 5118.2 5142.6 4681.6 4728.4 4731.5 4781.1 4804.7 4712.6 4737.0 4754.3 4759.2 4759.7 4680.3 4730.6 4739.9 4750.1 4802.7 4798.7 4820.0 4835.5 4836.2 4865.2 4752.8 4793.0 4800.4 4818.3 4823.6 4997.0 5013.9 5029.0 5105.6 5139.8 5562.0 5562.4 5562.9 5568.1 5578.6 5549.7 5598.8 5612.9 5614.1 5618.7 5155.8 5234.6 5234.9 5274.1 5298.2 5727.2 5767.3 5773.7 5775.7 5777.7 5376.2 5544.9 5547.2 5552.1 5554.1 5481.2 5575.6 5641.4 5644.4 5675.7 5507.0 5518.3 5520.3 5520.5 5523.5 5469.1 5511.0 5518.6 5544.1 5548.1 4289.8 4292.3 4295.3 4297.7 4299.0 3856.1 3877.3 3895.6 3908.2 3945.9 5289.0 5309.8 5312.7 5313.9 5343.2 5542.7 5573.6 5596.2 5598.4 5602.9 5199.0 5255.5 5270.8 5320.6 5334.1 4808.8 4837.1 4843.0 4843.0 4862.7 5648.0 5725.8 5758.4 5782.0 5784.7 5480.5 5522.9 5539.9 5555.2 5577.4 5638.3 5644.7 5651.4 5652.9 5660.4 5340.8 5428.3 5447.3 5447.9 5463.2 5663.7 5722.9 5724.7 5729.7 5748.9 5390.8 5420.1 5434.5 5440.2 5445.4 5343.7 5411.1 5454.9 5469.7 5470.0 5361.7 5392.6 5394.2 5395.4 5397.9 5441.4 5458.9 5471.6 5508.0 5513.3 5270.6 5327.1 5335.7 5362.7 5415.3 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#1] ext.html Cycles:180 Average:50245.56 Median:39037.51 stddev:83049.99 (212.7%) stddev-sans-first:83199.14 17:45:41 INFO - PROCESS | 32097 | Values: 549.7 559.5 571.0 572.7 581.9 30335.7 30728.4 38377.6 38894.0 38908.8 46713.5 47312.8 47443.8 47445.3 47450.1 9069.5 9264.9 9269.6 9273.6 9276.6 9012.1 9138.9 9190.2 9190.5 9194.0 9150.3 9226.0 9228.3 9230.3 9231.6 9100.0 9171.4 9172.1 9182.8 9203.9 8962.1 9119.1 9126.0 9135.0 9136.7 43041.6 43526.0 43597.0 43610.6 43654.8 3629.6 3646.6 3709.0 3753.7 3755.3 29572.3 29585.0 29738.3 33498.8 33978.5 4101.3 4128.8 4177.2 4182.6 4203.9 293190.0 295022.0 296057.0 296083.0 297136.5 61842.0 62897.0 68866.7 69313.0 70204.6 61590.7 62005.7 62134.7 62255.4 62294.4 18116.4 18352.5 18355.9 18391.1 18393.2 13796.7 13868.8 13874.9 13894.2 13997.3 22495.1 22760.5 22944.4 23021.8 23027.7 7937.4 8305.2 8422.0 8546.4 8561.9 1011.4 1115.2 1119.3 1186.6 1189.3 29428.3 29745.9 29984.7 30457.5 30561.9 1147.7 1241.7 1261.7 1267.0 1294.1 13533.7 15687.5 15771.0 15989.8 16466.9 350268.2 350745.0 350774.0 351203.0 355763.0 57448.1 57617.0 57879.4 57882.0 57988.7 1361.3 1457.3 1458.9 1486.2 1487.7 23734.8 29986.4 30444.4 31148.0 31224.5 53782.2 53976.2 54085.0 54133.5 54177.5 288353.0 291994.0 308880.0 308933.0 317503.0 33547.7 33601.7 33640.7 33780.3 34153.0 46225.0 47595.5 47675.0 48014.3 48203.8 38906.8 39206.8 39567.0 40006.2 40585.6 39166.2 40293.6 40438.2 40559.2 40887.8 39418.4 39630.0 40355.0 40370.8 40451.6 35084.6 35969.3 36005.3 36201.5 36327.5 26318.5 26549.5 26765.6 27349.5 27967.0 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#2] jquery.html Cycles:180 Average:24127.36 Median:2552.01 stddev:67163.51 (2631.8%) stddev-sans-first:67328.23 17:45:41 INFO - PROCESS | 32097 | Values: 372.9 399.2 402.4 403.1 407.4 12716.8 16521.2 17131.2 17131.3 19548.4 17837.8 18067.7 18091.5 18103.5 18187.5 6205.8 6407.9 6411.3 6411.5 6415.4 6100.4 6247.6 6319.0 6339.2 6354.3 4514.3 4643.5 4987.0 6340.5 6342.0 6897.1 7120.1 7130.9 7140.4 7158.0 6569.4 6785.2 6800.1 6802.1 6805.6 21398.7 21997.8 22189.0 22225.3 22228.0 2514.6 2520.1 2532.3 2553.9 2572.0 14039.2 14148.4 14265.3 14613.1 14668.7 1984.7 2027.9 2048.9 2076.8 2108.9 63732.4 64604.4 65211.7 65778.7 66889.0 14520.6 15482.8 15495.8 15545.7 15587.5 23801.2 23850.8 24214.6 24238.0 24257.0 7999.1 8400.4 8528.8 8571.1 9576.5 8288.7 8329.1 8348.1 8348.5 8348.6 4742.4 4759.7 4802.6 4810.6 4853.6 1699.0 1913.7 1975.5 1984.6 1999.5 459.6 460.6 465.3 465.7 482.0 10817.2 10993.9 11445.4 16332.6 16506.4 958.4 972.9 1013.7 1023.4 1054.2 9655.6 9856.7 9896.7 9924.0 9930.9 171924.1 172181.0 397150.0 533022.0 570178.0 74547.6 77251.0 78668.2 79989.6 81397.2 1133.2 1184.3 1185.4 1200.6 1212.1 15629.8 15770.2 15771.5 16034.2 16040.3 32309.8 32706.8 34716.0 36637.3 36801.4 42742.0 42971.0 43698.4 45286.8 47167.8 7298.0 7330.9 7574.2 7619.8 7716.5 8935.6 10734.5 11548.0 11551.6 11762.6 7924.0 9253.0 9507.2 9930.8 9994.9 9992.5 10089.1 10166.4 10522.9 10619.4 9315.7 9653.2 9706.3 9723.3 9746.5 7071.2 7624.5 7735.0 7750.3 7916.8 8829.6 9093.6 9254.7 9668.4 9766.7 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#3] mootools.html Cycles:180 Average:5867.81 Median:525.53 stddev:3080.07 (586.1%) stddev-sans-first:3070.61 17:45:41 INFO - PROCESS | 32097 | Values: 1425.9 1594.2 1604.2 1850.4 1952.7 7401.7 8073.8 8210.0 8226.0 8228.8 8131.6 8346.6 8375.5 8378.1 8388.5 2445.3 2479.0 2481.4 2485.3 2485.7 2391.3 2406.1 2472.7 2487.1 2493.0 2464.2 2472.8 2473.7 2475.8 2497.7 2439.1 2451.8 2462.0 2516.8 2519.9 2451.2 2462.6 2477.8 2488.6 2491.6 8270.9 8298.4 8300.0 8317.0 8317.4 5261.2 5369.2 5373.4 5373.9 5379.1 3224.2 3262.9 3304.6 3317.4 3323.6 1074.8 1120.6 1124.6 1126.9 1147.1 11738.9 11754.2 11759.6 11761.4 11776.1 4568.8 4580.7 4604.0 4625.8 4633.9 10019.9 10034.9 10035.5 10060.1 10067.7 5171.9 5198.8 5199.2 5207.6 5212.5 4023.9 4077.7 4738.4 4790.7 4828.6 4015.6 4029.3 4042.1 4055.3 4081.0 1284.1 1320.4 1323.5 1334.3 1338.4 1411.7 1448.4 1469.2 1470.6 1479.5 7777.7 7813.1 7833.8 7849.8 8005.0 522.8 525.1 525.9 534.3 539.5 5431.6 5455.8 5481.1 5490.6 5552.7 9730.9 10115.5 10292.7 10391.1 10434.9 10087.9 10177.9 10290.1 10334.4 10347.5 7652.7 8125.9 8137.7 8139.1 8159.3 7664.6 7699.6 7781.3 7783.3 7791.3 8926.9 9181.3 9404.1 9437.7 9438.7 9028.3 9209.2 9368.4 9593.3 9595.3 6523.5 6714.2 6725.7 7415.7 7541.2 7768.0 7903.7 7937.6 7954.1 7964.4 7288.0 7506.0 7523.8 7594.4 7621.1 7434.4 7581.7 7592.2 7696.4 7712.7 7371.7 7430.4 7447.8 7454.2 7464.7 6587.8 6655.9 6787.6 6802.4 6850.9 6943.3 6952.2 6957.8 7008.6 7009.0 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#4] prototype.html Cycles:180 Average:5428.70 Median:6157.76 stddev:1621.13 (26.3%) stddev-sans-first:1580.52 17:45:41 INFO - PROCESS | 32097 | Values: 366.2 374.8 381.2 382.3 393.7 5992.0 6065.4 6074.4 6080.7 6082.8 5724.9 5857.5 5871.6 6014.6 6030.8 4704.1 4708.2 4718.1 4729.6 4732.8 4500.1 4740.7 4741.1 4746.9 4759.4 4551.8 4580.4 4650.4 4657.1 4685.0 4644.8 4656.1 4664.2 4666.5 4671.0 4174.2 4184.4 4187.2 4188.5 4192.1 5584.7 5639.5 5663.8 5665.2 5698.9 5398.3 5402.4 5410.6 5417.1 5430.2 6484.4 6486.4 6486.7 6490.5 6493.4 4513.0 4513.1 4516.9 4519.2 4521.2 6591.0 6637.7 6711.4 6713.6 6726.4 4677.3 4702.3 4707.0 4707.7 4710.4 4769.5 4772.0 4775.4 4778.7 4780.1 5331.3 5424.4 5430.3 5437.3 5447.9 6453.7 6458.5 6471.5 6478.9 6481.8 1647.9 1676.5 1676.7 1680.8 1681.1 1089.2 1093.9 1100.2 1117.2 1127.6 6249.9 6254.3 6257.0 6259.5 6263.4 6431.9 6647.1 6650.1 6650.9 6651.3 6134.4 6181.1 6291.9 6321.8 6371.7 3568.7 3585.7 3597.4 3597.5 3608.0 6750.9 6918.7 6919.5 6920.7 6930.8 6863.8 6870.4 6879.6 6880.9 6886.7 6917.4 6926.6 6927.5 6930.8 6934.4 6564.8 6608.0 6679.9 6680.7 6686.6 6554.3 6565.4 6584.4 6591.6 6592.3 6877.0 6906.9 6914.9 6917.7 6925.2 4535.2 4595.6 4600.5 4601.9 4606.1 6654.7 6708.2 6716.1 6717.1 6722.6 6489.4 6537.1 6548.8 6566.5 6570.5 6372.9 6548.1 6594.8 6610.0 6619.4 6451.9 6455.4 6455.6 6457.5 6463.2 6543.9 6544.1 6546.2 6552.7 6586.1 6295.2 6406.5 6418.2 6427.4 6433.5 17:45:41 INFO - PROCESS | 32097 | 17:45:41 INFO - PROCESS | 32097 | [#5] yui.html Cycles:180 Average:13925.07 Median:45096.55 stddev:16084.89 (35.7%) stddev-sans-first:16099.63 17:45:41 INFO - PROCESS | 32097 | Values: 761.0 863.3 894.2 944.2 944.5 12237.5 12326.7 12330.4 12345.4 12346.4 11879.7 11951.5 13879.1 14254.4 14288.1 753.8 755.2 887.7 908.6 910.9 893.6 900.7 904.2 907.7 907.7 958.5 959.5 960.1 960.4 960.4 778.6 781.0 924.1 936.3 949.5 686.1 692.1 692.6 692.9 693.2 12583.9 12591.6 12618.4 12658.4 12674.9 11739.4 12074.6 12671.5 12713.7 13571.6 10481.9 10593.9 10624.9 10723.9 10753.6 3832.7 3851.8 3854.5 3855.1 3856.2 50863.0 51045.0 52775.0 52978.2 53007.5 9477.0 10169.8 10255.1 10342.9 10432.0 18864.6 18921.6 18962.0 19449.1 19453.6 7555.1 7570.4 7710.8 7826.6 8180.6 4075.7 4079.8 4094.5 4112.3 4128.8 3000.4 3011.2 3028.9 3035.2 3044.1 555.3 584.0 587.9 589.6 591.0 657.5 665.3 671.6 679.6 690.2 8383.6 8941.4 8955.6 9139.8 9217.3 650.5 713.1 742.3 754.4 763.1 3953.4 4048.3 4150.9 4203.3 4246.7 56341.7 56985.4 57459.1 59196.0 59335.4 48572.8 49699.8 50009.2 50010.5 50246.5 44870.3 44922.1 45271.0 45335.3 46782.3 8304.8 8427.5 8590.6 8643.3 8762.3 33890.7 34679.5 35092.5 36154.3 36402.5 44477.8 44679.3 44898.6 44912.3 45599.3 11591.9 11816.6 11918.8 11972.9 12295.9 11823.8 11831.4 12268.2 12552.1 12982.4 10845.3 11436.9 11571.5 11632.1 12001.2 11466.0 11470.5 11527.1 11751.0 12002.5 10433.5 10718.2 11032.4 11138.5 11409.8 9320.5 9723.0 9742.4 9845.4 10174.0 9623.5 9805.2 9888.3 9898.3 9934.4 17:45:41 INFO - PROCESS | 32097 | -------- Summary: end -------- 17:45:41 INFO - PROCESS | 32097 | 17:45:42 INFO - TEST-INFO | 32097: exit 0 17:45:42 INFO - TEST-OK | dromaeo_css | took 1110615ms 17:45:42 INFO - TEST-START | kraken 17:45:42 INFO - operating with platform_type : linux_ 17:45:42 INFO - Initialising browser for kraken test... 17:45:42 INFO - TEST-INFO | started process 32291 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSg0udr/profile http://localhost:42386/getInfo.html) 17:45:46 INFO - PROCESS | 32291 | __metrics Screen width/height:1600/1200 17:45:46 INFO - PROCESS | 32291 | colorDepth:24 17:45:46 INFO - PROCESS | 32291 | Browser inner width/height: 1024/697 17:45:46 INFO - PROCESS | 32291 | __metrics 17:45:46 INFO - PROCESS | 32291 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:47 INFO - TEST-INFO | 32291: exit 0 17:45:47 INFO - Browser initialized. 17:45:47 INFO - Running cycle 1/1 for kraken test... 17:45:47 INFO - TEST-INFO | started process 32376 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSg0udr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:59 INFO - PROCESS | 32376 | RSS: Main: 136867840 17:45:59 INFO - PROCESS | 32376 | 17:46:01 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42386/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:02 INFO - PROCESS | 32376 | RSS: Main: 171663360 17:46:02 INFO - PROCESS | 32376 | 17:46:05 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42386/tests/kraken/driver.html?testName=audio-dft) 17:46:05 INFO - PROCESS | 32376 | RSS: Main: 168128512 17:46:05 INFO - PROCESS | 32376 | 17:46:08 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42386/tests/kraken/driver.html?testName=audio-fft) 17:46:09 INFO - PROCESS | 32376 | RSS: Main: 166051840 17:46:09 INFO - PROCESS | 32376 | 17:46:11 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42386/tests/kraken/driver.html?testName=audio-oscillator) 17:46:11 INFO - PROCESS | 32376 | RSS: Main: 168124416 17:46:11 INFO - PROCESS | 32376 | 17:46:13 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:14 INFO - PROCESS | 32376 | RSS: Main: 165683200 17:46:14 INFO - PROCESS | 32376 | 17:46:17 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42386/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:17 INFO - PROCESS | 32376 | RSS: Main: 165392384 17:46:17 INFO - PROCESS | 32376 | 17:46:21 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42386/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:21 INFO - PROCESS | 32376 | RSS: Main: 164835328 17:46:21 INFO - PROCESS | 32376 | 17:46:24 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42386/tests/kraken/driver.html?testName=json-parse-financial) 17:46:25 INFO - PROCESS | 32376 | RSS: Main: 165355520 17:46:25 INFO - PROCESS | 32376 | 17:46:26 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:27 INFO - PROCESS | 32376 | RSS: Main: 171364352 17:46:27 INFO - PROCESS | 32376 | 17:46:29 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:29 INFO - PROCESS | 32376 | RSS: Main: 166854656 17:46:29 INFO - PROCESS | 32376 | 17:46:31 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:32 INFO - PROCESS | 32376 | RSS: Main: 173252608 17:46:32 INFO - PROCESS | 32376 | 17:46:34 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:35 INFO - PROCESS | 32376 | RSS: Main: 177012736 17:46:35 INFO - PROCESS | 32376 | 17:46:37 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:38 INFO - PROCESS | 32376 | RSS: Main: 174186496 17:46:38 INFO - PROCESS | 32376 | 17:46:39 INFO - PROCESS | 32376 | Cycle 1(1): loaded http://localhost:42386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42386/tests/kraken/driver.html?testName=ai-astar) 17:46:40 INFO - PROCESS | 32376 | RSS: Main: 234078208 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | __start_tp_report 17:46:40 INFO - PROCESS | 32376 | _x_x_mozilla_page_load 17:46:40 INFO - PROCESS | 32376 | _x_x_mozilla_page_load_details 17:46:40 INFO - PROCESS | 32376 | |i|pagename|runs| 17:46:40 INFO - PROCESS | 32376 | |0;ai-astar;109;110;104;108;109;111;100;110;110;108 17:46:40 INFO - PROCESS | 32376 | |1;audio-beat-detection;159;129;159;161;125;151;164;129;162;128 17:46:40 INFO - PROCESS | 32376 | |2;audio-dft;161;160;160;160;160;160;163;164;160;162 17:46:40 INFO - PROCESS | 32376 | |3;audio-fft;73;74;77;144;74;72;73;76;150;72 17:46:40 INFO - PROCESS | 32376 | |4;audio-oscillator;96;96;149;95;96;95;138;95;96;137 17:46:40 INFO - PROCESS | 32376 | |5;imaging-gaussian-blur;109;109;109;109;108;110;117;109;109;109 17:46:40 INFO - PROCESS | 32376 | |6;imaging-darkroom;146;146;145;145;146;147;146;146;145;145 17:46:40 INFO - PROCESS | 32376 | |7;imaging-desaturate;95;96;96;96;96;95;96;95;96;96 17:46:40 INFO - PROCESS | 32376 | |8;json-parse-financial;55;54;54;55;55;55;56;56;57;53 17:46:40 INFO - PROCESS | 32376 | |9;json-stringify-tinderbox;63;64;65;64;64;64;65;65;64;63 17:46:40 INFO - PROCESS | 32376 | |10;stanford-crypto-aes;78;78;79;80;78;78;79;79;78;82 17:46:40 INFO - PROCESS | 32376 | |11;stanford-crypto-ccm;113;111;112;114;113;116;114;111;111;109 17:46:40 INFO - PROCESS | 32376 | |12;stanford-crypto-pbkdf2;150;152;148;147;149;140;146;148;148;149 17:46:40 INFO - PROCESS | 32376 | |13;stanford-crypto-sha256-iterative;66;67;67;65;65;66;67;68;69;65 17:46:40 INFO - PROCESS | 32376 | __end_tp_report 17:46:40 INFO - PROCESS | 32376 | __start_cc_report 17:46:40 INFO - PROCESS | 32376 | _x_x_mozilla_cycle_collect,905 17:46:40 INFO - PROCESS | 32376 | __end_cc_report 17:46:40 INFO - PROCESS | 32376 | __startTimestamp1458175600187__endTimestamp 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | ------- Summary: start ------- 17:46:40 INFO - PROCESS | 32376 | Number of tests: 14 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.38 (3.1%) stddev-sans-first:3.56 17:46:40 INFO - PROCESS | 32376 | Values: 109.0 110.0 104.0 108.0 109.0 111.0 100.0 110.0 110.0 108.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:159.00 stddev:16.69 (10.5%) stddev-sans-first:17.10 17:46:40 INFO - PROCESS | 32376 | Values: 159.0 129.0 159.0 161.0 125.0 151.0 164.0 129.0 162.0 128.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 17:46:40 INFO - PROCESS | 32376 | Values: 161.0 160.0 160.0 160.0 160.0 160.0 163.0 164.0 160.0 162.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#3] audio-fft Cycles:10 Average:88.50 Median:73.50 stddev:30.91 (42.0%) stddev-sans-first:32.27 17:46:40 INFO - PROCESS | 32376 | Values: 73.0 74.0 77.0 144.0 74.0 72.0 73.0 76.0 150.0 72.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.50 stddev:22.33 (23.4%) stddev-sans-first:23.16 17:46:40 INFO - PROCESS | 32376 | Values: 96.0 96.0 149.0 95.0 96.0 95.0 138.0 95.0 96.0 137.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:109.00 stddev:2.57 (2.4%) stddev-sans-first:2.71 17:46:40 INFO - PROCESS | 32376 | Values: 109.0 109.0 109.0 109.0 108.0 110.0 117.0 109.0 109.0 109.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:46:40 INFO - PROCESS | 32376 | Values: 146.0 146.0 145.0 145.0 146.0 147.0 146.0 146.0 145.0 145.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:46:40 INFO - PROCESS | 32376 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 17:46:40 INFO - PROCESS | 32376 | Values: 55.0 54.0 54.0 55.0 55.0 55.0 56.0 56.0 57.0 53.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 17:46:40 INFO - PROCESS | 32376 | Values: 63.0 64.0 65.0 64.0 64.0 64.0 65.0 65.0 64.0 63.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.29 (1.6%) stddev-sans-first:1.32 17:46:40 INFO - PROCESS | 32376 | Values: 78.0 78.0 79.0 80.0 78.0 78.0 79.0 79.0 78.0 82.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:113.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 17:46:40 INFO - PROCESS | 32376 | Values: 113.0 111.0 112.0 114.0 113.0 116.0 114.0 111.0 111.0 109.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.50 stddev:3.16 (2.1%) stddev-sans-first:3.24 17:46:40 INFO - PROCESS | 32376 | Values: 150.0 152.0 148.0 147.0 149.0 140.0 146.0 148.0 148.0 149.0 17:46:40 INFO - PROCESS | 32376 | 17:46:40 INFO - PROCESS | 32376 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 17:46:40 INFO - PROCESS | 32376 | Values: 66.0 67.0 67.0 65.0 65.0 66.0 67.0 68.0 69.0 65.0 17:46:40 INFO - PROCESS | 32376 | -------- Summary: end -------- 17:46:40 INFO - PROCESS | 32376 | 17:46:41 INFO - TEST-INFO | 32376: exit 0 17:46:41 INFO - TEST-OK | kraken | took 58826ms 17:46:41 INFO - TEST-START | v8_7 17:46:41 INFO - operating with platform_type : linux_ 17:46:41 INFO - Initialising browser for v8_7 test... 17:46:41 INFO - TEST-INFO | started process 32630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDQFV7c/profile http://localhost:42386/getInfo.html) 17:46:45 INFO - PROCESS | 32630 | __metrics Screen width/height:1600/1200 17:46:45 INFO - PROCESS | 32630 | colorDepth:24 17:46:45 INFO - PROCESS | 32630 | Browser inner width/height: 1024/697 17:46:45 INFO - PROCESS | 32630 | __metrics 17:46:45 INFO - PROCESS | 32630 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:46 INFO - TEST-INFO | 32630: exit 0 17:46:46 INFO - Browser initialized. 17:46:46 INFO - Running cycle 1/1 for v8_7 test... 17:46:46 INFO - TEST-INFO | started process 32719 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDQFV7c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:58 INFO - PROCESS | 32719 | RSS: Main: 137662464 17:46:58 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | Cycle 1(1): loaded http://localhost:42386/tests/v8_7/run.html (next: http://localhost:42386/tests/v8_7/run.html) 17:47:20 INFO - PROCESS | 32719 | RSS: Main: 421953536 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | __start_tp_report 17:47:20 INFO - PROCESS | 32719 | _x_x_mozilla_page_load 17:47:20 INFO - PROCESS | 32719 | _x_x_mozilla_page_load_details 17:47:20 INFO - PROCESS | 32719 | |i|pagename|runs| 17:47:20 INFO - PROCESS | 32719 | |0;Richards;168.83336147222693 17:47:20 INFO - PROCESS | 32719 | |1;DeltaBlue;173.91304347826087 17:47:20 INFO - PROCESS | 32719 | |2;Encrypt;277.700638711469 17:47:20 INFO - PROCESS | 32719 | |3;Decrypt;5170.103092783505 17:47:20 INFO - PROCESS | 32719 | |4;RayTrace;968.054211035818 17:47:20 INFO - PROCESS | 32719 | |5;Earley;562.1135469364812 17:47:20 INFO - PROCESS | 32719 | |6;Boyer;10670.212765957447 17:47:20 INFO - PROCESS | 32719 | |7;RegExp;41285.71428571428 17:47:20 INFO - PROCESS | 32719 | |8;Splay;508.646998982706 17:47:20 INFO - PROCESS | 32719 | |9;NavierStokes;4817.307692307692 17:47:20 INFO - PROCESS | 32719 | __end_tp_report 17:47:20 INFO - PROCESS | 32719 | __startTimestamp1458175640982__endTimestamp 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | ------- Summary: start ------- 17:47:20 INFO - PROCESS | 32719 | Number of tests: 10 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#0] Richards Cycles:1 Average:168.83 Median:168.83 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 168.8 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#1] DeltaBlue Cycles:1 Average:173.91 Median:173.91 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 173.9 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 277.7 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 5170.1 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#4] RayTrace Cycles:1 Average:968.05 Median:968.05 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 968.1 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#5] Earley Cycles:1 Average:562.11 Median:562.11 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 562.1 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#6] Boyer Cycles:1 Average:10670.21 Median:10670.21 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 10670.2 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#7] RegExp Cycles:1 Average:41285.71 Median:41285.71 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 41285.7 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#8] Splay Cycles:1 Average:508.65 Median:508.65 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 508.6 17:47:20 INFO - PROCESS | 32719 | 17:47:20 INFO - PROCESS | 32719 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:47:20 INFO - PROCESS | 32719 | Values: 4817.3 17:47:20 INFO - PROCESS | 32719 | -------- Summary: end -------- 17:47:20 INFO - PROCESS | 32719 | 17:47:21 INFO - TEST-INFO | 32719: exit 0 17:47:21 INFO - TEST-OK | v8_7 | took 40737ms 17:47:21 INFO - SUITE-END | took 1210s 17:47:22 INFO - Completed test suite (00:20:10) 17:47:22 INFO - Working with test: dromaeo_css 17:47:22 INFO - Generating results file: dromaeo_css 17:47:22 INFO - Working with test: kraken 17:47:22 INFO - Generating results file: kraken 17:47:22 INFO - javascript benchmark 17:47:22 INFO - Working with test: v8_7 17:47:22 INFO - Generating results file: v8_7 17:47:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 17:47:22 INFO - process_Request line: dromaeo_css 7175.59 graph.html#tests=[[72,53,35]] 17:47:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:22 INFO - process_Request line: kraken 1489.20 graph.html#tests=[[232,53,35]] 17:47:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:22 INFO - process_Request line: v8_7 21912.70 graph.html#tests=[[230,53,35]] 17:47:22 INFO - RETURN: dromaeo_css: 7175.59 17:47:22 INFO - RETURN: kraken: 1489.20 17:47:22 INFO - RETURN: v8_7: 21912.70 17:47:22 INFO - javascript benchmark 17:47:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.7612179086573, 3226.5644138041357, 3247.902562923112, 3250.7724459287842, 3268.166617512534, 5079.949200507994, 5082.136036873736, 5090.694558326503, 5118.6416950813455, 5130.256112863633, 5093.719845408501, 5111.7699703513335, 5115.488451154883, 5118.206677964912, 5142.614303927202, 4681.602063824562, 4728.385309909707, 4731.503192164816, 4781.139394908915, 4804.735739534324, 4712.6229901607785, 4737.0, 4754.310624959378, 4759.190937540609, 4759.690620109682, 4680.3447517347595, 4730.574248317651, 4739.90520189596, 4750.144973904696, 4802.711837289757, 4798.712077275374, 4819.95180048202, 4835.540623640766, 4836.177849765549, 4865.245886887538, 4752.833650822239, 4793.0, 4800.447948485934, 4818.301346304801, 4823.614110871157, 4996.9500304996845, 5013.924791128136, 5028.974855125737, 5105.566026887719, 5139.794408223666, 5561.972190139064, 5562.3881373048935, 5562.916556251659, 5568.053430916713, 5578.609497335188, 5549.694766787825, 5598.776048958037, 5612.887742245132, 5614.129809879475, 5618.6628802272, 5155.845324640267, 5234.555062819665, 5234.947650523484, 5274.103402421598, 5298.231756395301, 5727.198192253088, 5767.336756273083, 5773.74018169175, 5775.740091695884, 5777.740001699934, 5376.166694162411, 5544.86137846549, 5547.223388725582, 5552.08390615552, 5554.111342185231, 5481.205225242317, 5575.637583557137, 5641.407652196543, 5644.379118296984, 5675.716214189274, 5506.972465137729, 5518.33779946409, 5520.282363292747, 5520.503154716095, 5523.502884740393, 5469.097598896217, 5511.0, 5518.586106042063, 5544.140658197985, 5548.140038294071, 4289.785510724451, 4292.270314046557, 4295.312749960054, 4297.72064815786, 4299.011227417712, 3856.1130939883983, 3877.2827027000094, 3895.6299151580556, 3908.159745654698, 3945.861894833667, 5289.0, 5309.814156504503, 5312.654677445954, 5313.946860531422, 5343.19852022192, 5542.695151766611, 5573.5819813514145, 5596.1605759136455, 5598.384177740445, 5602.85992850182, 5198.9861976914135, 5255.500727430888, 5270.789168433296, 5320.600954928396, 5334.093204155225, 4808.759562021885, 4837.105135549864, 4843.0, 4843.0, 4862.6839255448285, 5648.039833228361, 5725.770969161187, 5758.395368486249, 5782.0, 5784.681842498619, 5480.534154596745, 5522.9447705523235, 5539.861503462445, 5555.166724991283, 5577.44225577439, 5638.323401191719, 5644.689542075061, 5651.378348381757, 5652.915206271827, 5660.377358490645, 5340.839774806762, 5428.348598168245, 5447.319085114361, 5447.891042179213, 5463.153211252262, 5663.66018038919, 5722.885542289214, 5724.74238659253, 5729.68486733217, 5748.856278592902, 5390.757415916215, 5420.13277875538, 5434.483724046209, 5440.156775699773, 5445.401005889428, 5343.732813359239, 5411.080116380146, 5454.945450545602, 5469.699166545719, 5470.042742519963, 5361.678299302054, 5392.595555333287, 5394.163904594794, 5395.3525576931015, 5397.946020539902, 5441.350076459766, 5458.863528411663, 5471.6169868108855, 5508.0, 5513.255710479034, 5270.631055826056, 5327.067763141512, 5335.706536140549, 5362.731863406892, 5415.296011518635], "unit": "score", "name": "dojo.html", "value": 5149.025835650136}, {"lowerIsBetter": false, "replicates": [549.7361266592036, 559.5411762354868, 571.0064487791242, 572.7136431784108, 581.9214406055183, 30335.696643033563, 30728.38543229134, 38377.61622383779, 38894.0, 38908.80545597268, 46713.532864671346, 47312.76343618277, 47443.76278118613, 47445.288320675216, 47450.050998980085, 9069.501177435255, 9264.861027084598, 9269.629214831399, 9273.58268877902, 9276.582553785096, 9012.098790121001, 9138.862917056249, 9190.21883139934, 9190.540472976358, 9194.034626364235, 9150.267978561698, 9226.031266716998, 9228.26173906086, 9230.307726920475, 9231.630734770635, 9100.0, 9171.44971301724, 9172.082791720775, 9182.816343673156, 9203.861942070875, 8962.058983806737, 9119.088091190893, 9125.954370228174, 9135.040820713795, 9136.725898223063, 43041.56958430407, 43526.0, 43597.0, 43610.56389436097, 43654.78172609117, 3629.564452265745, 3646.5806432260365, 3708.981455092707, 3753.6997040236715, 3755.267722794056, 29572.260693482836, 29585.0, 29738.256543586584, 33498.832505837556, 33978.49032264518, 4101.282275601758, 4128.772917489537, 4177.227212965611, 4182.56083111275, 4203.936940945889, 293190.0, 295022.0, 296057.0, 296083.0, 297136.5143174292, 61842.0, 62897.0, 68866.65566672134, 69313.0, 70204.64897675479, 61590.69204653948, 62005.68997154985, 62134.689326553984, 62255.377446225866, 62294.377056229765, 18116.365927192484, 18352.541186470444, 18355.908220458812, 18391.080445977914, 18393.172307246205, 13796.724065518634, 13868.791968120486, 13874.86125138756, 13894.166350019032, 13997.30013499321, 22495.100195991978, 22760.544789104126, 22944.4263893404, 23021.84890755489, 23027.654585181237, 7937.404694647925, 8305.211004954519, 8421.95789021051, 8546.359023073295, 8561.914380856237, 1011.3906122204841, 1115.1803424482998, 1119.2822254198593, 1186.596557170549, 1189.2745425290566, 29428.264293392407, 29745.85127074394, 29984.700152998626, 30457.543136852964, 30561.930332438256, 1147.6671765188169, 1241.7392347606924, 1261.65935197498, 1267.0, 1294.087668193921, 13533.661658458617, 15687.450939217073, 15771.0, 15989.840101599068, 16466.917665411594, 350268.24865876016, 350745.0, 350774.0, 351203.0, 355763.0, 57448.138277925864, 57617.0, 57879.4212057874, 57882.0, 57988.71005645029, 1361.271719630013, 1457.3441951122038, 1458.941642334316, 1486.1677460622086, 1487.6652753130459, 23734.762652373254, 29986.400271994, 30444.39111217719, 31148.0, 31224.531632025082, 53782.19326710181, 53976.19035714546, 54085.0, 54133.45866541284, 54177.45822541882, 288353.0, 291994.0, 308880.0, 308933.0, 317503.0, 33547.65809367598, 33601.66398335985, 33640.66359336375, 33780.3243935115, 34153.0, 46225.0, 47595.524044759106, 47675.0, 48014.27978580394, 48203.75898120487, 38906.80546597362, 39206.803965981126, 39567.02164891802, 40006.1998760029, 40585.59414405818, 39166.216675666896, 40293.59706402898, 40438.1912361757, 40559.21069014774, 40887.795561022, 39418.40872386859, 39630.0, 40355.0, 40370.79814601026, 40451.59548404478, 35084.64915350916, 35969.28061438809, 36005.27989440249, 36201.45697814482, 36327.455088174225, 26318.473630527664, 26549.469010620065, 26765.598516022666, 27349.453010939273, 27966.95427220604], "unit": "score", "name": "ext.html", "value": 20011.980640932707}, {"lowerIsBetter": false, "replicates": [372.94965179700733, 399.161760303363, 402.42453291792737, 403.1252182763405, 407.4438391595472, 12716.809247861267, 16521.17394130293, 17131.229094690738, 17131.314747410102, 19548.413547593558, 17837.82162178378, 18067.72898406525, 18091.547711307223, 18103.456896293133, 18187.454376368696, 6205.813825585228, 6407.935920640781, 6411.294757576663, 6411.455026322768, 6415.390537898892, 6100.389961003909, 6247.625142491443, 6318.988961766118, 6339.207599050119, 6354.2692590352235, 4514.345419914127, 4643.466001409831, 4986.950130498703, 6340.492760579143, 6342.048692696087, 6897.1033765610655, 7120.074390329276, 7130.893036604429, 7140.357367836894, 7157.964210178942, 6569.408753212186, 6785.2196997345445, 6800.08198893153, 6802.115724955774, 6805.625690587016, 21398.679019814714, 21997.780022199735, 22189.0, 22225.333240002827, 22228.0, 2514.57252267115, 2520.092766604021, 2532.278300684296, 2553.9233822985157, 2571.996921200733, 14039.227842468661, 14148.434062637481, 14265.28673566328, 14613.050151740103, 14668.706625867422, 1984.6725290327079, 2027.858049936505, 2048.94877628059, 2076.844236682255, 2108.862923909941, 63732.36267637357, 64604.353956460305, 65211.67394163046, 65778.67110664464, 66888.99666505055, 14520.63698407527, 15482.767758483631, 15495.84504154944, 15545.689086218212, 15587.454439094805, 23801.166959156693, 23850.7614923852, 24214.63678044831, 24238.0, 24257.0, 7999.120096789348, 8400.411971162082, 8528.829423411496, 8571.142885711379, 9576.521173941275, 8288.70989515364, 8329.08380078191, 8348.123447038095, 8348.540830254395, 8348.624311905978, 4742.407199100113, 4759.666823322404, 4802.615790736802, 4810.5670489656095, 4853.563179313879, 1698.9585688512022, 1913.6938089905548, 1975.4962484566631, 1984.6130004648955, 1999.5101200206043, 459.6139243035866, 460.56016504238374, 465.3299249081312, 465.72289487754733, 482.0431443584482, 10817.242793004414, 10993.945030274797, 11445.427728613537, 16332.591685207964, 16506.42227522031, 958.4201558057414, 972.8589354543551, 1013.6958912326272, 1023.4064242739194, 1054.1672079057612, 9655.613775449045, 9856.704298871045, 9896.703098907044, 9924.0, 9930.851037234448, 171924.14037929982, 172181.0, 397150.0, 533022.0, 570178.0, 74547.62726186334, 77251.0, 78668.21331786724, 79989.60005199937, 81397.18602814015, 1133.2010932292715, 1184.3367714080143, 1185.4309931233056, 1200.5557943560764, 1212.1333246728632, 15629.76555351648, 15770.211489425254, 15771.526854194393, 16034.198290085682, 16040.278187481357, 32309.838450807594, 32706.83646581752, 34716.0, 36637.26725465529, 36801.447978279815, 42742.0, 42971.0, 43698.378097314264, 45286.77356613196, 47167.76416117897, 7297.963510182415, 7330.926690733238, 7574.235404077583, 7619.809504762426, 7716.5370077795515, 8935.597898094471, 10734.463276836283, 11548.0, 11551.595694150665, 11762.647120586396, 7924.0, 9253.014915899917, 9507.239420846454, 9930.751731206778, 9994.850077248993, 9992.500374981368, 10089.142422893843, 10166.390016599027, 10522.947385263025, 10619.415932123808, 9315.72052838416, 9653.227741780782, 9706.320557560903, 9723.319367644197, 9746.512674366395, 7071.186813516511, 7624.466287359832, 7735.0, 7750.302472777477, 7916.762497125095, 8829.60266788009, 9093.636254549743, 9254.676086336945, 9668.37155584913, 9766.658166964122], "unit": "score", "name": "jquery.html", "value": 8766.54077563847}, {"lowerIsBetter": false, "replicates": [1425.9358328875212, 1594.2268000019992, 1604.2139351717658, 1850.3893715074028, 1952.6973319135539, 7401.70393184272, 8073.798155046126, 8209.973753280847, 8226.0, 8228.794280143, 8131.552764597959, 8346.624401901914, 8375.539345336005, 8378.12029736878, 8388.496690198592, 2445.29086564896, 2478.983616717146, 2481.392058945561, 2485.3413845331, 2485.72657007729, 2391.270662447953, 2406.097713357491, 2472.6538284640164, 2487.067349743846, 2493.002798880444, 2464.199135281032, 2472.81453890958, 2473.6536884836137, 2475.8390704604235, 2497.687789026372, 2439.1219161102076, 2451.754824517543, 2461.9876900615473, 2516.7860731837814, 2519.9370015749755, 2451.154351748644, 2462.56905041617, 2477.7893879020125, 2488.589382751844, 2491.6262560615874, 8270.917290827076, 8298.419110662197, 8300.0, 8317.0, 8317.376196785266, 5261.158214685632, 5369.24830523727, 5373.355197376301, 5373.946260537423, 5379.139337705988, 3224.2423030587793, 3262.869485220588, 3304.5704058472484, 3317.419451595961, 3323.551320571716, 1074.8495210670512, 1120.6077872744474, 1124.5951457475303, 1126.8929451702074, 1147.0651419093413, 11738.882611173864, 11754.23597466162, 11759.58841440554, 11761.353125578089, 11776.11679124069, 4568.840090596813, 4580.748058856728, 4603.976980115078, 4625.838095666635, 4633.884152896205, 10019.899801002042, 10034.949825250827, 10035.498225088717, 10060.094591486655, 10067.748306292402, 5171.870703232449, 5198.81804136861, 5199.246109314204, 5207.557357624569, 5212.530872221519, 4023.91952160961, 4077.734947228421, 4738.407699037621, 4790.688605240648, 4828.637852161102, 4015.578364271768, 4029.274730548471, 4042.110735638155, 4055.310597198424, 4081.0409553754844, 1284.1203775413871, 1320.4058173821627, 1323.530146797892, 1334.2794890759076, 1338.3508998135896, 1411.7176564687104, 1448.3554818106052, 1469.169918995764, 1470.5661829760247, 1479.4821812365585, 7777.727779527802, 7813.062432508135, 7833.843323133619, 7849.803754906059, 8005.039395272488, 522.7569180331088, 525.1309083466869, 525.9316288882421, 534.3427584071613, 539.541389818651, 5431.646942948775, 5455.809046683347, 5481.123020316731, 5490.560755139659, 5552.666839989613, 9730.902690973142, 10115.494225288707, 10292.742681432874, 10391.064804167661, 10434.895651043544, 10087.899121008695, 10177.898221017844, 10290.073893349634, 10334.379937203792, 10347.534360953776, 7652.65563049653, 8125.878111828328, 8137.674493020331, 8139.1453897339925, 8159.306458951056, 7664.616769161631, 7699.61406946755, 7781.338586220235, 7783.260590244145, 7791.298783109547, 8926.86609700868, 9181.311401644769, 9404.106609872051, 9437.716868493957, 9438.669646562612, 9028.27773778083, 9209.17117459432, 9368.39105458143, 9593.328467007243, 9595.328327017041, 6523.510736694672, 6714.227863795726, 6725.697343619451, 7415.740449084256, 7541.170471248268, 7768.0, 7903.723369682263, 7937.563434011185, 7954.125046245024, 7964.402669799904, 7287.963560182166, 7506.024216851774, 7523.774286771406, 7594.430417718803, 7621.123570789208, 7434.405247580073, 7581.658825352762, 7592.202818703957, 7696.384289256958, 7712.691492340468, 7371.668274927534, 7430.442716796154, 7447.813804654927, 7454.217307182885, 7464.738734144279, 6587.80236592903, 6655.933440665725, 6787.5588086774205, 6802.387785099365, 6850.862982740417, 6943.340382663639, 6952.165740111219, 6957.79126626202, 7008.579485230903, 7009.0], "unit": "score", "name": "mootools.html", "value": 4754.619945733492}, {"lowerIsBetter": false, "replicates": [366.2455341995488, 374.8013552817007, 381.2470371017241, 382.31947134101307, 393.7302947480974, 5992.0, 6065.36313687062, 6074.362191969846, 6080.72636731347, 6082.8479288017825, 5724.942750572493, 5857.47282744554, 5871.559633027529, 6014.578979471439, 6030.849228769283, 4704.082703872747, 4708.152532544141, 4718.127146477896, 4729.645276604251, 4732.793137749877, 4500.099980004013, 4740.6918550294295, 4741.146593613148, 4746.908211111447, 4759.428868535763, 4551.772411379435, 4580.358749775034, 4650.4186976627925, 4657.115148121863, 4685.0395668887795, 4644.814207431698, 4656.068786242765, 4664.230401983668, 4666.463356713971, 4670.953290467103, 4174.227767862955, 4184.4351012613215, 4187.183499217654, 4188.539260681323, 4192.140611174702, 5584.664920104807, 5639.548836093103, 5663.801766938179, 5665.1502274658715, 5698.943010569924, 5398.325209348832, 5402.37872644647, 5410.621256512046, 5417.052015897202, 5430.239766432703, 6484.416402523795, 6486.416222539994, 6486.740530378779, 6490.545661803676, 6493.383128602775, 4512.9774351128035, 4513.074819661962, 4516.864494065183, 4519.231730605805, 4521.208788462006, 6590.999999999952, 6637.73449062037, 6711.362420570087, 6713.597184168965, 6726.360995705449, 4677.298405239173, 4702.31816386622, 4706.987997580468, 4707.74028466338, 4710.364100846342, 4769.451513075971, 4772.0455908817685, 4775.355327030876, 4778.689385189951, 4780.067886762048, 5331.333583302087, 5424.430434804368, 5430.348358196962, 5437.34751829783, 5447.891042179213, 6453.709583068773, 6458.515611329169, 6471.514636402195, 6478.935210647927, 6481.805545833632, 1647.8599319057776, 1676.5389517882436, 1676.7484877268264, 1680.80670722866, 1681.0838093239213, 1089.215764649451, 1093.8906109388997, 1100.1638754546602, 1117.1788735279563, 1127.5997021057572, 6249.9062514062325, 6254.312025677172, 6256.968715156395, 6259.530535209878, 6263.404976527223, 6431.903521447182, 6647.135872336566, 6650.135482387259, 6650.900236496456, 6651.33486651331, 6134.38656134383, 6181.134641150243, 6291.937080629226, 6321.841953951188, 6371.681415929278, 3568.678818906311, 3585.6772890439984, 3597.424412094105, 3597.4603809428795, 3608.0, 6750.932490675129, 6918.723251070001, 6919.515633905578, 6920.653967301615, 6930.826729331807, 6863.759768408082, 6870.416014638811, 6879.58722476653, 6880.862382752317, 6886.724531018804, 6917.377436030681, 6926.61903595297, 6927.5452155047, 6930.757423490154, 6934.410575101173, 6564.8358791030605, 6608.0, 6679.899801503078, 6680.665966701548, 6686.632235226914, 6554.344565543408, 6565.409113179837, 6584.407403333723, 6591.604503729792, 6592.340765923369, 6876.965615172092, 6906.93093069083, 6914.896276555956, 6917.7232910685025, 6925.238223795278, 4535.229011068061, 4595.632349411972, 4600.539946005507, 4601.907961840678, 4606.055758569418, 6654.667266636552, 6708.161479815023, 6716.126903502709, 6717.0520549042185, 6722.630255335808, 6489.351064893662, 6537.084808126961, 6548.770793022221, 6566.474682025522, 6570.474362050929, 6372.87254254903, 6548.0832683423405, 6594.8351291218105, 6610.0, 6619.437347825488, 6451.935480645134, 6455.419012288917, 6455.580387274812, 6457.515686323451, 6463.192100987377, 6543.934560654333, 6544.116544266463, 6546.24718157418, 6552.6723663817575, 6586.1438013058, 6295.18162638854, 6406.519511036598, 6418.1656384669695, 6427.389398007182, 6433.5496515243485], "unit": "score", "name": "prototype.html", "value": 4913.654951978934}, {"lowerIsBetter": false, "replicates": [761.0030859573958, 863.3050394432481, 894.2041582991139, 944.2304521814716, 944.5182956692084, 12237.510499580017, 12326.691832704175, 12330.383480825956, 12345.444454999524, 12346.382680865965, 11879.70300742482, 11951.46218420171, 13879.097858639181, 14254.358553865075, 14288.142711437322, 753.7663324369463, 755.207032615754, 887.7381172554096, 908.609298001859, 910.8906931168269, 893.5666201892077, 900.6892622045384, 904.2178515584038, 907.664164259225, 907.6777743900919, 958.5399008475936, 959.491469521155, 960.1118964957421, 960.4093482508277, 960.433344326847, 778.6301506784289, 781.0081196879959, 924.1036194890945, 936.283742936654, 949.4872768704926, 686.080651926416, 692.0829900381964, 692.5671455340412, 692.930706929308, 693.1612748574231, 12583.874161258362, 12591.622251332476, 12618.432170552256, 12658.367081645973, 12674.936625316906, 11739.413029348498, 12074.637760867188, 12671.493140274379, 12713.682157946032, 13571.59285221445, 10481.895181048245, 10593.925937673488, 10624.893751062467, 10723.946380268128, 10753.56985720578, 3832.6550610445192, 3851.84592616295, 3854.5181852268465, 3855.055511399697, 3856.1709232514863, 50863.0, 51045.0, 52775.0, 52978.20532692013, 53007.46992530064, 9477.0, 10169.796604067877, 10255.128314093236, 10342.896571034193, 10432.0, 18864.622707545772, 18921.621567568847, 18962.0, 19449.12478938451, 19453.610927781367, 7555.09338879338, 7570.394368450511, 7710.845783084307, 7826.647800848976, 8180.6318715657935, 4075.7350772200307, 4079.755214687128, 4094.549599544048, 4112.259793237186, 4128.823285363657, 3000.4149190908, 3011.2020314616643, 3028.9394212115635, 3035.1501579557757, 3044.0867739678006, 555.2753656478335, 583.9620424672468, 587.9235699359056, 589.628534023571, 591.0, 657.5200103924162, 665.3147258323934, 671.6306031682556, 679.6228093408206, 690.2166041542885, 8383.580820958927, 8941.418807777474, 8955.552222388855, 9139.81720365589, 9217.308701847389, 650.5348675696805, 713.115736486763, 742.3170682971679, 754.3927138653327, 763.1452772894394, 3953.3872249801325, 4048.2713111640187, 4150.91698166041, 4203.327467605169, 4246.723962942398, 56341.7182914091, 56985.43014569884, 57459.13811292834, 59196.0, 59335.40664593385, 48572.757136214095, 49699.75150124226, 50009.24986125211, 50010.49989500058, 50246.497535024915, 44870.32694509585, 44922.10155796866, 45271.0, 45335.31997019982, 46782.298265526726, 8304.833903321778, 8427.494350338999, 8590.613422396133, 8643.265322447662, 8762.342824288331, 33890.66109338875, 34679.479807802396, 35092.473612895315, 36154.27691446209, 36402.45396319004, 44477.777611111735, 44679.32981005222, 44898.551014490746, 44912.32631510465, 45599.31601025921, 11591.88408115908, 11816.645500634995, 11918.761624767283, 11972.940135299268, 12295.877041229473, 11823.76352472963, 11831.40842957866, 12268.202566833128, 12552.05859560555, 12982.350882456029, 10845.349279043283, 11436.885631143914, 11571.479283432098, 11632.069434445393, 12001.1599188056, 11466.0, 11470.483828227583, 11527.135464840003, 11751.0, 12002.519899203933, 10433.530491127765, 10718.24972251935, 11032.393218373067, 11138.498767555642, 11409.771804564029, 9320.487373194539, 9723.0, 9742.366746161477, 9845.409275443497, 10174.0, 9623.518824058629, 9805.21558275322, 9888.307818452928, 9898.257630677585, 9934.354266972623], "unit": "score", "name": "yui.html", "value": 6467.610902233048}], "name": "dromaeo_css", "value": 7175.593757289532}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 108.0, 109.0, 111.0, 100.0, 110.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 159.0, 161.0, 125.0, 151.0, 164.0, 129.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 164.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 144.0, 74.0, 72.0, 73.0, 76.0, 150.0, 72.0], "unit": "score", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 95.0, 96.0, 95.0, 138.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 117.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 55.0, 55.0, 55.0, 56.0, 56.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 80.0, 78.0, 78.0, 79.0, 79.0, 78.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [113.0, 111.0, 112.0, 114.0, 113.0, 116.0, 114.0, 111.0, 111.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [150.0, 152.0, 148.0, 147.0, 149.0, 140.0, 146.0, 148.0, 148.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 65.0, 65.0, 66.0, 67.0, 68.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1489.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.83336147222693], "unit": "score", "name": "Richards", "value": 209.09374599999995}, {"lowerIsBetter": false, "replicates": [173.91304347826087], "unit": "score", "name": "DeltaBlue", "value": 380.17849999999993}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [968.054211035818], "unit": "score", "name": "RayTrace", "value": 764.4086370000001}, {"lowerIsBetter": false, "replicates": [562.1135469364812], "unit": "score", "name": "Earley", "value": 1185.6376769999997}, {"lowerIsBetter": false, "replicates": [10670.212765957447], "unit": "score", "name": "Boyer", "value": 62.46014157527414}, {"lowerIsBetter": false, "replicates": [41285.71428571428], "unit": "score", "name": "RegExp", "value": 22.06538062283738}, {"lowerIsBetter": false, "replicates": [508.646998982706], "unit": "score", "name": "Splay", "value": 160.211306}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 21912.697269973723}]} 17:47:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "21912.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1489.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7175.59"}}} 17:47:22 INFO - Return code: 0 17:47:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:47:22 INFO - # TBPL SUCCESS # 17:47:22 INFO - Running post-action listener: _resource_record_post_action 17:47:22 INFO - Running post-run listener: _resource_record_post_run 17:47:23 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 28672; Write bytes: 460931072; Read time: 416; Write time: 482836 17:47:23 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 4096; Write bytes: 234532864; Read time: 168; Write time: 359800 17:47:23 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 24576; Write bytes: 226398208; Read time: 248; Write time: 123036 17:47:23 INFO - Running post-run listener: _upload_blobber_files 17:47:23 INFO - Blob upload gear active. 17:47:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:47:23 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 17:47:23 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'] 17:47:23 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 17:47:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:25 INFO - (blobuploader) - INFO - Done attempting. 17:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:25 INFO - (blobuploader) - INFO - Done attempting. 17:47:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:25 INFO - Return code: 0 17:47:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:47:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58fa7de9ef47157ae5db1fa779d83c12f3eed8d8c39471983ef886890e2043738c6fb3c698c35d73ba2d88b433252e74531769d90fac8ed80f222e2f200726c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b28aea51f3d695bab988b15334f5124167d985a72e4aa6943023d63734ebcacaf0d70c16d8c2b7d8328dfbf1afe1f34ad7d1b04ed9527ef5acfe0f8e46921e"} 17:47:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:47:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:47:25 INFO - Contents: 17:47:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58fa7de9ef47157ae5db1fa779d83c12f3eed8d8c39471983ef886890e2043738c6fb3c698c35d73ba2d88b433252e74531769d90fac8ed80f222e2f200726c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b28aea51f3d695bab988b15334f5124167d985a72e4aa6943023d63734ebcacaf0d70c16d8c2b7d8328dfbf1afe1f34ad7d1b04ed9527ef5acfe0f8e46921e"} 17:47:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:25 INFO - Copying logs to upload dir... 17:47:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:47:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.570358 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-03-16 17:47:25.285529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:25.288640) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 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/58fa7de9ef47157ae5db1fa779d83c12f3eed8d8c39471983ef886890e2043738c6fb3c698c35d73ba2d88b433252e74531769d90fac8ed80f222e2f200726c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b28aea51f3d695bab988b15334f5124167d985a72e4aa6943023d63734ebcacaf0d70c16d8c2b7d8328dfbf1afe1f34ad7d1b04ed9527ef5acfe0f8e46921e"} build_url:https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/We3Fln4STWOwyi3Mnn4YMg/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/58fa7de9ef47157ae5db1fa779d83c12f3eed8d8c39471983ef886890e2043738c6fb3c698c35d73ba2d88b433252e74531769d90fac8ed80f222e2f200726c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b28aea51f3d695bab988b15334f5124167d985a72e4aa6943023d63734ebcacaf0d70c16d8c2b7d8328dfbf1afe1f34ad7d1b04ed9527ef5acfe0f8e46921e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:25.313083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:25.313433) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458174240.476109-535934533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:25.396481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:47:25.396883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:47:25.397190) ========= ========= Total master_lag: 0.24 =========