builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1453618957.96 results: success (0) buildid: 20160123203031 builduid: e8dd58988c904f0192fe19c0f7347a33 revision: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:37.968227) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:37.968930) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:37.969285) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:37.999028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:37.999361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.060499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.060833) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022129 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.126146) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.126453) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.126874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.127200) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 23:02:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.6M=0s 2016-01-23 23:02:39 (30.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150469 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.296152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.296484) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107729 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.415986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.416364) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 23:02:39,252 truncating revision to first 12 chars 2016-01-23 23:02:39,252 Setting DEBUG logging. 2016-01-23 23:02:39,252 attempt 1/10 2016-01-23 23:02:39,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d6d81655dd9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 23:02:39,518 unpacking tar archive at: b2g-inbound-d6d81655dd9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.970899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:38.971382) ========= echo d6d81655dd9e146c300a64c0fcaeb04ca3300a19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6d81655dd9e146c300a64c0fcaeb04ca3300a19'] 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6d81655dd9e146c300a64c0fcaeb04ca3300a19 program finished with exit code 0 elapsedTime=0.003663 script_repo_revision: 'd6d81655dd9e146c300a64c0fcaeb04ca3300a19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:39.023013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:39.023769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 23:02:39.034344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-23 23:02:39.035002) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:02:39 INFO - MultiFileLogger online at 20160123 23:02:39 in /builds/slave/test-pgo 23:02:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 23:02:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:02:39 INFO - {'append_to_log': False, 23:02:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:02:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:02:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:02:39 INFO - 'branch': 'B2G-Inbound', 23:02:39 INFO - 'buildbot_json_path': 'buildprops.json', 23:02:39 INFO - 'config_files': ('talos/linux_config.py',), 23:02:39 INFO - 'default_actions': ('clobber', 23:02:39 INFO - 'read-buildbot-config', 23:02:39 INFO - 'download-and-extract', 23:02:39 INFO - 'populate-webroot', 23:02:39 INFO - 'create-virtualenv', 23:02:39 INFO - 'install', 23:02:39 INFO - 'run-tests'), 23:02:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:02:39 INFO - 'download_minidump_stackwalk': True, 23:02:39 INFO - 'download_symbols': 'ondemand', 23:02:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:02:39 INFO - 'tooltool.py': '/tools/tooltool.py', 23:02:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:02:39 INFO - '/tools/misc-python/virtualenv.py')}, 23:02:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:02:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:02:39 INFO - 'installer_path': 'installer.exe', 23:02:39 INFO - 'log_level': 'info', 23:02:39 INFO - 'log_name': 'talos', 23:02:39 INFO - 'log_to_console': True, 23:02:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:02:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:02:39 INFO - 'opt_config_files': (), 23:02:39 INFO - 'pip_index': False, 23:02:39 INFO - 'sps_profile': False, 23:02:39 INFO - 'sps_profile_interval': 0, 23:02:39 INFO - 'suite': 'dromaeojs', 23:02:39 INFO - 'system_bits': '32', 23:02:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:02:39 INFO - 'title': 'talos-linux64-ix-010', 23:02:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:02:39 INFO - 'use_talos_json': True, 23:02:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:02:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:02:39 INFO - 'work_dir': 'build'} 23:02:39 INFO - ##### 23:02:39 INFO - ##### Running clobber step. 23:02:39 INFO - ##### 23:02:39 INFO - Running pre-action listener: _resource_record_pre_action 23:02:39 INFO - Running main action method: clobber 23:02:39 INFO - rmtree: /builds/slave/test-pgo/build 23:02:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:02:41 INFO - Running post-action listener: _resource_record_post_action 23:02:41 INFO - ##### 23:02:41 INFO - ##### Running read-buildbot-config step. 23:02:41 INFO - ##### 23:02:41 INFO - Running pre-action listener: _resource_record_pre_action 23:02:41 INFO - Running main action method: read_buildbot_config 23:02:41 INFO - Using buildbot properties: 23:02:41 INFO - { 23:02:41 INFO - "project": "", 23:02:41 INFO - "product": "firefox", 23:02:41 INFO - "script_repo_revision": "production", 23:02:41 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:02:41 INFO - "repository": "", 23:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:02:41 INFO - "buildid": "20160123203031", 23:02:41 INFO - "pgo_build": "True", 23:02:41 INFO - "basedir": "/builds/slave/test-pgo", 23:02:41 INFO - "buildnumber": 1129, 23:02:41 INFO - "slavename": "talos-linux64-ix-010", 23:02:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:02:41 INFO - "platform": "ubuntu64_hw", 23:02:41 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:02:41 INFO - "branch": "b2g-inbound", 23:02:41 INFO - "repo_path": "integration/b2g-inbound", 23:02:41 INFO - "revision": "d6d81655dd9e146c300a64c0fcaeb04ca3300a19", 23:02:41 INFO - "stage_platform": "linux64-pgo", 23:02:41 INFO - "builduid": "e8dd58988c904f0192fe19c0f7347a33", 23:02:41 INFO - "slavebuilddir": "test" 23:02:41 INFO - } 23:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:02:41 INFO - Running post-action listener: _resource_record_post_action 23:02:41 INFO - ##### 23:02:41 INFO - ##### Running download-and-extract step. 23:02:41 INFO - ##### 23:02:41 INFO - Running pre-action listener: _resource_record_pre_action 23:02:41 INFO - Running main action method: download_and_extract 23:02:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:02: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')]} 23:02:41 INFO - https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/test_packages.json 23:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/test_packages.json 23:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:02:42 INFO - Downloaded 1448 bytes. 23:02:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:02:42 INFO - Using the following test package requirements: 23:02:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:02:42 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:02:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'jsshell-linux-x86_64.zip'], 23:02:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:02:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:02:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:02:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:02:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:02:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:42 INFO - https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:02:43 INFO - Downloaded 22490681 bytes. 23:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:02:44 INFO - Return code: 0 23:02:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:02: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')]} 23:02:44 INFO - https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:02:50 INFO - Downloaded 22490681 bytes. 23:02:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:02:51 INFO - Return code: 0 23:02: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')]} 23:02:51 INFO - https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:02:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:02:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:02:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:02:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:02:52 INFO - Downloaded 10706572 bytes. 23:02:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:02:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:02:52 INFO - Return code: 0 23:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:52 INFO - https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:02:54 INFO - Downloaded 55965782 bytes. 23:02:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - mkdir: /builds/slave/test-pgo/properties 23:02:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:02:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:02:54 INFO - Contents: 23:02:54 INFO - build_url:https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - Running post-action listener: _resource_record_post_action 23:02:54 INFO - Running post-action listener: set_extra_try_arguments 23:02:54 INFO - ##### 23:02:54 INFO - ##### Running populate-webroot step. 23:02:54 INFO - ##### 23:02:54 INFO - Running pre-action listener: _resource_record_pre_action 23:02:54 INFO - Running main action method: populate_webroot 23:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:54 INFO - '--tppagecycles', 23:02:54 INFO - '7'], 23:02:54 INFO - 'tests': ['tsvgm']}}, 23:02:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:02:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:02:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:02:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'tests': ['damp', 'tps']}, 23:02:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['damp', 'tps']}, 23:02:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:02:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:54 INFO - 'other': {'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'other_l64': {'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'other_nol64': {'tests': ['a11yr', 23:02:54 INFO - 'ts_paint', 23:02:54 INFO - 'tpaint', 23:02:54 INFO - 'sessionrestore', 23:02:54 INFO - 'sessionrestore_no_auto_restore']}, 23:02:54 INFO - 'svgr': {'tests': ['tsvgx', 23:02:54 INFO - 'tsvgr_opacity', 23:02:54 INFO - 'tart', 23:02:54 INFO - 'tscrollx', 23:02:54 INFO - 'cart']}, 23:02:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['tsvgx', 23:02:54 INFO - 'tsvgr_opacity', 23:02:54 INFO - 'tart', 23:02:54 INFO - 'tscrollx', 23:02:54 INFO - 'cart']}, 23:02:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'tests': ['tp5o']}, 23:02:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'talos_options': ['--e10s'], 23:02:54 INFO - 'tests': ['tp5o']}, 23:02:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'talos_options': ['--xperf_path', 23:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:54 INFO - 'tests': ['tp5n']}, 23:02:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:54 INFO - 'talos_options': ['--e10s', 23:02:54 INFO - '--xperf_path', 23:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:54 INFO - 'tests': ['tp5n']}}, 23:02:54 INFO - 'talos.zip': {'path': '', 23:02:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:54 INFO - Running post-action listener: _resource_record_post_action 23:02:54 INFO - ##### 23:02:54 INFO - ##### Running create-virtualenv step. 23:02:54 INFO - ##### 23:02:54 INFO - Running pre-action listener: _resource_record_pre_action 23:02:54 INFO - Running main action method: create_virtualenv 23:02:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:02:54 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 23:02:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:02:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:54 INFO - Using real prefix '/usr' 23:02:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:02:54 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:57 INFO - Installing pip.................done. 23:02:57 INFO - Return code: 0 23:02:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:02:57 INFO - Using env: {'DISPLAY': ':0', 23:02:57 INFO - 'HOME': '/home/cltbld', 23:02:57 INFO - 'LANG': 'en_US.UTF-8', 23:02:57 INFO - 'LANGUAGE': 'en_US:en', 23:02:57 INFO - 'LOGNAME': 'cltbld', 23:02:57 INFO - 'MAIL': '/var/mail/cltbld', 23:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:57 INFO - 'MOZ_NO_REMOTE': '1', 23:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:57 INFO - 'NO_EM_RESTART': '1', 23:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:57 INFO - 'SHELL': '/bin/bash', 23:02:57 INFO - 'SHLVL': '1', 23:02:57 INFO - 'TERM': 'linux', 23:02:57 INFO - 'TMOUT': '86400', 23:02:57 INFO - 'USER': 'cltbld', 23:02:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:57 INFO - '_': '/tools/buildbot/bin/python'} 23:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:57 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 23:02:57 INFO - Cleaning up... 23:02:57 INFO - Return code: 0 23:02:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:02:57 INFO - Using env: {'DISPLAY': ':0', 23:02:57 INFO - 'HOME': '/home/cltbld', 23:02:57 INFO - 'LANG': 'en_US.UTF-8', 23:02:57 INFO - 'LANGUAGE': 'en_US:en', 23:02:57 INFO - 'LOGNAME': 'cltbld', 23:02:57 INFO - 'MAIL': '/var/mail/cltbld', 23:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:57 INFO - 'MOZ_NO_REMOTE': '1', 23:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:57 INFO - 'NO_EM_RESTART': '1', 23:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:57 INFO - 'SHELL': '/bin/bash', 23:02:57 INFO - 'SHLVL': '1', 23:02:57 INFO - 'TERM': 'linux', 23:02:57 INFO - 'TMOUT': '86400', 23:02:57 INFO - 'USER': 'cltbld', 23:02:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:57 INFO - '_': '/tools/buildbot/bin/python'} 23:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:57 INFO - Downloading/unpacking psutil>=0.7.1 23:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:59 INFO - Installing collected packages: psutil 23:02:59 INFO - Running setup.py install for psutil 23:02:59 INFO - building 'psutil._psutil_linux' extension 23:02:59 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 23:02:59 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 23:02:59 INFO - building 'psutil._psutil_posix' extension 23:02:59 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 23:02:59 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 23:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:59 INFO - Successfully installed psutil 23:02:59 INFO - Cleaning up... 23:02:59 INFO - Return code: 0 23:02:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:02:59 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')]} 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 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')]} 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:02:59 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 23:02:59 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 23:02:59 INFO - Using env: {'DISPLAY': ':0', 23:02:59 INFO - 'HOME': '/home/cltbld', 23:02:59 INFO - 'LANG': 'en_US.UTF-8', 23:02:59 INFO - 'LANGUAGE': 'en_US:en', 23:02:59 INFO - 'LOGNAME': 'cltbld', 23:02:59 INFO - 'MAIL': '/var/mail/cltbld', 23:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:59 INFO - 'MOZ_NO_REMOTE': '1', 23:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:59 INFO - 'NO_EM_RESTART': '1', 23:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:59 INFO - 'SHELL': '/bin/bash', 23:02:59 INFO - 'SHLVL': '1', 23:02:59 INFO - 'TERM': 'linux', 23:02:59 INFO - 'TMOUT': '86400', 23:02:59 INFO - 'USER': 'cltbld', 23:02:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:59 INFO - '_': '/tools/buildbot/bin/python'} 23:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:03:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:03:01 INFO - Installing collected packages: mozsystemmonitor 23:03:01 INFO - Running setup.py install for mozsystemmonitor 23:03:02 INFO - Successfully installed mozsystemmonitor 23:03:02 INFO - Cleaning up... 23:03:02 INFO - Return code: 0 23:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:03:02 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')]} 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:02 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')]} 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:02 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:02 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 23:03:02 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 23:03:02 INFO - Using env: {'DISPLAY': ':0', 23:03:02 INFO - 'HOME': '/home/cltbld', 23:03:02 INFO - 'LANG': 'en_US.UTF-8', 23:03:02 INFO - 'LANGUAGE': 'en_US:en', 23:03:02 INFO - 'LOGNAME': 'cltbld', 23:03:02 INFO - 'MAIL': '/var/mail/cltbld', 23:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:02 INFO - 'MOZ_NO_REMOTE': '1', 23:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:02 INFO - 'NO_EM_RESTART': '1', 23:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:02 INFO - 'SHELL': '/bin/bash', 23:03:02 INFO - 'SHLVL': '1', 23:03:02 INFO - 'TERM': 'linux', 23:03:02 INFO - 'TMOUT': '86400', 23:03:02 INFO - 'USER': 'cltbld', 23:03:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:02 INFO - '_': '/tools/buildbot/bin/python'} 23:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:02 INFO - Downloading/unpacking blobuploader==1.2.4 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 23:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 INFO - Downloading docopt-0.6.1.tar.gz 23:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:03:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:03:04 INFO - Running setup.py install for blobuploader 23:03:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:03:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:03:04 INFO - Running setup.py install for requests 23:03:05 INFO - Running setup.py install for docopt 23:03:05 INFO - Successfully installed blobuploader requests docopt 23:03:05 INFO - Cleaning up... 23:03:05 INFO - Return code: 0 23:03:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:05 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')]} 23:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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')]} 23:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:05 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 23:03:05 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 23:03:05 INFO - Using env: {'DISPLAY': ':0', 23:03:05 INFO - 'HOME': '/home/cltbld', 23:03:05 INFO - 'LANG': 'en_US.UTF-8', 23:03:05 INFO - 'LANGUAGE': 'en_US:en', 23:03:05 INFO - 'LOGNAME': 'cltbld', 23:03:05 INFO - 'MAIL': '/var/mail/cltbld', 23:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:05 INFO - 'MOZ_NO_REMOTE': '1', 23:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:05 INFO - 'NO_EM_RESTART': '1', 23:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:05 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:05 INFO - 'SHELL': '/bin/bash', 23:03:05 INFO - 'SHLVL': '1', 23:03:05 INFO - 'TERM': 'linux', 23:03:05 INFO - 'TMOUT': '86400', 23:03:05 INFO - 'USER': 'cltbld', 23:03:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:05 INFO - '_': '/tools/buildbot/bin/python'} 23:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:05 INFO - Running setup.py (path:/tmp/pip-2xDvEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:05 INFO - Running setup.py (path:/tmp/pip-nx1MME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:05 INFO - Running setup.py (path:/tmp/pip-HWIa8w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:05 INFO - Running setup.py (path:/tmp/pip-LJuPFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:05 INFO - Running setup.py (path:/tmp/pip-3IxkUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:06 INFO - Running setup.py (path:/tmp/pip-39N02Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:06 INFO - Running setup.py (path:/tmp/pip-cKOwk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:06 INFO - Running setup.py (path:/tmp/pip-zoKXzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:06 INFO - Running setup.py (path:/tmp/pip-kpNYok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:06 INFO - Running setup.py (path:/tmp/pip-dXbTbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:06 INFO - Running setup.py (path:/tmp/pip-5lRhEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:06 INFO - Running setup.py (path:/tmp/pip-cnR99J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:06 INFO - Running setup.py (path:/tmp/pip-mjjcxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:06 INFO - Running setup.py (path:/tmp/pip-II9xqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:06 INFO - Running setup.py (path:/tmp/pip-Vdwifh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:06 INFO - Running setup.py (path:/tmp/pip-xeTpRL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:06 INFO - Running setup.py (path:/tmp/pip-rWLiJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:03:06 INFO - Running setup.py install for manifestparser 23:03:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:03:06 INFO - Running setup.py install for mozcrash 23:03:07 INFO - Running setup.py install for mozdebug 23:03:07 INFO - Running setup.py install for mozdevice 23:03:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Running setup.py install for mozfile 23:03:07 INFO - Running setup.py install for mozhttpd 23:03:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Running setup.py install for mozinfo 23:03:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Running setup.py install for mozInstall 23:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Running setup.py install for mozleak 23:03:07 INFO - Running setup.py install for mozlog 23:03:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:03:07 INFO - Running setup.py install for moznetwork 23:03:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Running setup.py install for mozprocess 23:03:08 INFO - Running setup.py install for mozprofile 23:03:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Running setup.py install for mozrunner 23:03:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Running setup.py install for mozscreenshot 23:03:08 INFO - Running setup.py install for moztest 23:03:08 INFO - Running setup.py install for mozversion 23:03:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:03:08 INFO - Cleaning up... 23:03:08 INFO - Return code: 0 23:03:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03: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')]} 23:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03: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')]} 23:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:08 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:08 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 23:03:08 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 23:03:08 INFO - Using env: {'DISPLAY': ':0', 23:03:08 INFO - 'HOME': '/home/cltbld', 23:03:08 INFO - 'LANG': 'en_US.UTF-8', 23:03:08 INFO - 'LANGUAGE': 'en_US:en', 23:03:08 INFO - 'LOGNAME': 'cltbld', 23:03:08 INFO - 'MAIL': '/var/mail/cltbld', 23:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:08 INFO - 'MOZ_NO_REMOTE': '1', 23:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:08 INFO - 'NO_EM_RESTART': '1', 23:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:08 INFO - 'SHELL': '/bin/bash', 23:03:08 INFO - 'SHLVL': '1', 23:03:08 INFO - 'TERM': 'linux', 23:03:08 INFO - 'TMOUT': '86400', 23:03:08 INFO - 'USER': 'cltbld', 23:03:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:08 INFO - '_': '/tools/buildbot/bin/python'} 23:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:08 INFO - Running setup.py (path:/tmp/pip-44xcsd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:08 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)) 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:08 INFO - Running setup.py (path:/tmp/pip-VWK60q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:09 INFO - Running setup.py (path:/tmp/pip-RL2kh_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:09 INFO - Running setup.py (path:/tmp/pip-HspIuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:09 INFO - Running setup.py (path:/tmp/pip-LRxufG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:09 INFO - Running setup.py (path:/tmp/pip-bZF3TB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:09 INFO - Running setup.py (path:/tmp/pip-y42jzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:09 INFO - Running setup.py (path:/tmp/pip-QWOM5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:09 INFO - Running setup.py (path:/tmp/pip-I4gblO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:09 INFO - Running setup.py (path:/tmp/pip-w9cX2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:09 INFO - Running setup.py (path:/tmp/pip-71RRbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:09 INFO - Running setup.py (path:/tmp/pip-Wb42oU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:09 INFO - Running setup.py (path:/tmp/pip-oklsBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:09 INFO - Running setup.py (path:/tmp/pip-NrN2mI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:09 INFO - Running setup.py (path:/tmp/pip-WAD_1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:09 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)) 23:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:09 INFO - Running setup.py (path:/tmp/pip-nXiW97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:10 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)) 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:10 INFO - Running setup.py (path:/tmp/pip-zVqKHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:10 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)) 23:03:10 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)) 23:03:10 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)) 23:03:10 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)) 23:03:10 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)) 23:03:10 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)) 23:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:03:10 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 23:03:10 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 23:03:10 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 23:03:10 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 23:03:10 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 23:03:10 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 23:03:11 INFO - Downloading blessings-1.6.tar.gz 23:03:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:03:11 INFO - Installing collected packages: blessings 23:03:11 INFO - Running setup.py install for blessings 23:03:12 INFO - Successfully installed blessings 23:03:12 INFO - Cleaning up... 23:03:12 INFO - Return code: 0 23:03:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:03:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:03:12 INFO - Reading from file tmpfile_stdout 23:03:12 INFO - Current package versions: 23:03:12 INFO - argparse == 1.2.1 23:03:12 INFO - blessings == 1.6 23:03:12 INFO - blobuploader == 1.2.4 23:03:12 INFO - docopt == 0.6.1 23:03:12 INFO - manifestparser == 1.1 23:03:12 INFO - mozInstall == 1.12 23:03:12 INFO - mozcrash == 0.16 23:03:12 INFO - mozdebug == 0.1 23:03:12 INFO - mozdevice == 0.48 23:03:12 INFO - mozfile == 1.2 23:03:12 INFO - mozhttpd == 0.7 23:03:12 INFO - mozinfo == 0.9 23:03:12 INFO - mozleak == 0.1 23:03:12 INFO - mozlog == 3.1 23:03:12 INFO - moznetwork == 0.27 23:03:12 INFO - mozprocess == 0.22 23:03:12 INFO - mozprofile == 0.28 23:03:12 INFO - mozrunner == 6.11 23:03:12 INFO - mozscreenshot == 0.1 23:03:12 INFO - mozsystemmonitor == 0.0 23:03:12 INFO - moztest == 0.7 23:03:12 INFO - mozversion == 1.4 23:03:12 INFO - psutil == 3.1.1 23:03:12 INFO - requests == 1.2.3 23:03:12 INFO - wsgiref == 0.1.2 23:03:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:12 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')]} 23:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:12 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')]} 23:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:12 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:12 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 23:03:12 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 23:03:12 INFO - Using env: {'DISPLAY': ':0', 23:03:12 INFO - 'HOME': '/home/cltbld', 23:03:12 INFO - 'LANG': 'en_US.UTF-8', 23:03:12 INFO - 'LANGUAGE': 'en_US:en', 23:03:12 INFO - 'LOGNAME': 'cltbld', 23:03:12 INFO - 'MAIL': '/var/mail/cltbld', 23:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:12 INFO - 'MOZ_NO_REMOTE': '1', 23:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:12 INFO - 'NO_EM_RESTART': '1', 23:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:12 INFO - 'SHELL': '/bin/bash', 23:03:12 INFO - 'SHLVL': '1', 23:03:12 INFO - 'TERM': 'linux', 23:03:12 INFO - 'TMOUT': '86400', 23:03:12 INFO - 'USER': 'cltbld', 23:03:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:12 INFO - '_': '/tools/buildbot/bin/python'} 23:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 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)) 23:03:12 INFO - Cleaning up... 23:03:12 INFO - Return code: 0 23:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:03:12 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')]} 23:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:12 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')]} 23:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:12 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:12 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 23:03:12 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 23:03:12 INFO - Using env: {'DISPLAY': ':0', 23:03:12 INFO - 'HOME': '/home/cltbld', 23:03:12 INFO - 'LANG': 'en_US.UTF-8', 23:03:12 INFO - 'LANGUAGE': 'en_US:en', 23:03:12 INFO - 'LOGNAME': 'cltbld', 23:03:12 INFO - 'MAIL': '/var/mail/cltbld', 23:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:12 INFO - 'MOZ_NO_REMOTE': '1', 23:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:12 INFO - 'NO_EM_RESTART': '1', 23:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:12 INFO - 'SHELL': '/bin/bash', 23:03:12 INFO - 'SHLVL': '1', 23:03:12 INFO - 'TERM': 'linux', 23:03:12 INFO - 'TMOUT': '86400', 23:03:12 INFO - 'USER': 'cltbld', 23:03:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:12 INFO - '_': '/tools/buildbot/bin/python'} 23:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:12 INFO - Downloading/unpacking jsonschema 23:03:12 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 23:03:12 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 23:03:12 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 23:03:12 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 23:03:12 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 23:03:12 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 23:03:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:03:14 INFO - Downloading/unpacking functools32 (from jsonschema) 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 INFO - Downloading functools32-3.2.3-2.tar.gz 23:03:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:03:14 INFO - warning: no files found matching '*.txt' 23:03:14 INFO - no previously-included directories found matching 'build' 23:03:14 INFO - no previously-included directories found matching 'dist' 23:03:14 INFO - no previously-included directories found matching '.git*' 23:03:14 INFO - Installing collected packages: jsonschema, functools32 23:03:14 INFO - Running setup.py install for functools32 23:03:14 INFO - warning: no files found matching '*.txt' 23:03:14 INFO - no previously-included directories found matching 'build' 23:03:14 INFO - no previously-included directories found matching 'dist' 23:03:14 INFO - no previously-included directories found matching '.git*' 23:03:14 INFO - Successfully installed jsonschema functools32 23:03:14 INFO - Cleaning up... 23:03:15 INFO - Return code: 0 23:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:15 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 0x7fbcd1964f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, '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': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', '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 23:03:15 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 23:03:15 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 23:03:15 INFO - Using env: {'DISPLAY': ':0', 23:03:15 INFO - 'HOME': '/home/cltbld', 23:03:15 INFO - 'LANG': 'en_US.UTF-8', 23:03:15 INFO - 'LANGUAGE': 'en_US:en', 23:03:15 INFO - 'LOGNAME': 'cltbld', 23:03:15 INFO - 'MAIL': '/var/mail/cltbld', 23:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:15 INFO - 'MOZ_NO_REMOTE': '1', 23:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:15 INFO - 'NO_EM_RESTART': '1', 23:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:15 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:15 INFO - 'SHELL': '/bin/bash', 23:03:15 INFO - 'SHLVL': '1', 23:03:15 INFO - 'TERM': 'linux', 23:03:15 INFO - 'TMOUT': '86400', 23:03:15 INFO - 'USER': 'cltbld', 23:03:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:15 INFO - '_': '/tools/buildbot/bin/python'} 23:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:15 INFO - Downloading/unpacking flake8 23:03:15 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 23:03:15 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 23:03:15 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 23:03:15 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 23:03:15 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 23:03:15 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 23:03:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:03:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:03:17 INFO - no previously-included directories found matching 'docs/_build' 23:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:03:17 INFO - Running setup.py install for pep8 23:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:03:17 INFO - no previously-included directories found matching 'docs/_build' 23:03:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:03:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:03:17 INFO - Cleaning up... 23:03:17 INFO - Return code: 0 23:03:17 INFO - Running post-action listener: _resource_record_post_action 23:03:17 INFO - Running post-action listener: _start_resource_monitoring 23:03:17 INFO - Starting resource monitoring. 23:03:17 INFO - ##### 23:03:17 INFO - ##### Running install step. 23:03:17 INFO - ##### 23:03:17 INFO - Running pre-action listener: _resource_record_pre_action 23:03:17 INFO - Running main action method: install 23:03:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:03:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:03:18 INFO - Reading from file tmpfile_stdout 23:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 23:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:03:18 INFO - Reading from file tmpfile_stdout 23:03:18 INFO - Output received: 23:03:18 INFO - Usage: mozinstall [options] installer 23:03:18 INFO - Options: 23:03:18 INFO - -h, --help show this help message and exit 23:03:18 INFO - -d DEST, --destination=DEST 23:03:18 INFO - Directory to install application into. [default: 23:03:18 INFO - "/builds/slave/test-pgo"] 23:03:18 INFO - --app=APP Application being installed. [default: firefox] 23:03:18 INFO - mkdir: /builds/slave/test-pgo/build/application 23:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:03:34 INFO - Reading from file tmpfile_stdout 23:03:34 INFO - Output received: 23:03:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:03:34 INFO - Running post-action listener: _resource_record_post_action 23:03:34 INFO - ##### 23:03:34 INFO - ##### Running run-tests step. 23:03:34 INFO - ##### 23:03:34 INFO - Running pre-action listener: _resource_record_pre_action 23:03:34 INFO - Running main action method: run_tests 23:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:03:34 INFO - Python 2.7.3 23:03:34 INFO - Return code: 0 23:03:34 INFO - grabbing minidump binary from tooltool 23:03:34 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')]} 23:03:34 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 0x2073840>, '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 0x1fe06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:03:34 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 23:03:34 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 23:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:03:34 INFO - Return code: 0 23:03:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:03:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:03:35 INFO - Return code: 0 23:03:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 23:03:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 23:03:35 INFO - Using env: {'DISPLAY': ':0', 23:03:35 INFO - 'HOME': '/home/cltbld', 23:03:35 INFO - 'LANG': 'en_US.UTF-8', 23:03:35 INFO - 'LANGUAGE': 'en_US:en', 23:03:35 INFO - 'LOGNAME': 'cltbld', 23:03:35 INFO - 'MAIL': '/var/mail/cltbld', 23:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:35 INFO - 'MOZ_NO_REMOTE': '1', 23:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:35 INFO - 'NO_EM_RESTART': '1', 23:03:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:35 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:03:35 INFO - 'SHELL': '/bin/bash', 23:03:35 INFO - 'SHLVL': '1', 23:03:35 INFO - 'TERM': 'linux', 23:03:35 INFO - 'TMOUT': '86400', 23:03:35 INFO - 'USER': 'cltbld', 23:03:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965', 23:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:35 INFO - '_': '/tools/buildbot/bin/python'} 23:03:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 23:03:35 INFO - mozversion application_buildid: 20160123203031 23:03:35 INFO - mozversion application_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 23:03:35 INFO - mozversion application_display_name: Nightly 23:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:03:35 INFO - mozversion application_name: Firefox 23:03:35 INFO - mozversion application_remotingname: firefox 23:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:03:35 INFO - mozversion application_vendor: Mozilla 23:03:35 INFO - mozversion application_version: 46.0a1 23:03:35 INFO - mozversion platform_buildid: 20160123203031 23:03:35 INFO - mozversion platform_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 23:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:03:35 INFO - mozversion platform_version: 46.0a1 23:03:35 INFO - using testdate: 1453619015 23:03:35 INFO - actual date: 1453619015 23:03:35 INFO - starting webserver on 'localhost:57541' 23:03:35 INFO - SUITE-START | Running 3 tests 23:03:35 INFO - TEST-START | dromaeo_css 23:03:35 INFO - operating with platform_type : linux_ 23:03:35 INFO - Initialising browser for dromaeo_css test... 23:03:35 INFO - TEST-INFO | started process 3776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPpqSdP/profile http://localhost:57541/getInfo.html) 23:03:39 INFO - PROCESS | 3776 | __metrics Screen width/height:1600/1200 23:03:39 INFO - PROCESS | 3776 | colorDepth:24 23:03:39 INFO - PROCESS | 3776 | Browser inner width/height: 1024/697 23:03:39 INFO - PROCESS | 3776 | __metrics 23:03:40 INFO - PROCESS | 3776 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:03:40 INFO - PROCESS | 3776 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:03:41 INFO - TEST-INFO | 3776: exit 0 23:03:41 INFO - Browser initialized. 23:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 23:03:41 INFO - TEST-INFO | started process 3871 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPpqSdP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:53 INFO - PROCESS | 3871 | RSS: Main: 149114880 23:03:53 INFO - PROCESS | 3871 | 23:04:44 INFO - PROCESS | 3871 | 1453619084154 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] 23:06:52 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57541/tests/dromaeo/cssquery-ext.html) 23:06:53 INFO - PROCESS | 3871 | RSS: Main: 237363200 23:06:53 INFO - PROCESS | 3871 | 23:09:55 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-ext.html (next: http://localhost:57541/tests/dromaeo/cssquery-jquery.html) 23:09:56 INFO - PROCESS | 3871 | RSS: Main: 230907904 23:09:56 INFO - PROCESS | 3871 | 23:12:58 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57541/tests/dromaeo/cssquery-mootools.html) 23:12:58 INFO - PROCESS | 3871 | RSS: Main: 237580288 23:12:58 INFO - PROCESS | 3871 | 23:16:00 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57541/tests/dromaeo/cssquery-prototype.html) 23:16:01 INFO - PROCESS | 3871 | RSS: Main: 211476480 23:16:01 INFO - PROCESS | 3871 | 23:19:03 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57541/tests/dromaeo/cssquery-yui.html) 23:19:04 INFO - PROCESS | 3871 | RSS: Main: 214695936 23:19:04 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | Cycle 1(1): loaded http://localhost:57541/tests/dromaeo/cssquery-yui.html (next: http://localhost:57541/tests/dromaeo/cssquery-dojo.html) 23:22:07 INFO - PROCESS | 3871 | RSS: Main: 282681344 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | __start_tp_report 23:22:07 INFO - PROCESS | 3871 | _x_x_mozilla_page_load 23:22:07 INFO - PROCESS | 3871 | _x_x_mozilla_page_load_details 23:22:07 INFO - PROCESS | 3871 | |i|pagename|runs| 23:22:07 INFO - PROCESS | 3871 | |0;dojo.html;3097.674744151864;3114.922126946825;3156.6843315668434;3168.112928380053;3181.681831816818;5014.849554513361;5098.872528186797;5131.358580177473;5135.152699804527;5170.922436163456;4965.62757793166;4997.600191984641;5026.120428924933;5037.168867136918;5153.974230128844;4684.812607495696;4694.906101877978;4707.38803955487;4748.335233067356;4798.47216806151;417.96920352561125;4577.588017078462;4661.394018777554;4698.107359601682;4777.450593181794;4616.976915115437;4723.07899959508;4765.380500534943;4816.988432429212;4821.445533763592;4721.5750582447745;4729.574338309534;4734.644901632391;4739.715617062987;4767.974885399621;4548.385967894358;4615.215413379734;4706.247000479907;4716.457607375161;4774.665773395864;4942.061008408391;4962.702237865704;4981.37732783402;4981.775820088104;5034.899302013976;5471.8084867029465;5486.835394938118;5502.477264659851;5505.6696598204235;5537.169424586345;5355.678659280456;5413.810516631899;5429.864253393696;5528.889422211573;5533.557315414757;5083.720395378253;5125.64120511568;5129.974350128263;5131.050755610224;5146.536811686966;5594.412586678422;5598.048331783607;5601.103823388238;5639.266895303666;5647.774089036392;5243.239730239094;5315.787368505216;5319.28189694394;5371.033214021513;5423.918641220384;5411.729413529308;5519.034169020405;5522.779088836482;5530.695811730313;5571.860703482364;5437.782488700487;5450.5367043800925;5482.095454250084;5500.532454741312;5512.448755124536;5339.359276886798;5399.190121481809;5503.587230957694;5508.843142940027;5558.194061861008;4260.318349064135;4262.552431994658;4267.061246525759;4297.226499230106;4304.634106101016;3818.9618103818607;3825.139343647713;3827.0432391902023;3842.7502212356108;3844.1735026968777;4995.650304478651;5043.9747801260755;5080.314157588678;5095.439501654815;5175.81884634036;5477.260569823103;5497.065498865202;5499.50504454601;5505.284313039279;5535.778568857281;5084.593232541388;5085.211792172219;5089.033083714083;5100.438951715309;5133.307003554547;4630.560096790799;4696.436427628706;4703.882402939954;4708.128996135726;4759.50025247351;5682.232898558642;5693.68684722336;5709.486146246858;5710.143478478179;5717.142428635738;5503.3395992481155;5519.3652729936575;5526.668399896019;5527.668339899619;5550.916736249041;5512.5589952802875;5558.138488534284;5682.062459694104;5711.228984087095;5726.942730572808;5501.587380946365;5526.447355264441;5536.252605898152;5551.611387202857;5555.777768889199;5296.258523806747;5623.718814059199;5627.296587926509;5628.127640215773;5630.634008789416;5329.893402132013;5400.486953739389;5436.673799572039;5442.891142177214;5483.232347471437;5407.107827208467;5409.891802163856;5411.702356370437;5412.918806217831;5415.6479828811;5152.355955505562;5233.215017747369;5325.147976323769;5325.2810870531985;5375.489328513785;5404.216388623706;5411.918821217606;5448.346198456211;5449.64577302474;5468.91796623059;5243.790248390174;5250.921236181537;5251.212318152155;5260.316158899472;5281.15501519755 23:22:07 INFO - PROCESS | 3871 | |1;ext.html;494.9331840201574;521.0646888834542;526.1791605096048;527.7203082366345;537.6854540094046;28591.285217869565;29229.269268268305;36569.63430365692;36985.44521832168;37142.44286335707;40133;40539.59460405402;40567.391489127614;40573;40576.59423405765;7306.050213472267;8434.24091831735;8650;8670.089640587743;8676.132386761337;7402.62986850658;7512.060992375953;7520.623968801566;7523.586202758846;9998.45008524531;9999.850002249972;10074;10078.244131690117;10079.596816127383;10085.798284034316;9908.207343412545;9976.152027077707;9978;9985.850212246822;9995.15041221497;9980.500974951296;10073.093421592019;10101.646442374482;10107;10134.645287414978;36405;36761;36818;36874.44688329677;40047.19905601901;3173.6826317368077;3203.7116659500757;3298.901032969015;3618.8371523281253;4157.127003329305;26723.19830405091;26903.46193076147;29706.25734356637;29729;30131.397372052656;3850.249201405727;3855.749376290532;3876.8061596920325;3891.280113179071;3937.625925537098;265866;266356;266371;267409;269277;52880.73559632177;60738.696306518184;60968;61180.082298765556;61229.69385153046;48579;71598;72675.63662181761;72701.27298727051;72950.63524682449;15207.923960380127;15317.080975141527;15394.615134621725;15508.612284692974;15509.612259693373;11465.484053217626;11506.597269095542;11513.654590362303;11565.653030409101;11641.47613357401;20163.495912602008;20347.593048138955;20351.796482035286;20383.8980805095;20409.48976275605;7823.335016523659;7900.84198316042;8025.23760242776;8038.959805200937;8116.959415203004;943.8914524829732;973.8977407372265;1026.0662796854826;1042.3745752548562;1052.3317693264678;28554;29036;29507;29571;30865.382692346026;998.9960090109394;1013.3615822032073;1058.5342449322275;1062.585591619269;1093.2675107677717;13752.968527360488;13894.513692020731;14117.223552704494;14171.220582867834;14202.360893759598;366843;372066;372145;372959;373420;48587.271190932166;49572.75213623909;53579;54198.72900635472;54375.45624543783;1315.651352391617;1352.6618345413647;1365.5220672764453;1369.500132451648;1377.2425166158773;26941.191764247105;27114.593281101195;27617.861910690317;27772.722272777013;27807.44385112327;42231.78884105683;43372.34941475817;48676.75661621811;48817.51182488272;50298.74850625724;226421;227326;228172;228471;229210;38588;39000;39173;39184.412233817086;39256;41768.582314177685;42249.78875105605;42658.14683706371;42760;45958.54041459676;37860.810695947446;38229.61770382372;38380.616193837704;38613.2277354457;39489.40765888571;33977.3204535903;37969;38821.61178388293;39492.80253598714;43166;35266.47100293549;35545.82227088848;35684.28631427305;35808.46287305745;35886.461703073954;31476.213094672818;33190.33619327648;33419.66580334165;33843.3231335367;33879.66120338765;26360.60459093077;26941.191764247105;27115.457690846466;27224.72775272301;27266.454670906867 23:22:07 INFO - PROCESS | 3871 | |2;jquery.html;370.2077554034367;372.97202709796767;375.68817881158634;377.10625816814155;377.47907887115775;13862.930685346584;15373.538793836175;15569.455069072585;17749.645007099865;18556.257749690012;10937.398443085627;11211;11213.439328033606;11231.382273974928;15249.161296128736;3802.448644946481;4955.529224723646;5096.413912400084;5104.2088476286235;5105.897882042375;3876.7673939563574;5432.402435732086;5643.68959707216;5645.068563686987;5651.208830763697;5198.064348417283;5394.32570928634;5399.595030372718;5600;5626.2967129108865;5321.414644389114;5322.680639161663;5336.733163341837;5679.630823996468;5998.370171132012;5355.518003379676;5360.65155764874;5363.034653762321;5363.785448582052;5363.865903352447;18923;19441.708374374255;19897.701534476848;20035.89982050095;20429.591408171753;2011.9798802012085;2083.2500299892176;2127.680847872816;2275.5221403505284;2428.720697119836;9599.42403455795;9604.615815367377;10030.34802737827;11893.286402815858;12517.93741031289;1837.6126024851285;1851;1886.1041005522404;1892.3660573707825;1898.098403258455;48584.757076214744;49513.50486495161;54593.454065459235;56820;57200.71399642975;9761.707148785548;10214.182865370753;10343.27597068213;10356.669749306497;10424.68725938223;13439.664008399674;13488.12327198729;13510.797338039938;13510.86489135096;13516.324183790772;7764.534127952341;7817.491863028885;7828.099768526692;7854.72508462201;7858.371330293563;7503.399728021745;7551.471397002267;7552.244775522404;7579;7587.810304742426;4169.291220492523;4318.30907054876;4367.868963931087;4519.81920723174;4584.083183363341;1792.1666425112385;1835.6145209505887;1840.2822899069374;1851.1211120712487;1862.3574866670976;887.8712586674895;966.7824739433571;976.5751897924425;978.4422878959067;1017.2624846985876;13178.934105329412;14439.35022923971;15352.385904563916;16835.158242087848;16944.15279236033;894.0344428017726;912.9178373946244;969.1810420194925;987.3730181334904;1003.4681618742078;8092.878606820902;9119.452832830051;9470.95264523673;9499.90500095004;9586.95206523963;512802;515751;519485;522432;528836;66226.33773662298;68801;69979.65010175019;71229;71272.64363678252;1119.1662211652372;1125.7861006408757;1127.8702949160952;1154.5554961339944;1161.2045748662194;14781.408743650134;15034.849651503782;15054.849451505783;15070;15180.20494876281;31869.36261274808;32003.35993280168;32590.348193035534;33259.66740332566;33705.83147084249;41955;42550.936226593345;42803.57196427996;43826.561734383526;44307.556924431636;4281.865305693931;7115.217326094022;7240.782776516713;7456.66445009965;7480.177180510248;10170.338927969658;10675;11007.61473348429;11031.062359699194;11268.267562608404;8788.604512796812;9375.156235938799;9626.66306679263;9769.31614786958;9812.165965892978;7544.735934242275;8913.509756963429;9605;9744.220462362851;9977.950110249401;9282.582283797381;9316.627334906529;9356.578953947224;9426.95286523563;9533.142017218484;7079.433645308466;7163.426925845815;7270.127584689871;7282.854342913218;7361.447891408059;9082.18260356571;9562.760930976781;9618.182454491447;9680.515974201402;9760.365576237522 23:22:07 INFO - PROCESS | 3871 | |3;mootools.html;1306.0270098776414;1456.8761655259302;1479.2751551739648;1646.6542026174502;1797.7573027641265;6911.136107986502;7691.923080769197;7858.607069646523;7869.17373675763;7877.36981041516;7653.693852245903;7833.412494062954;7841.059072911258;7854.410919181056;7864.252895974873;1982.692682634187;2049.5798361335965;2277.23712556293;2295.9081636734554;2325.1513197682893;2330.6620540021686;2336.217367181996;2344.9882750586307;2352.6588644646604;2352.6706261123454;2239.8320125990535;2298.4368829636765;2301.0680674326923;2303.28598134578;2306.792388685018;2288.4164538042774;2311.768823117683;2349.9530009399887;2362.5156842847173;2364.1843563970488;2315.2591170825344;2318.7801329698864;2333.754955729641;2337.6610391493136;2346.7183937927557;7990.640421181002;8031.799205019921;8031.839363212762;8046.034475862875;8048.557329346883;4816.470188279286;4881.096997055521;4919.385076865392;4920.8031678732805;4921.409430868319;3034.1959380764115;3078.184281165493;3115.2679120406688;3207.3585282943504;3222.0817067135754;932.3473568502008;934.4533447932968;971.5288085278635;974.7173319737268;996.7757254617726;11165.888341116648;11196.66410007701;11207.21549491536;11215.607453739161;11237.775244495064;4395.099004704028;4414.205443020287;4497.707649002804;4506.549345065533;4512.864614061584;9537.427754334762;9609.615615375447;9630.085141911508;9640.325177237526;9650.806983860284;4939.333190019373;4971.1549036663855;4979.726115063706;5001.149804533238;5002.59979201663;4517.841875534341;4523.864284071417;4527;4528.139653465831;4532.206863798822;3502.0894567412656;3560.3413368526903;3748.325301445766;3771.905702357463;3814.5231846019246;1240.348816871132;1243.657994051643;1251.8873301402734;1257.076049103908;1259.8362212912264;1069.534752382716;1090.5583238788304;1091.1598069486452;1207.9214851034656;1335.465813674538;7174.497785154989;7196.748113815991;7221.241769614115;7287.70849166038;7291.125064992235;1095.4632230207142;1097.3415950429837;1107.2194103157256;1118.8377685235596;1132.1621999720312;5879.2944846618675;5987.79042733511;5988.790392336247;5993.670348130895;6002.54980876436;9680.886698029817;9780.070893265129;9854.16239619626;9933.403995760278;10025.899741002642;9838.36050656705;9849.704508864745;9854.11312981835;9860.950695246478;9881.80236395268;7422.814429639302;7602.619869006528;7679.3856491481665;7688;7706.38348932084;7245.492815503075;7246.275372462712;7271.527350722186;7279;7290.890636640349;8661.566921653766;8714.041455440023;8816.603252853765;8820.029796722227;8985.820283594161;8333.083360830426;8892.199702026848;9048.728538143867;9064.50145242018;9071.138241867013;6225.470834979077;7073.575585464889;7132.358087772125;7193.136823581203;7198.49610527279;6811.795646130624;7231.63841807918;7406.037215161994;7414;7417.443691723251;6835.692393842389;6848.527566573211;6866.141732283465;6875.07186529812;6906.723731050702;6962.477814164059;7033.085698859116;7053.365197132282;7078.0444639975;7092.397146242627;6880.862382752417;6881.243063263138;6928.722851086101;6932.930670693228;6997.965010174917;6564.901526477011;6613.437857782143;6619.371159739817;6622.70197841108;6627.933720662924;6585.341465853377;6603.075569420189;6621.768238111643;6636.668166591748;6647.767328143492 23:22:07 INFO - PROCESS | 3871 | |4;prototype.html;335.63751148759343;348.90056333944824;350.2172644140346;358.3728475168455;359.91362073102465;5907.291125064988;5923.229980102586;6086.665233412161;6091.939080609192;6131.938680613192;5836.824895253149;5888.205092312536;5909;5921.20063791388;6020.187274717911;4631.698939568934;4638.211504044304;4638.860834174963;4645.396098507189;4645.628349732014;4422.734635921839;4499.212637788391;4546.431696037996;4613.1926912790295;4635.751660444682;4587.15137699525;4612.8385506507275;4616.215243408612;4626.8380606678775;4635.559621835921;4618.35343051973;4619.514950930155;4623.445186577632;4625.676202665814;4627;4020.5376381716183;4026.4966879140106;4032.6572241359227;4034.838606455738;4042.9191416171807;5633.6619802811965;5725.656460612335;5726.885462290731;5732.684702341369;5741.770329186827;5355.6251062425645;5366.114591092465;5374.086405311106;5375.3012108425655;5382.91925621116;6138.263408391022;6394.328595497453;6400.775972840928;6403.199600049994;6407.167068281094;4338;4376.6936314458;4416.734995900256;4420.690551661352;4423.093265880519;6474.1907261592305;6543.509236807211;6567.573107747981;6579.374959378852;6595.109660195908;4424.380586717862;4460.620847227957;4462.241418958784;4475.037866858641;4477.306017567283;4428.933565996513;4520.141173177086;4524.864254072318;4529.207388706963;4551.977240113778;5202.115640341151;5228.424873263938;5234.92147617786;5237.3453318335205;5239.768654366221;6355.872882542416;6362.968185159137;6367.649779262092;6370.522210834206;6371.585846919936;1669.7996240451223;1690.6111594333372;1690.797104347486;1690.9492715218564;1691.408007197471;1090.111559079348;1110.3615421132881;1114.2924243105685;1133.863936327646;1143.9485223164977;6100.328963813977;6105.175801266861;6107.8473038173515;6109.84725381869;6125.019996800491;6589.472842172615;6632.1046658701425;6645.3022432643875;6647.501437392215;6659.534902321481;5948.702564871739;6097.207363042865;6151.231096112986;6172.69136543171;6173.59871608353;3571.1786289153642;3589.3180295744246;3592.2276710507367;3596.7122630189524;3600.243948770735;6855.485838562127;6862.142232220973;6873.278305777922;6875.449964002968;6877.3810357068105;6626.602403855688;6783.287754785676;6803.149606299213;6817.284185160487;6820.658967051628;6855.451563874978;6858.931410685929;6866.759663411756;6868.553544019623;6874.278200788845;6447.258565264867;6621.304763000008;6624.8343791405605;6626.370494802986;6698.933010669831;6461.967690161519;6628.602283862983;6647.135872336758;6655.900161497679;6658.167729033871;6936.965315173392;6952.756653517103;6953.826154346182;6958.338957799001;6968.825779355557;4404.691671582958;4525.63794896414;4693.601043911306;4697.318888761042;4699.647526435463;6617.933820661732;6640.667966601747;6667.766628167991;6670.533062685566;6676.632785196861;6492.837679058061;6496.415322620986;6506.154199953976;6506.3818937200895;6508.837279068061;6337.841553961188;6428.903566446414;6456.774012909714;6467.967660161669;6471.352864713491;6351.523635727432;6355.078513615592;6355.491560675227;6357.650329231752;6360.586561873463;6499.38255865692;6500.804975850732;6503.44720698727;6503.479721622353;6503.577267477599;6216.533759968111;6323.588966717149;6335.936640633535;6378.266499352449;6422.678866056585 23:22:07 INFO - PROCESS | 3871 | |5;yui.html;685.2325395556977;696.5437638346884;733.6295170938675;777.4868586732756;854.406187699549;12970.805437918427;13142;13145.342732863342;13146.474141034347;13152.210867347965;12271.263724176555;12697.61907142785;12788.616341509747;14189.929050354734;14239.501617443391;805.4321703199245;821.2690705272313;822.1901427094307;822.2271065198725;822.5311572403732;804.0311424733212;804.2279411764713;809.1382677448528;812.9634166462494;815.9877601835977;858.2233079063458;860.4880096342666;862.3877047296427;863.0204717645455;863.3869952333819;856.575994882531;858.8497013022759;861.4788053227769;864.6282098697558;865.0182043380777;636.8821767972894;636.9681515924232;637.1939496536885;637.6333608175318;637.6365471681144;12952.481900724055;13155.408006639724;13239.404226809816;13245.139065960682;13270.336483175803;12714.173578717353;13009.544665936646;13095.672608184776;13423.328833558284;13633.931830340785;10503.159747220205;10576.576936922515;10714.464276786208;10738.140948724084;10749.570017199303;3563.5367402237803;3641;3644.3622366086092;3681.687056600192;3777.2823163598828;47582.762086189345;47819.76090119562;47826;47911.28133078007;48135.75932120352;9555.18780903631;9670.951645241728;9773.12041916231;9773.706788796348;9917.553710082919;17619.735703964452;17803.554911127325;17846.821531784775;17917.641647166984;19042.42872713821;7163.67763450646;7271.236520165412;7316.45126615506;7410.147832999166;7428.85142297151;4021.3565829467143;4035.071933455322;4153.397757325171;4166.645835103989;4227.87316380509;3062.908112756621;3087.845607719605;3088.5212792016823;3101.379724055198;3102.860371283298;530.1755769778032;548.9011977843946;549.9917501237485;580.1384943359109;582.5019608234983;509.5668681620593;548.410458756838;562.4768964862717;579;607.1894021481372;7786.922130778733;8324.6670133194;8424.873626895602;8532.829343413097;8582;557.9637323573954;620.6896551724138;628.2304177382761;642.5662677692538;644.7936660268668;3878.9612103879163;3980.5621381647998;4058.289799285113;4174.728642638219;4258.233517966796;58658;61175;61475.692621536604;61493.38506614966;61579.38420615737;45174;48601.513984859695;48818.26772598414;51506;53014.73492632512;35939.820300898326;44288.55711442844;45036.54963450389;45043.324350134775;45141.097178056254;7749.806254843674;8006.479578827358;8397.293450850215;8482.575871206538;8489.660413583635;33367.83316083404;33609.83195084009;33773.32453350969;33959.320813583094;34000.489992650626;45268.54731452643;45425.318620221384;45562.08875822531;46135.76932115318;46343.53656463527;10300.124489418184;10370.533326000197;10580.947095264475;10657.946710266398;10705.571777128827;11697.707557311136;11748.118891083031;11753.764924701287;11866;11895.226810257305;10912.127029837753;11073.335599864035;11120.555177792798;11449.198556101326;11489.425528723697;9993.300468967103;10490.213234007328;10497.842532362174;10524.842127367943;10893.455327233765;9525.952370238381;9530.904690953003;10438.582456701646;10546.314489558154;10552.894471055499;8607.483989203214;8733.825323493367;8813.118688131135;8900.5994730236;8985.730428087169;8443.746687599381;8701.695440659547;8762.824743505222;9128.406653567497;9353.625854965725 23:22:07 INFO - PROCESS | 3871 | __end_tp_report 23:22:07 INFO - PROCESS | 3871 | __start_cc_report 23:22:07 INFO - PROCESS | 3871 | _x_x_mozilla_cycle_collect,721 23:22:07 INFO - PROCESS | 3871 | __end_cc_report 23:22:07 INFO - PROCESS | 3871 | __startTimestamp1453620127569__endTimestamp 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | ------- Summary: start ------- 23:22:07 INFO - PROCESS | 3871 | Number of tests: 6 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#0] dojo.html Cycles:165 Average:5082.38 Median:5281.16 stddev:659.99 (12.5%) stddev-sans-first:643.38 23:22:07 INFO - PROCESS | 3871 | Values: 3097.7 3114.9 3156.7 3168.1 3181.7 5014.8 5098.9 5131.4 5135.2 5170.9 4965.6 4997.6 5026.1 5037.2 5154.0 4684.8 4694.9 4707.4 4748.3 4798.5 418.0 4577.6 4661.4 4698.1 4777.5 4617.0 4723.1 4765.4 4817.0 4821.4 4721.6 4729.6 4734.6 4739.7 4768.0 4548.4 4615.2 4706.2 4716.5 4774.7 4942.1 4962.7 4981.4 4981.8 5034.9 5471.8 5486.8 5502.5 5505.7 5537.2 5355.7 5413.8 5429.9 5528.9 5533.6 5083.7 5125.6 5130.0 5131.1 5146.5 5594.4 5598.0 5601.1 5639.3 5647.8 5243.2 5315.8 5319.3 5371.0 5423.9 5411.7 5519.0 5522.8 5530.7 5571.9 5437.8 5450.5 5482.1 5500.5 5512.4 5339.4 5399.2 5503.6 5508.8 5558.2 4260.3 4262.6 4267.1 4297.2 4304.6 3819.0 3825.1 3827.0 3842.8 3844.2 4995.7 5044.0 5080.3 5095.4 5175.8 5477.3 5497.1 5499.5 5505.3 5535.8 5084.6 5085.2 5089.0 5100.4 5133.3 4630.6 4696.4 4703.9 4708.1 4759.5 5682.2 5693.7 5709.5 5710.1 5717.1 5503.3 5519.4 5526.7 5527.7 5550.9 5512.6 5558.1 5682.1 5711.2 5726.9 5501.6 5526.4 5536.3 5551.6 5555.8 5296.3 5623.7 5627.3 5628.1 5630.6 5329.9 5400.5 5436.7 5442.9 5483.2 5407.1 5409.9 5411.7 5412.9 5415.6 5152.4 5233.2 5325.1 5325.3 5375.5 5404.2 5411.9 5448.3 5449.6 5468.9 5243.8 5250.9 5251.2 5260.3 5281.2 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#1] ext.html Cycles:180 Average:46432.91 Median:36789.50 stddev:77387.31 (210.4%) stddev-sans-first:77527.53 23:22:07 INFO - PROCESS | 3871 | Values: 494.9 521.1 526.2 527.7 537.7 28591.3 29229.3 36569.6 36985.4 37142.4 40133.0 40539.6 40567.4 40573.0 40576.6 7306.1 8434.2 8650.0 8670.1 8676.1 7402.6 7512.1 7520.6 7523.6 9998.5 9999.9 10074.0 10078.2 10079.6 10085.8 9908.2 9976.2 9978.0 9985.9 9995.2 9980.5 10073.1 10101.6 10107.0 10134.6 36405.0 36761.0 36818.0 36874.4 40047.2 3173.7 3203.7 3298.9 3618.8 4157.1 26723.2 26903.5 29706.3 29729.0 30131.4 3850.2 3855.7 3876.8 3891.3 3937.6 265866.0 266356.0 266371.0 267409.0 269277.0 52880.7 60738.7 60968.0 61180.1 61229.7 48579.0 71598.0 72675.6 72701.3 72950.6 15207.9 15317.1 15394.6 15508.6 15509.6 11465.5 11506.6 11513.7 11565.7 11641.5 20163.5 20347.6 20351.8 20383.9 20409.5 7823.3 7900.8 8025.2 8039.0 8117.0 943.9 973.9 1026.1 1042.4 1052.3 28554.0 29036.0 29507.0 29571.0 30865.4 999.0 1013.4 1058.5 1062.6 1093.3 13753.0 13894.5 14117.2 14171.2 14202.4 366843.0 372066.0 372145.0 372959.0 373420.0 48587.3 49572.8 53579.0 54198.7 54375.5 1315.7 1352.7 1365.5 1369.5 1377.2 26941.2 27114.6 27617.9 27772.7 27807.4 42231.8 43372.3 48676.8 48817.5 50298.7 226421.0 227326.0 228172.0 228471.0 229210.0 38588.0 39000.0 39173.0 39184.4 39256.0 41768.6 42249.8 42658.1 42760.0 45958.5 37860.8 38229.6 38380.6 38613.2 39489.4 33977.3 37969.0 38821.6 39492.8 43166.0 35266.5 35545.8 35684.3 35808.5 35886.5 31476.2 33190.3 33419.7 33843.3 33879.7 26360.6 26941.2 27115.5 27224.7 27266.5 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#2] jquery.html Cycles:180 Average:26617.11 Median:5100.31 stddev:84895.00 (1664.5%) stddev-sans-first:85110.28 23:22:07 INFO - PROCESS | 3871 | Values: 370.2 373.0 375.7 377.1 377.5 13862.9 15373.5 15569.5 17749.6 18556.3 10937.4 11211.0 11213.4 11231.4 15249.2 3802.4 4955.5 5096.4 5104.2 5105.9 3876.8 5432.4 5643.7 5645.1 5651.2 5198.1 5394.3 5399.6 5600.0 5626.3 5321.4 5322.7 5336.7 5679.6 5998.4 5355.5 5360.7 5363.0 5363.8 5363.9 18923.0 19441.7 19897.7 20035.9 20429.6 2012.0 2083.3 2127.7 2275.5 2428.7 9599.4 9604.6 10030.3 11893.3 12517.9 1837.6 1851.0 1886.1 1892.4 1898.1 48584.8 49513.5 54593.5 56820.0 57200.7 9761.7 10214.2 10343.3 10356.7 10424.7 13439.7 13488.1 13510.8 13510.9 13516.3 7764.5 7817.5 7828.1 7854.7 7858.4 7503.4 7551.5 7552.2 7579.0 7587.8 4169.3 4318.3 4367.9 4519.8 4584.1 1792.2 1835.6 1840.3 1851.1 1862.4 887.9 966.8 976.6 978.4 1017.3 13178.9 14439.4 15352.4 16835.2 16944.2 894.0 912.9 969.2 987.4 1003.5 8092.9 9119.5 9471.0 9499.9 9587.0 512802.0 515751.0 519485.0 522432.0 528836.0 66226.3 68801.0 69979.7 71229.0 71272.6 1119.2 1125.8 1127.9 1154.6 1161.2 14781.4 15034.8 15054.8 15070.0 15180.2 31869.4 32003.4 32590.3 33259.7 33705.8 41955.0 42550.9 42803.6 43826.6 44307.6 4281.9 7115.2 7240.8 7456.7 7480.2 10170.3 10675.0 11007.6 11031.1 11268.3 8788.6 9375.2 9626.7 9769.3 9812.2 7544.7 8913.5 9605.0 9744.2 9978.0 9282.6 9316.6 9356.6 9427.0 9533.1 7079.4 7163.4 7270.1 7282.9 7361.4 9082.2 9562.8 9618.2 9680.5 9760.4 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#3] mootools.html Cycles:180 Average:5590.12 Median:6616.40 stddev:2926.10 (44.2%) stddev-sans-first:2916.59 23:22:07 INFO - PROCESS | 3871 | Values: 1306.0 1456.9 1479.3 1646.7 1797.8 6911.1 7691.9 7858.6 7869.2 7877.4 7653.7 7833.4 7841.1 7854.4 7864.3 1982.7 2049.6 2277.2 2295.9 2325.2 2330.7 2336.2 2345.0 2352.7 2352.7 2239.8 2298.4 2301.1 2303.3 2306.8 2288.4 2311.8 2350.0 2362.5 2364.2 2315.3 2318.8 2333.8 2337.7 2346.7 7990.6 8031.8 8031.8 8046.0 8048.6 4816.5 4881.1 4919.4 4920.8 4921.4 3034.2 3078.2 3115.3 3207.4 3222.1 932.3 934.5 971.5 974.7 996.8 11165.9 11196.7 11207.2 11215.6 11237.8 4395.1 4414.2 4497.7 4506.5 4512.9 9537.4 9609.6 9630.1 9640.3 9650.8 4939.3 4971.2 4979.7 5001.1 5002.6 4517.8 4523.9 4527.0 4528.1 4532.2 3502.1 3560.3 3748.3 3771.9 3814.5 1240.3 1243.7 1251.9 1257.1 1259.8 1069.5 1090.6 1091.2 1207.9 1335.5 7174.5 7196.7 7221.2 7287.7 7291.1 1095.5 1097.3 1107.2 1118.8 1132.2 5879.3 5987.8 5988.8 5993.7 6002.5 9680.9 9780.1 9854.2 9933.4 10025.9 9838.4 9849.7 9854.1 9861.0 9881.8 7422.8 7602.6 7679.4 7688.0 7706.4 7245.5 7246.3 7271.5 7279.0 7290.9 8661.6 8714.0 8816.6 8820.0 8985.8 8333.1 8892.2 9048.7 9064.5 9071.1 6225.5 7073.6 7132.4 7193.1 7198.5 6811.8 7231.6 7406.0 7414.0 7417.4 6835.7 6848.5 6866.1 6875.1 6906.7 6962.5 7033.1 7053.4 7078.0 7092.4 6880.9 6881.2 6928.7 6932.9 6998.0 6564.9 6613.4 6619.4 6622.7 6627.9 6585.3 6603.1 6621.8 6636.7 6647.8 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#4] prototype.html Cycles:180 Average:5361.07 Median:6098.77 stddev:1616.00 (26.5%) stddev-sans-first:1575.90 23:22:07 INFO - PROCESS | 3871 | Values: 335.6 348.9 350.2 358.4 359.9 5907.3 5923.2 6086.7 6091.9 6131.9 5836.8 5888.2 5909.0 5921.2 6020.2 4631.7 4638.2 4638.9 4645.4 4645.6 4422.7 4499.2 4546.4 4613.2 4635.8 4587.2 4612.8 4616.2 4626.8 4635.6 4618.4 4619.5 4623.4 4625.7 4627.0 4020.5 4026.5 4032.7 4034.8 4042.9 5633.7 5725.7 5726.9 5732.7 5741.8 5355.6 5366.1 5374.1 5375.3 5382.9 6138.3 6394.3 6400.8 6403.2 6407.2 4338.0 4376.7 4416.7 4420.7 4423.1 6474.2 6543.5 6567.6 6579.4 6595.1 4424.4 4460.6 4462.2 4475.0 4477.3 4428.9 4520.1 4524.9 4529.2 4552.0 5202.1 5228.4 5234.9 5237.3 5239.8 6355.9 6363.0 6367.6 6370.5 6371.6 1669.8 1690.6 1690.8 1690.9 1691.4 1090.1 1110.4 1114.3 1133.9 1143.9 6100.3 6105.2 6107.8 6109.8 6125.0 6589.5 6632.1 6645.3 6647.5 6659.5 5948.7 6097.2 6151.2 6172.7 6173.6 3571.2 3589.3 3592.2 3596.7 3600.2 6855.5 6862.1 6873.3 6875.4 6877.4 6626.6 6783.3 6803.1 6817.3 6820.7 6855.5 6858.9 6866.8 6868.6 6874.3 6447.3 6621.3 6624.8 6626.4 6698.9 6462.0 6628.6 6647.1 6655.9 6658.2 6937.0 6952.8 6953.8 6958.3 6968.8 4404.7 4525.6 4693.6 4697.3 4699.6 6617.9 6640.7 6667.8 6670.5 6676.6 6492.8 6496.4 6506.2 6506.4 6508.8 6337.8 6428.9 6456.8 6468.0 6471.4 6351.5 6355.1 6355.5 6357.7 6360.6 6499.4 6500.8 6503.4 6503.5 6503.6 6216.5 6323.6 6335.9 6378.3 6422.7 23:22:07 INFO - PROCESS | 3871 | 23:22:07 INFO - PROCESS | 3871 | [#5] yui.html Cycles:180 Average:13582.52 Median:47868.64 stddev:15972.18 (33.4%) stddev-sans-first:15987.62 23:22:07 INFO - PROCESS | 3871 | Values: 685.2 696.5 733.6 777.5 854.4 12970.8 13142.0 13145.3 13146.5 13152.2 12271.3 12697.6 12788.6 14189.9 14239.5 805.4 821.3 822.2 822.2 822.5 804.0 804.2 809.1 813.0 816.0 858.2 860.5 862.4 863.0 863.4 856.6 858.8 861.5 864.6 865.0 636.9 637.0 637.2 637.6 637.6 12952.5 13155.4 13239.4 13245.1 13270.3 12714.2 13009.5 13095.7 13423.3 13633.9 10503.2 10576.6 10714.5 10738.1 10749.6 3563.5 3641.0 3644.4 3681.7 3777.3 47582.8 47819.8 47826.0 47911.3 48135.8 9555.2 9671.0 9773.1 9773.7 9917.6 17619.7 17803.6 17846.8 17917.6 19042.4 7163.7 7271.2 7316.5 7410.1 7428.9 4021.4 4035.1 4153.4 4166.6 4227.9 3062.9 3087.8 3088.5 3101.4 3102.9 530.2 548.9 550.0 580.1 582.5 509.6 548.4 562.5 579.0 607.2 7786.9 8324.7 8424.9 8532.8 8582.0 558.0 620.7 628.2 642.6 644.8 3879.0 3980.6 4058.3 4174.7 4258.2 58658.0 61175.0 61475.7 61493.4 61579.4 45174.0 48601.5 48818.3 51506.0 53014.7 35939.8 44288.6 45036.5 45043.3 45141.1 7749.8 8006.5 8397.3 8482.6 8489.7 33367.8 33609.8 33773.3 33959.3 34000.5 45268.5 45425.3 45562.1 46135.8 46343.5 10300.1 10370.5 10580.9 10657.9 10705.6 11697.7 11748.1 11753.8 11866.0 11895.2 10912.1 11073.3 11120.6 11449.2 11489.4 9993.3 10490.2 10497.8 10524.8 10893.5 9526.0 9530.9 10438.6 10546.3 10552.9 8607.5 8733.8 8813.1 8900.6 8985.7 8443.7 8701.7 8762.8 9128.4 9353.6 23:22:07 INFO - PROCESS | 3871 | -------- Summary: end -------- 23:22:07 INFO - PROCESS | 3871 | 23:22:08 INFO - TEST-INFO | 3871: exit 0 23:22:08 INFO - TEST-OK | dromaeo_css | took 1112587ms 23:22:08 INFO - TEST-START | kraken 23:22:08 INFO - operating with platform_type : linux_ 23:22:08 INFO - Initialising browser for kraken test... 23:22:08 INFO - TEST-INFO | started process 4078 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpauRLqv/profile http://localhost:57541/getInfo.html) 23:22:12 INFO - PROCESS | 4078 | __metrics Screen width/height:1600/1200 23:22:12 INFO - PROCESS | 4078 | colorDepth:24 23:22:12 INFO - PROCESS | 4078 | Browser inner width/height: 1024/697 23:22:12 INFO - PROCESS | 4078 | __metrics 23:22:13 INFO - PROCESS | 4078 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:22:13 INFO - PROCESS | 4078 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:14 INFO - TEST-INFO | 4078: exit 0 23:22:14 INFO - Browser initialized. 23:22:14 INFO - Running cycle 1/1 for kraken test... 23:22:14 INFO - TEST-INFO | started process 4161 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpauRLqv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:25 INFO - PROCESS | 4161 | RSS: Main: 147525632 23:22:25 INFO - PROCESS | 4161 | 23:22:28 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57541/tests/kraken/driver.html?testName=audio-beat-detection) 23:22:28 INFO - PROCESS | 4161 | RSS: Main: 188637184 23:22:28 INFO - PROCESS | 4161 | 23:22:31 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57541/tests/kraken/driver.html?testName=audio-dft) 23:22:32 INFO - PROCESS | 4161 | RSS: Main: 177278976 23:22:32 INFO - PROCESS | 4161 | 23:22:34 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57541/tests/kraken/driver.html?testName=audio-fft) 23:22:35 INFO - PROCESS | 4161 | RSS: Main: 163856384 23:22:35 INFO - PROCESS | 4161 | 23:22:37 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57541/tests/kraken/driver.html?testName=audio-oscillator) 23:22:38 INFO - PROCESS | 4161 | RSS: Main: 166318080 23:22:38 INFO - PROCESS | 4161 | 23:22:40 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:22:40 INFO - PROCESS | 4161 | RSS: Main: 167182336 23:22:40 INFO - PROCESS | 4161 | 23:22:43 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57541/tests/kraken/driver.html?testName=imaging-darkroom) 23:22:44 INFO - PROCESS | 4161 | RSS: Main: 167555072 23:22:44 INFO - PROCESS | 4161 | 23:22:47 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57541/tests/kraken/driver.html?testName=imaging-desaturate) 23:22:48 INFO - PROCESS | 4161 | RSS: Main: 167329792 23:22:48 INFO - PROCESS | 4161 | 23:22:51 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57541/tests/kraken/driver.html?testName=json-parse-financial) 23:22:51 INFO - PROCESS | 4161 | RSS: Main: 168771584 23:22:51 INFO - PROCESS | 4161 | 23:22:53 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:53 INFO - PROCESS | 4161 | RSS: Main: 178692096 23:22:53 INFO - PROCESS | 4161 | 23:22:55 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:56 INFO - PROCESS | 4161 | RSS: Main: 176967680 23:22:56 INFO - PROCESS | 4161 | 23:22:58 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:22:58 INFO - PROCESS | 4161 | RSS: Main: 190582784 23:22:58 INFO - PROCESS | 4161 | 23:23:01 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:23:01 INFO - PROCESS | 4161 | RSS: Main: 196395008 23:23:01 INFO - PROCESS | 4161 | 23:23:04 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:23:04 INFO - PROCESS | 4161 | RSS: Main: 194572288 23:23:04 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:57541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57541/tests/kraken/driver.html?testName=ai-astar) 23:23:06 INFO - PROCESS | 4161 | RSS: Main: 254144512 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | __start_tp_report 23:23:06 INFO - PROCESS | 4161 | _x_x_mozilla_page_load 23:23:06 INFO - PROCESS | 4161 | _x_x_mozilla_page_load_details 23:23:06 INFO - PROCESS | 4161 | |i|pagename|runs| 23:23:06 INFO - PROCESS | 4161 | |0;ai-astar;112;111;106;111;109;111;110;111;105;110 23:23:06 INFO - PROCESS | 4161 | |1;audio-beat-detection;145;132;148;172;131;148;151;138;176;130 23:23:06 INFO - PROCESS | 4161 | |2;audio-dft;162;162;161;160;159;163;162;161;163;161 23:23:06 INFO - PROCESS | 4161 | |3;audio-fft;76;73;101;97;76;73;75;115;96;72 23:23:06 INFO - PROCESS | 4161 | |4;audio-oscillator;95;97;137;95;97;96;145;95;96;138 23:23:06 INFO - PROCESS | 4161 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 23:23:06 INFO - PROCESS | 4161 | |6;imaging-darkroom;146;146;145;145;146;145;145;145;146;145 23:23:06 INFO - PROCESS | 4161 | |7;imaging-desaturate;96;96;97;97;96;96;96;96;97;96 23:23:06 INFO - PROCESS | 4161 | |8;json-parse-financial;57;56;56;57;57;56;59;57;58;54 23:23:06 INFO - PROCESS | 4161 | |9;json-stringify-tinderbox;68;68;68;68;67;69;68;68;68;69 23:23:06 INFO - PROCESS | 4161 | |10;stanford-crypto-aes;80;82;83;82;82;82;88;89;81;82 23:23:06 INFO - PROCESS | 4161 | |11;stanford-crypto-ccm;124;131;115;116;120;116;130;117;124;113 23:23:06 INFO - PROCESS | 4161 | |12;stanford-crypto-pbkdf2;142;129;140;145;142;130;139;140;138;140 23:23:06 INFO - PROCESS | 4161 | |13;stanford-crypto-sha256-iterative;69;66;68;66;67;73;66;65;64;65 23:23:06 INFO - PROCESS | 4161 | __end_tp_report 23:23:06 INFO - PROCESS | 4161 | __start_cc_report 23:23:06 INFO - PROCESS | 4161 | _x_x_mozilla_cycle_collect,958 23:23:06 INFO - PROCESS | 4161 | __end_cc_report 23:23:06 INFO - PROCESS | 4161 | __startTimestamp1453620186859__endTimestamp 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | ------- Summary: start ------- 23:23:06 INFO - PROCESS | 4161 | Number of tests: 14 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.32 (2.1%) stddev-sans-first:2.29 23:23:06 INFO - PROCESS | 4161 | Values: 112.0 111.0 106.0 111.0 109.0 111.0 110.0 111.0 105.0 110.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:148.00 stddev:16.12 (10.9%) stddev-sans-first:17.08 23:23:06 INFO - PROCESS | 4161 | Values: 145.0 132.0 148.0 172.0 131.0 148.0 151.0 138.0 176.0 130.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 23:23:06 INFO - PROCESS | 4161 | Values: 162.0 162.0 161.0 160.0 159.0 163.0 162.0 161.0 163.0 161.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.50 stddev:15.41 (20.4%) stddev-sans-first:15.97 23:23:06 INFO - PROCESS | 4161 | Values: 76.0 73.0 101.0 97.0 76.0 73.0 75.0 115.0 96.0 72.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:21.43 (22.4%) stddev-sans-first:22.12 23:23:06 INFO - PROCESS | 4161 | Values: 95.0 97.0 137.0 95.0 97.0 96.0 145.0 95.0 96.0 138.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:23:06 INFO - PROCESS | 4161 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:23:06 INFO - PROCESS | 4161 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:23:06 INFO - PROCESS | 4161 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.41 23:23:06 INFO - PROCESS | 4161 | Values: 57.0 56.0 56.0 57.0 57.0 56.0 59.0 57.0 58.0 54.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 23:23:06 INFO - PROCESS | 4161 | Values: 68.0 68.0 68.0 68.0 67.0 69.0 68.0 68.0 68.0 69.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:2.96 (3.6%) stddev-sans-first:2.92 23:23:06 INFO - PROCESS | 4161 | Values: 80.0 82.0 83.0 82.0 82.0 82.0 88.0 89.0 81.0 82.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:122.00 stddev:6.36 (5.2%) stddev-sans-first:6.63 23:23:06 INFO - PROCESS | 4161 | Values: 124.0 131.0 115.0 116.0 120.0 116.0 130.0 117.0 124.0 113.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:140.00 stddev:5.13 (3.7%) stddev-sans-first:5.28 23:23:06 INFO - PROCESS | 4161 | Values: 142.0 129.0 140.0 145.0 142.0 130.0 139.0 140.0 138.0 140.0 23:23:06 INFO - PROCESS | 4161 | 23:23:06 INFO - PROCESS | 4161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:2.60 (3.9%) stddev-sans-first:2.65 23:23:06 INFO - PROCESS | 4161 | Values: 69.0 66.0 68.0 66.0 67.0 73.0 66.0 65.0 64.0 65.0 23:23:06 INFO - PROCESS | 4161 | -------- Summary: end -------- 23:23:06 INFO - PROCESS | 4161 | 23:23:07 INFO - TEST-INFO | 4161: exit 0 23:23:07 INFO - TEST-OK | kraken | took 59495ms 23:23:07 INFO - TEST-START | v8_7 23:23:07 INFO - operating with platform_type : linux_ 23:23:07 INFO - Initialising browser for v8_7 test... 23:23:07 INFO - TEST-INFO | started process 4410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQCdFen/profile http://localhost:57541/getInfo.html) 23:23:12 INFO - PROCESS | 4410 | __metrics Screen width/height:1600/1200 23:23:12 INFO - PROCESS | 4410 | colorDepth:24 23:23:12 INFO - PROCESS | 4410 | Browser inner width/height: 1024/697 23:23:12 INFO - PROCESS | 4410 | __metrics 23:23:12 INFO - PROCESS | 4410 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:23:12 INFO - PROCESS | 4410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:23:13 INFO - TEST-INFO | 4410: exit 0 23:23:13 INFO - Browser initialized. 23:23:13 INFO - Running cycle 1/1 for v8_7 test... 23:23:13 INFO - TEST-INFO | started process 4493 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQCdFen/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:25 INFO - PROCESS | 4493 | RSS: Main: 149442560 23:23:25 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | Cycle 1(1): loaded http://localhost:57541/tests/v8_7/run.html (next: http://localhost:57541/tests/v8_7/run.html) 23:23:47 INFO - PROCESS | 4493 | RSS: Main: 544481280 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | __start_tp_report 23:23:47 INFO - PROCESS | 4493 | _x_x_mozilla_page_load 23:23:47 INFO - PROCESS | 4493 | _x_x_mozilla_page_load_details 23:23:47 INFO - PROCESS | 4493 | |i|pagename|runs| 23:23:47 INFO - PROCESS | 4493 | |0;Richards;167.22408026755852 23:23:47 INFO - PROCESS | 4493 | |1;DeltaBlue;189.0359168241966 23:23:47 INFO - PROCESS | 4493 | |2;Encrypt;282.16704288939053 23:23:47 INFO - PROCESS | 4493 | |3;Decrypt;5263.1578947368425 23:23:47 INFO - PROCESS | 4493 | |4;RayTrace;1129.9435028248588 23:23:47 INFO - PROCESS | 4493 | |5;Earley;823.0452674897119 23:23:47 INFO - PROCESS | 4493 | |6;Boyer;12243.90243902439 23:23:47 INFO - PROCESS | 4493 | |7;RegExp;43106.382978723406 23:23:47 INFO - PROCESS | 4493 | |8;Splay;586.1664712778429 23:23:47 INFO - PROCESS | 4493 | |9;NavierStokes;4826.923076923077 23:23:47 INFO - PROCESS | 4493 | __end_tp_report 23:23:47 INFO - PROCESS | 4493 | __startTimestamp1453620227720__endTimestamp 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | ------- Summary: start ------- 23:23:47 INFO - PROCESS | 4493 | Number of tests: 10 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 167.2 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#1] DeltaBlue Cycles:1 Average:189.04 Median:189.04 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 189.0 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#2] Encrypt Cycles:1 Average:282.17 Median:282.17 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 282.2 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 5263.2 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#4] RayTrace Cycles:1 Average:1129.94 Median:1129.94 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 1129.9 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#5] Earley Cycles:1 Average:823.05 Median:823.05 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 823.0 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 12243.9 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#7] RegExp Cycles:1 Average:43106.38 Median:43106.38 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 43106.4 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#8] Splay Cycles:1 Average:586.17 Median:586.17 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 586.2 23:23:47 INFO - PROCESS | 4493 | 23:23:47 INFO - PROCESS | 4493 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 23:23:47 INFO - PROCESS | 4493 | Values: 4826.9 23:23:47 INFO - PROCESS | 4493 | -------- Summary: end -------- 23:23:47 INFO - PROCESS | 4493 | 23:23:48 INFO - TEST-INFO | 4493: exit 0 23:23:48 INFO - TEST-OK | v8_7 | took 40761ms 23:23:48 INFO - SUITE-END | took 1212s 23:23:48 INFO - Completed test suite (00:20:13) 23:23:48 INFO - Working with test: dromaeo_css 23:23:48 INFO - Generating results file: dromaeo_css 23:23:48 INFO - Working with test: kraken 23:23:48 INFO - Generating results file: kraken 23:23:48 INFO - javascript benchmark 23:23:48 INFO - Working with test: v8_7 23:23:48 INFO - Generating results file: v8_7 23:23:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:23:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:23:48 INFO - process_Request line: dromaeo_css 6853.83 graph.html#tests=[[72,201,35]] 23:23:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:23:48 INFO - process_Request line: kraken 1497.20 graph.html#tests=[[232,201,35]] 23:23:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:23:48 INFO - process_Request line: v8_7 19894.19 graph.html#tests=[[230,201,35]] 23:23:48 INFO - RETURN: dromaeo_css: 6853.83 23:23:48 INFO - RETURN: kraken: 1497.20 23:23:48 INFO - RETURN: v8_7: 19894.19 23:23:48 INFO - javascript benchmark 23:23:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3097.674744151864, 3114.922126946825, 3156.6843315668434, 3168.112928380053, 3181.681831816818, 5014.849554513361, 5098.872528186797, 5131.358580177473, 5135.152699804527, 5170.922436163456, 4965.62757793166, 4997.600191984641, 5026.120428924933, 5037.168867136918, 5153.974230128844, 4684.812607495696, 4694.906101877978, 4707.38803955487, 4748.335233067356, 4798.47216806151, 417.96920352561125, 4577.588017078462, 4661.394018777554, 4698.107359601682, 4777.450593181794, 4616.976915115437, 4723.07899959508, 4765.380500534943, 4816.988432429212, 4821.445533763592, 4721.5750582447745, 4729.574338309534, 4734.644901632391, 4739.715617062987, 4767.974885399621, 4548.385967894358, 4615.215413379734, 4706.247000479907, 4716.457607375161, 4774.665773395864, 4942.061008408391, 4962.702237865704, 4981.37732783402, 4981.775820088104, 5034.899302013976, 5471.8084867029465, 5486.835394938118, 5502.477264659851, 5505.6696598204235, 5537.169424586345, 5355.678659280456, 5413.810516631899, 5429.864253393696, 5528.889422211573, 5533.557315414757, 5083.720395378253, 5125.64120511568, 5129.974350128263, 5131.050755610224, 5146.536811686966, 5594.412586678422, 5598.048331783607, 5601.103823388238, 5639.266895303666, 5647.774089036392, 5243.239730239094, 5315.787368505216, 5319.28189694394, 5371.033214021513, 5423.918641220384, 5411.729413529308, 5519.034169020405, 5522.779088836482, 5530.695811730313, 5571.860703482364, 5437.782488700487, 5450.5367043800925, 5482.095454250084, 5500.532454741312, 5512.448755124536, 5339.359276886798, 5399.190121481809, 5503.587230957694, 5508.843142940027, 5558.194061861008, 4260.318349064135, 4262.552431994658, 4267.061246525759, 4297.226499230106, 4304.634106101016, 3818.9618103818607, 3825.139343647713, 3827.0432391902023, 3842.7502212356108, 3844.1735026968777, 4995.650304478651, 5043.9747801260755, 5080.314157588678, 5095.439501654815, 5175.81884634036, 5477.260569823103, 5497.065498865202, 5499.50504454601, 5505.284313039279, 5535.778568857281, 5084.593232541388, 5085.211792172219, 5089.033083714083, 5100.438951715309, 5133.307003554547, 4630.560096790799, 4696.436427628706, 4703.882402939954, 4708.128996135726, 4759.50025247351, 5682.232898558642, 5693.68684722336, 5709.486146246858, 5710.143478478179, 5717.142428635738, 5503.3395992481155, 5519.3652729936575, 5526.668399896019, 5527.668339899619, 5550.916736249041, 5512.5589952802875, 5558.138488534284, 5682.062459694104, 5711.228984087095, 5726.942730572808, 5501.587380946365, 5526.447355264441, 5536.252605898152, 5551.611387202857, 5555.777768889199, 5296.258523806747, 5623.718814059199, 5627.296587926509, 5628.127640215773, 5630.634008789416, 5329.893402132013, 5400.486953739389, 5436.673799572039, 5442.891142177214, 5483.232347471437, 5407.107827208467, 5409.891802163856, 5411.702356370437, 5412.918806217831, 5415.6479828811, 5152.355955505562, 5233.215017747369, 5325.147976323769, 5325.2810870531985, 5375.489328513785, 5404.216388623706, 5411.918821217606, 5448.346198456211, 5449.64577302474, 5468.91796623059, 5243.790248390174, 5250.921236181537, 5251.212318152155, 5260.316158899472, 5281.15501519755], "unit": "score", "name": "dojo.html", "value": 5043.11953876138}, {"lowerIsBetter": false, "replicates": [494.9331840201574, 521.0646888834542, 526.1791605096048, 527.7203082366345, 537.6854540094046, 28591.285217869565, 29229.269268268305, 36569.63430365692, 36985.44521832168, 37142.44286335707, 40133.0, 40539.59460405402, 40567.391489127614, 40573.0, 40576.59423405765, 7306.050213472267, 8434.24091831735, 8650.0, 8670.089640587743, 8676.132386761337, 7402.62986850658, 7512.060992375953, 7520.623968801566, 7523.586202758846, 9998.45008524531, 9999.850002249972, 10074.0, 10078.244131690117, 10079.596816127383, 10085.798284034316, 9908.207343412545, 9976.152027077707, 9978.0, 9985.850212246822, 9995.15041221497, 9980.500974951296, 10073.093421592019, 10101.646442374482, 10107.0, 10134.645287414978, 36405.0, 36761.0, 36818.0, 36874.44688329677, 40047.19905601901, 3173.6826317368077, 3203.7116659500757, 3298.901032969015, 3618.8371523281253, 4157.127003329305, 26723.19830405091, 26903.46193076147, 29706.25734356637, 29729.0, 30131.397372052656, 3850.249201405727, 3855.749376290532, 3876.8061596920325, 3891.280113179071, 3937.625925537098, 265866.0, 266356.0, 266371.0, 267409.0, 269277.0, 52880.73559632177, 60738.696306518184, 60968.0, 61180.082298765556, 61229.69385153046, 48579.0, 71598.0, 72675.63662181761, 72701.27298727051, 72950.63524682449, 15207.923960380127, 15317.080975141527, 15394.615134621725, 15508.612284692974, 15509.612259693373, 11465.484053217626, 11506.597269095542, 11513.654590362303, 11565.653030409101, 11641.47613357401, 20163.495912602008, 20347.593048138955, 20351.796482035286, 20383.8980805095, 20409.48976275605, 7823.335016523659, 7900.84198316042, 8025.23760242776, 8038.959805200937, 8116.959415203004, 943.8914524829732, 973.8977407372265, 1026.0662796854826, 1042.3745752548562, 1052.3317693264678, 28554.0, 29036.0, 29507.0, 29571.0, 30865.382692346026, 998.9960090109394, 1013.3615822032073, 1058.5342449322275, 1062.585591619269, 1093.2675107677717, 13752.968527360488, 13894.513692020731, 14117.223552704494, 14171.220582867834, 14202.360893759598, 366843.0, 372066.0, 372145.0, 372959.0, 373420.0, 48587.271190932166, 49572.75213623909, 53579.0, 54198.72900635472, 54375.45624543783, 1315.651352391617, 1352.6618345413647, 1365.5220672764453, 1369.500132451648, 1377.2425166158773, 26941.191764247105, 27114.593281101195, 27617.861910690317, 27772.722272777013, 27807.44385112327, 42231.78884105683, 43372.34941475817, 48676.75661621811, 48817.51182488272, 50298.74850625724, 226421.0, 227326.0, 228172.0, 228471.0, 229210.0, 38588.0, 39000.0, 39173.0, 39184.412233817086, 39256.0, 41768.582314177685, 42249.78875105605, 42658.14683706371, 42760.0, 45958.54041459676, 37860.810695947446, 38229.61770382372, 38380.616193837704, 38613.2277354457, 39489.40765888571, 33977.3204535903, 37969.0, 38821.61178388293, 39492.80253598714, 43166.0, 35266.47100293549, 35545.82227088848, 35684.28631427305, 35808.46287305745, 35886.461703073954, 31476.213094672818, 33190.33619327648, 33419.66580334165, 33843.3231335367, 33879.66120338765, 26360.60459093077, 26941.191764247105, 27115.457690846466, 27224.72775272301, 27266.454670906867], "unit": "score", "name": "ext.html", "value": 18670.457702373715}, {"lowerIsBetter": false, "replicates": [370.2077554034367, 372.97202709796767, 375.68817881158634, 377.10625816814155, 377.47907887115775, 13862.930685346584, 15373.538793836175, 15569.455069072585, 17749.645007099865, 18556.257749690012, 10937.398443085627, 11211.0, 11213.439328033606, 11231.382273974928, 15249.161296128736, 3802.448644946481, 4955.529224723646, 5096.413912400084, 5104.2088476286235, 5105.897882042375, 3876.7673939563574, 5432.402435732086, 5643.68959707216, 5645.068563686987, 5651.208830763697, 5198.064348417283, 5394.32570928634, 5399.595030372718, 5600.0, 5626.2967129108865, 5321.414644389114, 5322.680639161663, 5336.733163341837, 5679.630823996468, 5998.370171132012, 5355.518003379676, 5360.65155764874, 5363.034653762321, 5363.785448582052, 5363.865903352447, 18923.0, 19441.708374374255, 19897.701534476848, 20035.89982050095, 20429.591408171753, 2011.9798802012085, 2083.2500299892176, 2127.680847872816, 2275.5221403505284, 2428.720697119836, 9599.42403455795, 9604.615815367377, 10030.34802737827, 11893.286402815858, 12517.93741031289, 1837.6126024851285, 1851.0, 1886.1041005522404, 1892.3660573707825, 1898.098403258455, 48584.757076214744, 49513.50486495161, 54593.454065459235, 56820.0, 57200.71399642975, 9761.707148785548, 10214.182865370753, 10343.27597068213, 10356.669749306497, 10424.68725938223, 13439.664008399674, 13488.12327198729, 13510.797338039938, 13510.86489135096, 13516.324183790772, 7764.534127952341, 7817.491863028885, 7828.099768526692, 7854.72508462201, 7858.371330293563, 7503.399728021745, 7551.471397002267, 7552.244775522404, 7579.0, 7587.810304742426, 4169.291220492523, 4318.30907054876, 4367.868963931087, 4519.81920723174, 4584.083183363341, 1792.1666425112385, 1835.6145209505887, 1840.2822899069374, 1851.1211120712487, 1862.3574866670976, 887.8712586674895, 966.7824739433571, 976.5751897924425, 978.4422878959067, 1017.2624846985876, 13178.934105329412, 14439.35022923971, 15352.385904563916, 16835.158242087848, 16944.15279236033, 894.0344428017726, 912.9178373946244, 969.1810420194925, 987.3730181334904, 1003.4681618742078, 8092.878606820902, 9119.452832830051, 9470.95264523673, 9499.90500095004, 9586.95206523963, 512802.0, 515751.0, 519485.0, 522432.0, 528836.0, 66226.33773662298, 68801.0, 69979.65010175019, 71229.0, 71272.64363678252, 1119.1662211652372, 1125.7861006408757, 1127.8702949160952, 1154.5554961339944, 1161.2045748662194, 14781.408743650134, 15034.849651503782, 15054.849451505783, 15070.0, 15180.20494876281, 31869.36261274808, 32003.35993280168, 32590.348193035534, 33259.66740332566, 33705.83147084249, 41955.0, 42550.936226593345, 42803.57196427996, 43826.561734383526, 44307.556924431636, 4281.865305693931, 7115.217326094022, 7240.782776516713, 7456.66445009965, 7480.177180510248, 10170.338927969658, 10675.0, 11007.61473348429, 11031.062359699194, 11268.267562608404, 8788.604512796812, 9375.156235938799, 9626.66306679263, 9769.31614786958, 9812.165965892978, 7544.735934242275, 8913.509756963429, 9605.0, 9744.220462362851, 9977.950110249401, 9282.582283797381, 9316.627334906529, 9356.578953947224, 9426.95286523563, 9533.142017218484, 7079.433645308466, 7163.426925845815, 7270.127584689871, 7282.854342913218, 7361.447891408059, 9082.18260356571, 9562.760930976781, 9618.182454491447, 9680.515974201402, 9760.365576237522], "unit": "score", "name": "jquery.html", "value": 8055.959380546453}, {"lowerIsBetter": false, "replicates": [1306.0270098776414, 1456.8761655259302, 1479.2751551739648, 1646.6542026174502, 1797.7573027641265, 6911.136107986502, 7691.923080769197, 7858.607069646523, 7869.17373675763, 7877.36981041516, 7653.693852245903, 7833.412494062954, 7841.059072911258, 7854.410919181056, 7864.252895974873, 1982.692682634187, 2049.5798361335965, 2277.23712556293, 2295.9081636734554, 2325.1513197682893, 2330.6620540021686, 2336.217367181996, 2344.9882750586307, 2352.6588644646604, 2352.6706261123454, 2239.8320125990535, 2298.4368829636765, 2301.0680674326923, 2303.28598134578, 2306.792388685018, 2288.4164538042774, 2311.768823117683, 2349.9530009399887, 2362.5156842847173, 2364.1843563970488, 2315.2591170825344, 2318.7801329698864, 2333.754955729641, 2337.6610391493136, 2346.7183937927557, 7990.640421181002, 8031.799205019921, 8031.839363212762, 8046.034475862875, 8048.557329346883, 4816.470188279286, 4881.096997055521, 4919.385076865392, 4920.8031678732805, 4921.409430868319, 3034.1959380764115, 3078.184281165493, 3115.2679120406688, 3207.3585282943504, 3222.0817067135754, 932.3473568502008, 934.4533447932968, 971.5288085278635, 974.7173319737268, 996.7757254617726, 11165.888341116648, 11196.66410007701, 11207.21549491536, 11215.607453739161, 11237.775244495064, 4395.099004704028, 4414.205443020287, 4497.707649002804, 4506.549345065533, 4512.864614061584, 9537.427754334762, 9609.615615375447, 9630.085141911508, 9640.325177237526, 9650.806983860284, 4939.333190019373, 4971.1549036663855, 4979.726115063706, 5001.149804533238, 5002.59979201663, 4517.841875534341, 4523.864284071417, 4527.0, 4528.139653465831, 4532.206863798822, 3502.0894567412656, 3560.3413368526903, 3748.325301445766, 3771.905702357463, 3814.5231846019246, 1240.348816871132, 1243.657994051643, 1251.8873301402734, 1257.076049103908, 1259.8362212912264, 1069.534752382716, 1090.5583238788304, 1091.1598069486452, 1207.9214851034656, 1335.465813674538, 7174.497785154989, 7196.748113815991, 7221.241769614115, 7287.70849166038, 7291.125064992235, 1095.4632230207142, 1097.3415950429837, 1107.2194103157256, 1118.8377685235596, 1132.1621999720312, 5879.2944846618675, 5987.79042733511, 5988.790392336247, 5993.670348130895, 6002.54980876436, 9680.886698029817, 9780.070893265129, 9854.16239619626, 9933.403995760278, 10025.899741002642, 9838.36050656705, 9849.704508864745, 9854.11312981835, 9860.950695246478, 9881.80236395268, 7422.814429639302, 7602.619869006528, 7679.3856491481665, 7688.0, 7706.38348932084, 7245.492815503075, 7246.275372462712, 7271.527350722186, 7279.0, 7290.890636640349, 8661.566921653766, 8714.041455440023, 8816.603252853765, 8820.029796722227, 8985.820283594161, 8333.083360830426, 8892.199702026848, 9048.728538143867, 9064.50145242018, 9071.138241867013, 6225.470834979077, 7073.575585464889, 7132.358087772125, 7193.136823581203, 7198.49610527279, 6811.795646130624, 7231.63841807918, 7406.037215161994, 7414.0, 7417.443691723251, 6835.692393842389, 6848.527566573211, 6866.141732283465, 6875.07186529812, 6906.723731050702, 6962.477814164059, 7033.085698859116, 7053.365197132282, 7078.0444639975, 7092.397146242627, 6880.862382752417, 6881.243063263138, 6928.722851086101, 6932.930670693228, 6997.965010174917, 6564.901526477011, 6613.437857782143, 6619.371159739817, 6622.70197841108, 6627.933720662924, 6585.341465853377, 6603.075569420189, 6621.768238111643, 6636.668166591748, 6647.767328143492], "unit": "score", "name": "mootools.html", "value": 4576.071953321153}, {"lowerIsBetter": false, "replicates": [335.63751148759343, 348.90056333944824, 350.2172644140346, 358.3728475168455, 359.91362073102465, 5907.291125064988, 5923.229980102586, 6086.665233412161, 6091.939080609192, 6131.938680613192, 5836.824895253149, 5888.205092312536, 5909.0, 5921.20063791388, 6020.187274717911, 4631.698939568934, 4638.211504044304, 4638.860834174963, 4645.396098507189, 4645.628349732014, 4422.734635921839, 4499.212637788391, 4546.431696037996, 4613.1926912790295, 4635.751660444682, 4587.15137699525, 4612.8385506507275, 4616.215243408612, 4626.8380606678775, 4635.559621835921, 4618.35343051973, 4619.514950930155, 4623.445186577632, 4625.676202665814, 4627.0, 4020.5376381716183, 4026.4966879140106, 4032.6572241359227, 4034.838606455738, 4042.9191416171807, 5633.6619802811965, 5725.656460612335, 5726.885462290731, 5732.684702341369, 5741.770329186827, 5355.6251062425645, 5366.114591092465, 5374.086405311106, 5375.3012108425655, 5382.91925621116, 6138.263408391022, 6394.328595497453, 6400.775972840928, 6403.199600049994, 6407.167068281094, 4338.0, 4376.6936314458, 4416.734995900256, 4420.690551661352, 4423.093265880519, 6474.1907261592305, 6543.509236807211, 6567.573107747981, 6579.374959378852, 6595.109660195908, 4424.380586717862, 4460.620847227957, 4462.241418958784, 4475.037866858641, 4477.306017567283, 4428.933565996513, 4520.141173177086, 4524.864254072318, 4529.207388706963, 4551.977240113778, 5202.115640341151, 5228.424873263938, 5234.92147617786, 5237.3453318335205, 5239.768654366221, 6355.872882542416, 6362.968185159137, 6367.649779262092, 6370.522210834206, 6371.585846919936, 1669.7996240451223, 1690.6111594333372, 1690.797104347486, 1690.9492715218564, 1691.408007197471, 1090.111559079348, 1110.3615421132881, 1114.2924243105685, 1133.863936327646, 1143.9485223164977, 6100.328963813977, 6105.175801266861, 6107.8473038173515, 6109.84725381869, 6125.019996800491, 6589.472842172615, 6632.1046658701425, 6645.3022432643875, 6647.501437392215, 6659.534902321481, 5948.702564871739, 6097.207363042865, 6151.231096112986, 6172.69136543171, 6173.59871608353, 3571.1786289153642, 3589.3180295744246, 3592.2276710507367, 3596.7122630189524, 3600.243948770735, 6855.485838562127, 6862.142232220973, 6873.278305777922, 6875.449964002968, 6877.3810357068105, 6626.602403855688, 6783.287754785676, 6803.149606299213, 6817.284185160487, 6820.658967051628, 6855.451563874978, 6858.931410685929, 6866.759663411756, 6868.553544019623, 6874.278200788845, 6447.258565264867, 6621.304763000008, 6624.8343791405605, 6626.370494802986, 6698.933010669831, 6461.967690161519, 6628.602283862983, 6647.135872336758, 6655.900161497679, 6658.167729033871, 6936.965315173392, 6952.756653517103, 6953.826154346182, 6958.338957799001, 6968.825779355557, 4404.691671582958, 4525.63794896414, 4693.601043911306, 4697.318888761042, 4699.647526435463, 6617.933820661732, 6640.667966601747, 6667.766628167991, 6670.533062685566, 6676.632785196861, 6492.837679058061, 6496.415322620986, 6506.154199953976, 6506.3818937200895, 6508.837279068061, 6337.841553961188, 6428.903566446414, 6456.774012909714, 6467.967660161669, 6471.352864713491, 6351.523635727432, 6355.078513615592, 6355.491560675227, 6357.650329231752, 6360.586561873463, 6499.38255865692, 6500.804975850732, 6503.44720698727, 6503.479721622353, 6503.577267477599, 6216.533759968111, 6323.588966717149, 6335.936640633535, 6378.266499352449, 6422.678866056585], "unit": "score", "name": "prototype.html", "value": 4844.222492567985}, {"lowerIsBetter": false, "replicates": [685.2325395556977, 696.5437638346884, 733.6295170938675, 777.4868586732756, 854.406187699549, 12970.805437918427, 13142.0, 13145.342732863342, 13146.474141034347, 13152.210867347965, 12271.263724176555, 12697.61907142785, 12788.616341509747, 14189.929050354734, 14239.501617443391, 805.4321703199245, 821.2690705272313, 822.1901427094307, 822.2271065198725, 822.5311572403732, 804.0311424733212, 804.2279411764713, 809.1382677448528, 812.9634166462494, 815.9877601835977, 858.2233079063458, 860.4880096342666, 862.3877047296427, 863.0204717645455, 863.3869952333819, 856.575994882531, 858.8497013022759, 861.4788053227769, 864.6282098697558, 865.0182043380777, 636.8821767972894, 636.9681515924232, 637.1939496536885, 637.6333608175318, 637.6365471681144, 12952.481900724055, 13155.408006639724, 13239.404226809816, 13245.139065960682, 13270.336483175803, 12714.173578717353, 13009.544665936646, 13095.672608184776, 13423.328833558284, 13633.931830340785, 10503.159747220205, 10576.576936922515, 10714.464276786208, 10738.140948724084, 10749.570017199303, 3563.5367402237803, 3641.0, 3644.3622366086092, 3681.687056600192, 3777.2823163598828, 47582.762086189345, 47819.76090119562, 47826.0, 47911.28133078007, 48135.75932120352, 9555.18780903631, 9670.951645241728, 9773.12041916231, 9773.706788796348, 9917.553710082919, 17619.735703964452, 17803.554911127325, 17846.821531784775, 17917.641647166984, 19042.42872713821, 7163.67763450646, 7271.236520165412, 7316.45126615506, 7410.147832999166, 7428.85142297151, 4021.3565829467143, 4035.071933455322, 4153.397757325171, 4166.645835103989, 4227.87316380509, 3062.908112756621, 3087.845607719605, 3088.5212792016823, 3101.379724055198, 3102.860371283298, 530.1755769778032, 548.9011977843946, 549.9917501237485, 580.1384943359109, 582.5019608234983, 509.5668681620593, 548.410458756838, 562.4768964862717, 579.0, 607.1894021481372, 7786.922130778733, 8324.6670133194, 8424.873626895602, 8532.829343413097, 8582.0, 557.9637323573954, 620.6896551724138, 628.2304177382761, 642.5662677692538, 644.7936660268668, 3878.9612103879163, 3980.5621381647998, 4058.289799285113, 4174.728642638219, 4258.233517966796, 58658.0, 61175.0, 61475.692621536604, 61493.38506614966, 61579.38420615737, 45174.0, 48601.513984859695, 48818.26772598414, 51506.0, 53014.73492632512, 35939.820300898326, 44288.55711442844, 45036.54963450389, 45043.324350134775, 45141.097178056254, 7749.806254843674, 8006.479578827358, 8397.293450850215, 8482.575871206538, 8489.660413583635, 33367.83316083404, 33609.83195084009, 33773.32453350969, 33959.320813583094, 34000.489992650626, 45268.54731452643, 45425.318620221384, 45562.08875822531, 46135.76932115318, 46343.53656463527, 10300.124489418184, 10370.533326000197, 10580.947095264475, 10657.946710266398, 10705.571777128827, 11697.707557311136, 11748.118891083031, 11753.764924701287, 11866.0, 11895.226810257305, 10912.127029837753, 11073.335599864035, 11120.555177792798, 11449.198556101326, 11489.425528723697, 9993.300468967103, 10490.213234007328, 10497.842532362174, 10524.842127367943, 10893.455327233765, 9525.952370238381, 9530.904690953003, 10438.582456701646, 10546.314489558154, 10552.894471055499, 8607.483989203214, 8733.825323493367, 8813.118688131135, 8900.5994730236, 8985.730428087169, 8443.746687599381, 8701.695440659547, 8762.824743505222, 9128.406653567497, 9353.625854965725], "unit": "score", "name": "yui.html", "value": 6164.17657046562}], "name": "dromaeo_css", "value": 6853.834263560151}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 111.0, 109.0, 111.0, 110.0, 111.0, 105.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 132.0, 148.0, 172.0, 131.0, 148.0, 151.0, 138.0, 176.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 159.0, 163.0, 162.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 101.0, 97.0, 76.0, 73.0, 75.0, 115.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 137.0, 95.0, 97.0, 96.0, 145.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 57.0, 57.0, 56.0, 59.0, 57.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 83.0, 82.0, 82.0, 82.0, 88.0, 89.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 115.0, 116.0, 120.0, 116.0, 130.0, 117.0, 124.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [142.0, 129.0, 140.0, 145.0, 142.0, 130.0, 139.0, 140.0, 138.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 68.0, 66.0, 67.0, 73.0, 66.0, 65.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1497.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [189.0359168241966], "unit": "score", "name": "DeltaBlue", "value": 349.7642200000001}, {"lowerIsBetter": false, "replicates": [282.16704288939053], "unit": "score", "name": "Encrypt", "value": 943.3454639999995}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1129.9435028248588], "unit": "score", "name": "RayTrace", "value": 654.890265}, {"lowerIsBetter": false, "replicates": [823.0452674897119], "unit": "score", "name": "Earley", "value": 809.7525450000003}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [43106.382978723406], "unit": "score", "name": "RegExp", "value": 21.133413129318836}, {"lowerIsBetter": false, "replicates": [586.1664712778429], "unit": "score", "name": "Splay", "value": 139.02364600000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19894.19243242846}]} 23:23:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19894.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1497.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6853.83"}}} 23:23:48 INFO - Return code: 0 23:23:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:23:49 INFO - # TBPL SUCCESS # 23:23:49 INFO - Running post-action listener: _resource_record_post_action 23:23:49 INFO - Running post-run listener: _resource_record_post_run 23:23:50 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 20480; Write bytes: 548438016; Read time: 260; Write time: 610836 23:23:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236208128; Read time: 0; Write time: 335308 23:23:50 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 20480; Write bytes: 312229888; Read time: 260; Write time: 275528 23:23:50 INFO - Running post-run listener: _upload_blobber_files 23:23:50 INFO - Blob upload gear active. 23:23:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:23:50 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 23:23:50 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:23:50 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:23:50 INFO - (blobuploader) - INFO - Open directory for files ... 23:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:51 INFO - (blobuploader) - INFO - Done attempting. 23:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:52 INFO - (blobuploader) - INFO - Done attempting. 23:23:52 INFO - (blobuploader) - INFO - Iteration through files over. 23:23:52 INFO - Return code: 0 23:23:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:23:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:23:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d01fc2a5a0777f3f2d3cfb5c96ef27fa1f3ed5191e1742de52b3ad31ec8cc1f46f94f3082a790f8da76d93fa5772d337707c0331edbce8328709d820def498d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e2d8d228db6ea454ae17149c3ea826175b926b9bff567f33c3bfcda4308f2b678370ac76f65abfae8620f61874b1a01dde983d090f06cb8ba8913f00270f3355"} 23:23:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:23:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:23:52 INFO - Contents: 23:23:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d01fc2a5a0777f3f2d3cfb5c96ef27fa1f3ed5191e1742de52b3ad31ec8cc1f46f94f3082a790f8da76d93fa5772d337707c0331edbce8328709d820def498d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e2d8d228db6ea454ae17149c3ea826175b926b9bff567f33c3bfcda4308f2b678370ac76f65abfae8620f61874b1a01dde983d090f06cb8ba8913f00270f3355"} 23:23:52 INFO - Running post-run listener: copy_logs_to_upload_dir 23:23:52 INFO - Copying logs to upload dir... 23:23:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:23:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.456048 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-23 23:23:51.515461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 23:23:51.519219) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d01fc2a5a0777f3f2d3cfb5c96ef27fa1f3ed5191e1742de52b3ad31ec8cc1f46f94f3082a790f8da76d93fa5772d337707c0331edbce8328709d820def498d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e2d8d228db6ea454ae17149c3ea826175b926b9bff567f33c3bfcda4308f2b678370ac76f65abfae8620f61874b1a01dde983d090f06cb8ba8913f00270f3355"} build_url:https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/e0zoSFnsQsOdITXOpqEIQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d01fc2a5a0777f3f2d3cfb5c96ef27fa1f3ed5191e1742de52b3ad31ec8cc1f46f94f3082a790f8da76d93fa5772d337707c0331edbce8328709d820def498d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e2d8d228db6ea454ae17149c3ea826175b926b9bff567f33c3bfcda4308f2b678370ac76f65abfae8620f61874b1a01dde983d090f06cb8ba8913f00270f3355"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 23:23:51.548606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:23:51.549026) ========= 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=eca2ab57546de7b41f256b19000001ef-1453608808.109642-417647965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:23:51.633177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 23:23:51.633973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 23:23:51.634773) ========= ========= Total master_lag: 0.28 =========