builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1457263259.08 results: success (0) buildid: 20160306004032 builduid: d258606d27aa4de19aa08369c3c57d4e revision: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.082999) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.083424) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.083699) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.131536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.131822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.219789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.220047) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.292100) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.292363) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.292678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.293269) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 03:20:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-03-06 03:21:00 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.473538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.473856) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.526236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:20:59.526529) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 --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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 03:21:00,167 truncating revision to first 12 chars 2016-03-06 03:21:00,167 Setting DEBUG logging. 2016-03-06 03:21:00,167 attempt 1/10 2016-03-06 03:21:00,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/383d2c72f4c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 03:21:00,549 unpacking tar archive at: mozilla-aurora-383d2c72f4c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703826 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:21:00.244275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 03:21:00.244565) ========= echo 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'383d2c72f4c77a81d44704272dcfbbe3c8cafca8'] 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 program finished with exit code 0 elapsedTime=0.004452 script_repo_revision: '383d2c72f4c77a81d44704272dcfbbe3c8cafca8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 03:21:00.297044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 03:21:00.297312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 03:21:00.319252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-03-06 03:21:00.319515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:01 INFO - MultiFileLogger online at 20160306 03:21:01 in /builds/slave/test-pgo 03:21:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:21:01 INFO - {'append_to_log': False, 03:21:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:21:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:21:01 INFO - 'branch': 'Mozilla-Aurora', 03:21:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:01 INFO - 'config_files': ('talos/linux_config.py',), 03:21:01 INFO - 'default_actions': ('clobber', 03:21:01 INFO - 'read-buildbot-config', 03:21:01 INFO - 'download-and-extract', 03:21:01 INFO - 'populate-webroot', 03:21:01 INFO - 'create-virtualenv', 03:21:01 INFO - 'install', 03:21:01 INFO - 'run-tests'), 03:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:01 INFO - 'download_minidump_stackwalk': True, 03:21:01 INFO - 'download_symbols': 'ondemand', 03:21:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:01 INFO - 'installer_path': 'installer.exe', 03:21:01 INFO - 'log_level': 'info', 03:21:01 INFO - 'log_name': 'talos', 03:21:01 INFO - 'log_to_console': True, 03:21:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:01 INFO - 'opt_config_files': (), 03:21:01 INFO - 'pip_index': False, 03:21:01 INFO - 'sps_profile': False, 03:21:01 INFO - 'sps_profile_interval': 0, 03:21:01 INFO - 'suite': 'dromaeojs', 03:21:01 INFO - 'system_bits': '32', 03:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:01 INFO - 'title': 'talos-linux64-ix-026', 03:21:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:01 INFO - 'use_talos_json': True, 03:21:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:01 INFO - 'work_dir': 'build'} 03:21:01 INFO - ##### 03:21:01 INFO - ##### Running clobber step. 03:21:01 INFO - ##### 03:21:01 INFO - Running pre-action listener: _resource_record_pre_action 03:21:01 INFO - Running main action method: clobber 03:21:01 INFO - rmtree: /builds/slave/test-pgo/build 03:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:21:02 INFO - Running post-action listener: _resource_record_post_action 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running read-buildbot-config step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: read_buildbot_config 03:21:02 INFO - Using buildbot properties: 03:21:02 INFO - { 03:21:02 INFO - "project": "", 03:21:02 INFO - "product": "firefox", 03:21:02 INFO - "script_repo_revision": "production", 03:21:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:21:02 INFO - "repository": "", 03:21:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:21:02 INFO - "buildid": "20160306004032", 03:21:02 INFO - "stage_platform": "linux64-pgo", 03:21:02 INFO - "basedir": "/builds/slave/test-pgo", 03:21:02 INFO - "nightly_build": "True", 03:21:02 INFO - "buildnumber": 208, 03:21:02 INFO - "slavename": "talos-linux64-ix-026", 03:21:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:21:02 INFO - "platform": "ubuntu64_hw", 03:21:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:02 INFO - "branch": "mozilla-aurora", 03:21:02 INFO - "repo_path": "releases/mozilla-aurora", 03:21:02 INFO - "revision": "383d2c72f4c77a81d44704272dcfbbe3c8cafca8", 03:21:02 INFO - "pgo_build": "True", 03:21:02 INFO - "builduid": "d258606d27aa4de19aa08369c3c57d4e", 03:21:02 INFO - "slavebuilddir": "test" 03:21:02 INFO - } 03:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 03:21:02 INFO - Running post-action listener: _resource_record_post_action 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running download-and-extract step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: download_and_extract 03:21:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:21: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')]} 03:21:02 INFO - https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/test_packages.json 03:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/test_packages.json 03:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:21:08 INFO - Downloaded 1448 bytes. 03:21:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:21:08 INFO - Using the following test package requirements: 03:21:08 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:08 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:08 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:21:08 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'jsshell-linux-x86_64.zip'], 03:21:08 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:08 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:08 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:08 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:08 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:08 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:08 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:08 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21: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')]} 03:21:08 INFO - https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:18 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip: [Errno 104] Connection reset by peer 03:21:18 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 03:21:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:21:48 INFO - Downloaded 23097457 bytes. 03:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:21:50 INFO - Return code: 0 03:21:50 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 INFO - https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:51 INFO - Downloaded 23097457 bytes. 03:21:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:21:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:21:52 INFO - Return code: 0 03:21: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')]} 03:21:52 INFO - https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:21:53 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip: [Errno 104] Connection reset by peer 03:21:53 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 03:21:53 INFO - retry: Failed, sleeping 30 seconds before retrying 03:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:22:24 INFO - Downloaded 10801536 bytes. 03:22:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:22:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:22:24 INFO - Return code: 0 03:22:24 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')]} 03:22:24 INFO - https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:22:25 INFO - Downloaded 59963391 bytes. 03:22:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:22:25 INFO - mkdir: /builds/slave/test-pgo/properties 03:22:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:22:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:22:25 INFO - Contents: 03:22:25 INFO - build_url:https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:22:26 INFO - Running post-action listener: _resource_record_post_action 03:22:26 INFO - Running post-action listener: set_extra_try_arguments 03:22:26 INFO - ##### 03:22:26 INFO - ##### Running populate-webroot step. 03:22:26 INFO - ##### 03:22:26 INFO - Running pre-action listener: _resource_record_pre_action 03:22:26 INFO - Running main action method: populate_webroot 03:22:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:26 INFO - '--tppagecycles', 03:22:26 INFO - '7'], 03:22:26 INFO - 'tests': ['tsvgm']}}, 03:22:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:22:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'tests': ['damp', 'tps']}, 03:22:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['damp', 'tps']}, 03:22:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:22:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:26 INFO - 'other': {'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'other_l64': {'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'other_nol64': {'tests': ['a11yr', 03:22:26 INFO - 'ts_paint', 03:22:26 INFO - 'tpaint', 03:22:26 INFO - 'sessionrestore', 03:22:26 INFO - 'sessionrestore_no_auto_restore']}, 03:22:26 INFO - 'svgr': {'tests': ['tsvgx', 03:22:26 INFO - 'tsvgr_opacity', 03:22:26 INFO - 'tart', 03:22:26 INFO - 'tscrollx', 03:22:26 INFO - 'cart']}, 03:22:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['tsvgx', 03:22:26 INFO - 'tsvgr_opacity', 03:22:26 INFO - 'tart', 03:22:26 INFO - 'tscrollx', 03:22:26 INFO - 'cart']}, 03:22:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'tests': ['tp5o']}, 03:22:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'talos_options': ['--e10s'], 03:22:26 INFO - 'tests': ['tp5o']}, 03:22:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'talos_options': ['--xperf_path', 03:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:26 INFO - 'tests': ['tp5n']}, 03:22:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:26 INFO - 'talos_options': ['--e10s', 03:22:26 INFO - '--xperf_path', 03:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:26 INFO - 'tests': ['tp5n']}}, 03:22:26 INFO - 'talos.zip': {'path': '', 03:22:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:26 INFO - Running post-action listener: _resource_record_post_action 03:22:26 INFO - ##### 03:22:26 INFO - ##### Running create-virtualenv step. 03:22:26 INFO - ##### 03:22:26 INFO - Running pre-action listener: _resource_record_pre_action 03:22:26 INFO - Running main action method: create_virtualenv 03:22:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:22:26 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 03:22:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:22:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:26 INFO - Using real prefix '/usr' 03:22:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:22:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:29 INFO - Installing pip.................done. 03:22:29 INFO - Return code: 0 03:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:29 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:29 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 03:22:29 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 03:22:29 INFO - Using env: {'DISPLAY': ':0', 03:22:29 INFO - 'HOME': '/home/cltbld', 03:22:29 INFO - 'LANG': 'en_US.UTF-8', 03:22:29 INFO - 'LANGUAGE': 'en_US:en', 03:22:29 INFO - 'LOGNAME': 'cltbld', 03:22:29 INFO - 'MAIL': '/var/mail/cltbld', 03:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:29 INFO - 'MOZ_NO_REMOTE': '1', 03:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:29 INFO - 'NO_EM_RESTART': '1', 03:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:29 INFO - 'SHELL': '/bin/bash', 03:22:29 INFO - 'SHLVL': '1', 03:22:29 INFO - 'TERM': 'linux', 03:22:29 INFO - 'TMOUT': '86400', 03:22:29 INFO - 'USER': 'cltbld', 03:22:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:29 INFO - '_': '/tools/buildbot/bin/python'} 03:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:29 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 03:22:29 INFO - Cleaning up... 03:22:29 INFO - Return code: 0 03:22:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:29 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:29 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 03:22:29 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 03:22:29 INFO - Using env: {'DISPLAY': ':0', 03:22:29 INFO - 'HOME': '/home/cltbld', 03:22:29 INFO - 'LANG': 'en_US.UTF-8', 03:22:29 INFO - 'LANGUAGE': 'en_US:en', 03:22:29 INFO - 'LOGNAME': 'cltbld', 03:22:29 INFO - 'MAIL': '/var/mail/cltbld', 03:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:29 INFO - 'MOZ_NO_REMOTE': '1', 03:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:29 INFO - 'NO_EM_RESTART': '1', 03:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:29 INFO - 'SHELL': '/bin/bash', 03:22:29 INFO - 'SHLVL': '1', 03:22:29 INFO - 'TERM': 'linux', 03:22:29 INFO - 'TMOUT': '86400', 03:22:29 INFO - 'USER': 'cltbld', 03:22:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:29 INFO - '_': '/tools/buildbot/bin/python'} 03:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:29 INFO - Downloading/unpacking psutil>=0.7.1 03:22:29 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 03:22:29 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 03:22:29 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 03:22:29 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 03:22:29 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 03:22:29 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 03:22:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:31 INFO - Installing collected packages: psutil 03:22:31 INFO - Running setup.py install for psutil 03:22:31 INFO - building 'psutil._psutil_linux' extension 03:22:31 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 03:22:32 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 03:22:32 INFO - building 'psutil._psutil_posix' extension 03:22:32 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 03:22:32 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 03:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:32 INFO - Successfully installed psutil 03:22:32 INFO - Cleaning up... 03:22:32 INFO - Return code: 0 03:22:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:22:32 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')]} 03:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:32 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')]} 03:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:32 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:32 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 03:22:32 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 03:22:32 INFO - Using env: {'DISPLAY': ':0', 03:22:32 INFO - 'HOME': '/home/cltbld', 03:22:32 INFO - 'LANG': 'en_US.UTF-8', 03:22:32 INFO - 'LANGUAGE': 'en_US:en', 03:22:32 INFO - 'LOGNAME': 'cltbld', 03:22:32 INFO - 'MAIL': '/var/mail/cltbld', 03:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:32 INFO - 'MOZ_NO_REMOTE': '1', 03:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:32 INFO - 'NO_EM_RESTART': '1', 03:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:32 INFO - 'SHELL': '/bin/bash', 03:22:32 INFO - 'SHLVL': '1', 03:22:32 INFO - 'TERM': 'linux', 03:22:32 INFO - 'TMOUT': '86400', 03:22:32 INFO - 'USER': 'cltbld', 03:22:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:32 INFO - '_': '/tools/buildbot/bin/python'} 03:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:32 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 03:22:32 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 03:22:32 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 03:22:32 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 03:22:32 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 03:22:32 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 03:22:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:22:34 INFO - Installing collected packages: mozsystemmonitor 03:22:34 INFO - Running setup.py install for mozsystemmonitor 03:22:34 INFO - Successfully installed mozsystemmonitor 03:22:34 INFO - Cleaning up... 03:22:34 INFO - Return code: 0 03:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:22: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')]} 03:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:34 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:34 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 03:22:34 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 03:22:34 INFO - Using env: {'DISPLAY': ':0', 03:22:34 INFO - 'HOME': '/home/cltbld', 03:22:34 INFO - 'LANG': 'en_US.UTF-8', 03:22:34 INFO - 'LANGUAGE': 'en_US:en', 03:22:34 INFO - 'LOGNAME': 'cltbld', 03:22:34 INFO - 'MAIL': '/var/mail/cltbld', 03:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:34 INFO - 'MOZ_NO_REMOTE': '1', 03:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:34 INFO - 'NO_EM_RESTART': '1', 03:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:34 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:34 INFO - 'SHELL': '/bin/bash', 03:22:34 INFO - 'SHLVL': '1', 03:22:34 INFO - 'TERM': 'linux', 03:22:34 INFO - 'TMOUT': '86400', 03:22:34 INFO - 'USER': 'cltbld', 03:22:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:34 INFO - '_': '/tools/buildbot/bin/python'} 03:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:37 INFO - Downloading docopt-0.6.1.tar.gz 03:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:37 INFO - Running setup.py install for blobuploader 03:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:22:37 INFO - Running setup.py install for requests 03:22:37 INFO - Running setup.py install for docopt 03:22:37 INFO - Successfully installed blobuploader requests docopt 03:22:37 INFO - Cleaning up... 03:22:37 INFO - Return code: 0 03:22:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:37 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:38 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 03:22:38 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 03:22:38 INFO - Using env: {'DISPLAY': ':0', 03:22:38 INFO - 'HOME': '/home/cltbld', 03:22:38 INFO - 'LANG': 'en_US.UTF-8', 03:22:38 INFO - 'LANGUAGE': 'en_US:en', 03:22:38 INFO - 'LOGNAME': 'cltbld', 03:22:38 INFO - 'MAIL': '/var/mail/cltbld', 03:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:38 INFO - 'MOZ_NO_REMOTE': '1', 03:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:38 INFO - 'NO_EM_RESTART': '1', 03:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:38 INFO - 'SHELL': '/bin/bash', 03:22:38 INFO - 'SHLVL': '1', 03:22:38 INFO - 'TERM': 'linux', 03:22:38 INFO - 'TMOUT': '86400', 03:22:38 INFO - 'USER': 'cltbld', 03:22:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:38 INFO - '_': '/tools/buildbot/bin/python'} 03:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:38 INFO - Running setup.py (path:/tmp/pip-llyVr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:38 INFO - Running setup.py (path:/tmp/pip-yZG3Yc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:38 INFO - Running setup.py (path:/tmp/pip-8DSYij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:38 INFO - Running setup.py (path:/tmp/pip-B3SDGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:38 INFO - Running setup.py (path:/tmp/pip-uacHx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:38 INFO - Running setup.py (path:/tmp/pip-ZHA3aI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:38 INFO - Running setup.py (path:/tmp/pip-WGRreu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:38 INFO - Running setup.py (path:/tmp/pip-wjiLlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:38 INFO - Running setup.py (path:/tmp/pip-hZRL1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:38 INFO - Running setup.py (path:/tmp/pip-Xnm4yQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:38 INFO - Running setup.py (path:/tmp/pip-wEY7N4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:38 INFO - Running setup.py (path:/tmp/pip-AH8gl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:39 INFO - Running setup.py (path:/tmp/pip-cEmC2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:39 INFO - Running setup.py (path:/tmp/pip-5YpqS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:39 INFO - Running setup.py (path:/tmp/pip-RLGNbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:39 INFO - Running setup.py (path:/tmp/pip-RfSWlX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:39 INFO - Running setup.py (path:/tmp/pip-mjScW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:39 INFO - Running setup.py install for manifestparser 03:22:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:22:39 INFO - Running setup.py install for mozcrash 03:22:39 INFO - Running setup.py install for mozdebug 03:22:39 INFO - Running setup.py install for mozdevice 03:22:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:22:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:22:39 INFO - Running setup.py install for mozfile 03:22:39 INFO - Running setup.py install for mozhttpd 03:22:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozinfo 03:22:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozInstall 03:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozleak 03:22:40 INFO - Running setup.py install for mozlog 03:22:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for moznetwork 03:22:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozprocess 03:22:40 INFO - Running setup.py install for mozprofile 03:22:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozrunner 03:22:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:22:40 INFO - Running setup.py install for mozscreenshot 03:22:40 INFO - Running setup.py install for moztest 03:22:41 INFO - Running setup.py install for mozversion 03:22:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:41 INFO - Cleaning up... 03:22:41 INFO - Return code: 0 03:22:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:22: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')]} 03:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:41 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:41 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 03:22:41 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 03:22:41 INFO - Using env: {'DISPLAY': ':0', 03:22:41 INFO - 'HOME': '/home/cltbld', 03:22:41 INFO - 'LANG': 'en_US.UTF-8', 03:22:41 INFO - 'LANGUAGE': 'en_US:en', 03:22:41 INFO - 'LOGNAME': 'cltbld', 03:22:41 INFO - 'MAIL': '/var/mail/cltbld', 03:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:41 INFO - 'MOZ_NO_REMOTE': '1', 03:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:41 INFO - 'NO_EM_RESTART': '1', 03:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:41 INFO - 'SHELL': '/bin/bash', 03:22:41 INFO - 'SHLVL': '1', 03:22:41 INFO - 'TERM': 'linux', 03:22:41 INFO - 'TMOUT': '86400', 03:22:41 INFO - 'USER': 'cltbld', 03:22:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:41 INFO - '_': '/tools/buildbot/bin/python'} 03:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:41 INFO - Running setup.py (path:/tmp/pip-EP1xfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:41 INFO - Running setup.py (path:/tmp/pip-Cq7CGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:41 INFO - Running setup.py (path:/tmp/pip-QVfeGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:41 INFO - Running setup.py (path:/tmp/pip-GJP8lg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:41 INFO - Running setup.py (path:/tmp/pip-e9ae9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:41 INFO - Running setup.py (path:/tmp/pip-PMJrsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:41 INFO - Running setup.py (path:/tmp/pip-oLkBEV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:41 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)) 03:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:41 INFO - Running setup.py (path:/tmp/pip-LAABFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:42 INFO - Running setup.py (path:/tmp/pip-y85fZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:42 INFO - Running setup.py (path:/tmp/pip-xTC94N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:42 INFO - Running setup.py (path:/tmp/pip-85uT33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:42 INFO - Running setup.py (path:/tmp/pip-zm8MHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:42 INFO - Running setup.py (path:/tmp/pip-4gt5at-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:42 INFO - Running setup.py (path:/tmp/pip-0Oduu1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:42 INFO - Running setup.py (path:/tmp/pip-FBi8bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:42 INFO - Running setup.py (path:/tmp/pip-4xpdgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:42 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)) 03:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:42 INFO - Running setup.py (path:/tmp/pip-YGGYcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:42 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)) 03:22:42 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)) 03:22:42 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)) 03:22:42 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)) 03:22:42 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)) 03:22:42 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)) 03:22:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:44 INFO - Downloading blessings-1.6.tar.gz 03:22:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:44 INFO - Installing collected packages: blessings 03:22:44 INFO - Running setup.py install for blessings 03:22:44 INFO - Successfully installed blessings 03:22:44 INFO - Cleaning up... 03:22:44 INFO - Return code: 0 03:22:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:22:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:22:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:22:44 INFO - Reading from file tmpfile_stdout 03:22:44 INFO - Current package versions: 03:22:44 INFO - argparse == 1.2.1 03:22:44 INFO - blessings == 1.6 03:22:44 INFO - blobuploader == 1.2.4 03:22:44 INFO - docopt == 0.6.1 03:22:44 INFO - manifestparser == 1.1 03:22:44 INFO - mozInstall == 1.12 03:22:44 INFO - mozcrash == 0.16 03:22:44 INFO - mozdebug == 0.1 03:22:44 INFO - mozdevice == 0.48 03:22:44 INFO - mozfile == 1.2 03:22:44 INFO - mozhttpd == 0.7 03:22:44 INFO - mozinfo == 0.9 03:22:44 INFO - mozleak == 0.1 03:22:44 INFO - mozlog == 3.1 03:22:44 INFO - moznetwork == 0.27 03:22:44 INFO - mozprocess == 0.22 03:22:44 INFO - mozprofile == 0.28 03:22:44 INFO - mozrunner == 6.11 03:22:44 INFO - mozscreenshot == 0.1 03:22:44 INFO - mozsystemmonitor == 0.0 03:22:44 INFO - moztest == 0.7 03:22:44 INFO - mozversion == 1.4 03:22:44 INFO - psutil == 3.1.1 03:22:44 INFO - requests == 1.2.3 03:22:44 INFO - wsgiref == 0.1.2 03:22:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:22: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')]} 03:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:44 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:44 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 03:22:44 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 03:22:44 INFO - Using env: {'DISPLAY': ':0', 03:22:44 INFO - 'HOME': '/home/cltbld', 03:22:44 INFO - 'LANG': 'en_US.UTF-8', 03:22:44 INFO - 'LANGUAGE': 'en_US:en', 03:22:44 INFO - 'LOGNAME': 'cltbld', 03:22:44 INFO - 'MAIL': '/var/mail/cltbld', 03:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:44 INFO - 'MOZ_NO_REMOTE': '1', 03:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:44 INFO - 'NO_EM_RESTART': '1', 03:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:44 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:44 INFO - 'SHELL': '/bin/bash', 03:22:44 INFO - 'SHLVL': '1', 03:22:44 INFO - 'TERM': 'linux', 03:22:44 INFO - 'TMOUT': '86400', 03:22:44 INFO - 'USER': 'cltbld', 03:22:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:44 INFO - '_': '/tools/buildbot/bin/python'} 03:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 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)) 03:22:45 INFO - Cleaning up... 03:22:45 INFO - Return code: 0 03:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:22:45 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')]} 03:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:45 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')]} 03:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:45 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:45 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 03:22:45 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 03:22:45 INFO - Using env: {'DISPLAY': ':0', 03:22:45 INFO - 'HOME': '/home/cltbld', 03:22:45 INFO - 'LANG': 'en_US.UTF-8', 03:22:45 INFO - 'LANGUAGE': 'en_US:en', 03:22:45 INFO - 'LOGNAME': 'cltbld', 03:22:45 INFO - 'MAIL': '/var/mail/cltbld', 03:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:45 INFO - 'MOZ_NO_REMOTE': '1', 03:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:45 INFO - 'NO_EM_RESTART': '1', 03:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:45 INFO - 'SHELL': '/bin/bash', 03:22:45 INFO - 'SHLVL': '1', 03:22:45 INFO - 'TERM': 'linux', 03:22:45 INFO - 'TMOUT': '86400', 03:22:45 INFO - 'USER': 'cltbld', 03:22:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:45 INFO - '_': '/tools/buildbot/bin/python'} 03:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:45 INFO - Downloading/unpacking jsonschema 03:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:47 INFO - warning: no files found matching '*.txt' 03:22:47 INFO - no previously-included directories found matching 'build' 03:22:47 INFO - no previously-included directories found matching 'dist' 03:22:47 INFO - no previously-included directories found matching '.git*' 03:22:47 INFO - Installing collected packages: jsonschema, functools32 03:22:47 INFO - Running setup.py install for functools32 03:22:47 INFO - warning: no files found matching '*.txt' 03:22:47 INFO - no previously-included directories found matching 'build' 03:22:47 INFO - no previously-included directories found matching 'dist' 03:22:47 INFO - no previously-included directories found matching '.git*' 03:22:47 INFO - Successfully installed jsonschema functools32 03:22:47 INFO - Cleaning up... 03:22:47 INFO - Return code: 0 03:22:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:47 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 0x7f8963db3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, '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': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', '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 03:22:47 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 03:22:47 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 03:22:47 INFO - Using env: {'DISPLAY': ':0', 03:22:47 INFO - 'HOME': '/home/cltbld', 03:22:47 INFO - 'LANG': 'en_US.UTF-8', 03:22:47 INFO - 'LANGUAGE': 'en_US:en', 03:22:47 INFO - 'LOGNAME': 'cltbld', 03:22:47 INFO - 'MAIL': '/var/mail/cltbld', 03:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:47 INFO - 'MOZ_NO_REMOTE': '1', 03:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:47 INFO - 'NO_EM_RESTART': '1', 03:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:47 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:47 INFO - 'SHELL': '/bin/bash', 03:22:47 INFO - 'SHLVL': '1', 03:22:47 INFO - 'TERM': 'linux', 03:22:47 INFO - 'TMOUT': '86400', 03:22:47 INFO - 'USER': 'cltbld', 03:22:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:47 INFO - '_': '/tools/buildbot/bin/python'} 03:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:47 INFO - Downloading/unpacking flake8 03:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:50 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 03:22:50 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 03:22:50 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 03:22:50 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 03:22:50 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 03:22:50 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 03:22:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:50 INFO - no previously-included directories found matching 'docs/_build' 03:22:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:50 INFO - Running setup.py install for pep8 03:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:50 INFO - no previously-included directories found matching 'docs/_build' 03:22:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:22:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:50 INFO - Cleaning up... 03:22:50 INFO - Return code: 0 03:22:50 INFO - Running post-action listener: _resource_record_post_action 03:22:50 INFO - Running post-action listener: _start_resource_monitoring 03:22:50 INFO - Starting resource monitoring. 03:22:50 INFO - ##### 03:22:50 INFO - ##### Running install step. 03:22:50 INFO - ##### 03:22:50 INFO - Running pre-action listener: _resource_record_pre_action 03:22:50 INFO - Running main action method: install 03:22:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:22:50 INFO - Reading from file tmpfile_stdout 03:22:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:22:50 INFO - Reading from file tmpfile_stdout 03:22:50 INFO - Output received: 03:22:50 INFO - Usage: mozinstall [options] installer 03:22:50 INFO - Options: 03:22:50 INFO - -h, --help show this help message and exit 03:22:50 INFO - -d DEST, --destination=DEST 03:22:50 INFO - Directory to install application into. [default: 03:22:50 INFO - "/builds/slave/test-pgo"] 03:22:50 INFO - --app=APP Application being installed. [default: firefox] 03:22:50 INFO - mkdir: /builds/slave/test-pgo/build/application 03:22:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:23:05 INFO - Reading from file tmpfile_stdout 03:23:05 INFO - Output received: 03:23:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:23:05 INFO - Running post-action listener: _resource_record_post_action 03:23:05 INFO - ##### 03:23:05 INFO - ##### Running run-tests step. 03:23:05 INFO - ##### 03:23:05 INFO - Running pre-action listener: _resource_record_pre_action 03:23:05 INFO - Running main action method: run_tests 03:23:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:23:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:23:05 INFO - Python 2.7.3 03:23:05 INFO - Return code: 0 03:23:05 INFO - grabbing minidump binary from tooltool 03:23: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')]} 03:23:05 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 0x2c5b850>, '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 0x2bc7330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc77c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:23:05 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 03:23:05 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 03:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:06 INFO - Return code: 0 03:23:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:23:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:23:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:23:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:23:07 INFO - Return code: 0 03:23:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 03:23:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 03:23:07 INFO - Using env: {'DISPLAY': ':0', 03:23:07 INFO - 'HOME': '/home/cltbld', 03:23:07 INFO - 'LANG': 'en_US.UTF-8', 03:23:07 INFO - 'LANGUAGE': 'en_US:en', 03:23:07 INFO - 'LOGNAME': 'cltbld', 03:23:07 INFO - 'MAIL': '/var/mail/cltbld', 03:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:07 INFO - 'MOZ_NO_REMOTE': '1', 03:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:07 INFO - 'NO_EM_RESTART': '1', 03:23:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:23:07 INFO - 'SHELL': '/bin/bash', 03:23:07 INFO - 'SHLVL': '1', 03:23:07 INFO - 'TERM': 'linux', 03:23:07 INFO - 'TMOUT': '86400', 03:23:07 INFO - 'USER': 'cltbld', 03:23:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965', 03:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:07 INFO - '_': '/tools/buildbot/bin/python'} 03:23:07 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 03:23:07 INFO - mozversion application_buildid: 20160306004032 03:23:07 INFO - mozversion application_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 03:23:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:07 INFO - mozversion application_name: Firefox 03:23:07 INFO - mozversion application_remotingname: firefox-dev 03:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:07 INFO - mozversion application_vendor: Mozilla 03:23:07 INFO - mozversion application_version: 46.0a2 03:23:07 INFO - mozversion platform_buildid: 20160306004032 03:23:07 INFO - mozversion platform_changeset: 383d2c72f4c77a81d44704272dcfbbe3c8cafca8 03:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:07 INFO - mozversion platform_version: 46.0a2 03:23:07 INFO - using testdate: 1457263387 03:23:07 INFO - actual date: 1457263387 03:23:07 INFO - starting webserver on 'localhost:34352' 03:23:07 INFO - SUITE-START | Running 3 tests 03:23:07 INFO - TEST-START | dromaeo_css 03:23:07 INFO - operating with platform_type : linux_ 03:23:07 INFO - Initialising browser for dromaeo_css test... 03:23:07 INFO - TEST-INFO | started process 26528 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHzPRcA/profile http://localhost:34352/getInfo.html) 03:23:11 INFO - PROCESS | 26528 | __metrics Screen width/height:1600/1200 03:23:11 INFO - PROCESS | 26528 | colorDepth:24 03:23:11 INFO - PROCESS | 26528 | Browser inner width/height: 1024/697 03:23:11 INFO - PROCESS | 26528 | __metrics 03:23:11 INFO - PROCESS | 26528 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:23:12 INFO - TEST-INFO | 26528: exit 0 03:23:12 INFO - Browser initialized. 03:23:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:12 INFO - TEST-INFO | started process 26616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHzPRcA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:24 INFO - PROCESS | 26616 | RSS: Main: 138256384 03:23:24 INFO - PROCESS | 26616 | 03:24:15 INFO - PROCESS | 26616 | 1457263455822 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] 03:26:22 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34352/tests/dromaeo/cssquery-ext.html) 03:26:23 INFO - PROCESS | 26616 | RSS: Main: 242126848 03:26:23 INFO - PROCESS | 26616 | 03:29:26 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-ext.html (next: http://localhost:34352/tests/dromaeo/cssquery-jquery.html) 03:29:26 INFO - PROCESS | 26616 | RSS: Main: 219635712 03:29:26 INFO - PROCESS | 26616 | 03:32:28 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34352/tests/dromaeo/cssquery-mootools.html) 03:32:29 INFO - PROCESS | 26616 | RSS: Main: 220778496 03:32:29 INFO - PROCESS | 26616 | 03:35:31 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34352/tests/dromaeo/cssquery-prototype.html) 03:35:31 INFO - PROCESS | 26616 | RSS: Main: 200282112 03:35:31 INFO - PROCESS | 26616 | 03:38:34 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34352/tests/dromaeo/cssquery-yui.html) 03:38:34 INFO - PROCESS | 26616 | RSS: Main: 206368768 03:38:34 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | Cycle 1(1): loaded http://localhost:34352/tests/dromaeo/cssquery-yui.html (next: http://localhost:34352/tests/dromaeo/cssquery-dojo.html) 03:41:37 INFO - PROCESS | 26616 | RSS: Main: 222769152 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | __start_tp_report 03:41:37 INFO - PROCESS | 26616 | _x_x_mozilla_page_load 03:41:37 INFO - PROCESS | 26616 | _x_x_mozilla_page_load_details 03:41:37 INFO - PROCESS | 26616 | |i|pagename|runs| 03:41:37 INFO - PROCESS | 26616 | |0;dojo.html;3242.4001559711455;3273.2635157089644;3333.833308334584;3334.033130392185;3360.3447327771087;5209.609279304053;5223.190405487156;5232.633715639907;5234.345706786652;5285.497877701617;5159.406668233154;5174.939137476817;5189.792408303663;5194.532492075712;5284.841454756353;4747.8575642730775;4749.548792864673;4780.952190478086;4825.855224343275;4828;4688.906221875561;4779.569838714515;4783.497732738065;4800.087983283165;4876.487968763282;4830.372051633282;4860.05228980349;4863.051704917542;4865.172920603488;4887.706737595738;4791.880202994918;4826.95173048272;4851.151048566504;4855.684380515255;4882.780274887638;4683.437987441494;4712.458067322267;4720.173969555314;4733.313669517901;4786.976065119687;5087.236914462823;5101.948980510221;5122.359705036871;5147.356580427447;5164.889548747;5520.1167813149705;5659.066254068074;5691.146328050784;5698;5708.0581704019205;5573.554115670737;5596.580256480739;5638.379778224392;5657.915131273035;5693.430656934315;5236.162214045735;5256.342957130359;5264.6051546134195;5271.235670827708;5272.446393128743;5629.662220266797;5667;5685.5167310778215;5686.829395118153;5689.943100569024;5440.183972404092;5510.614257001971;5513.421090785409;5518.972405137949;5552;5642.6614403135945;5663.32040155184;5665.433456654301;5670.773169073191;5673.120666296731;5505.146702261156;5590.105583106765;5623.775048998076;5636.577256705681;5662.943370566324;5617.325920889438;5625;5625.774969001276;5631.408702086222;5645.661260324394;4333.978330108393;4344.261475549164;4348.173846969065;4349.217140914602;4370.082282720664;3867.878315288535;3881.708871834567;3928.8035598219976;3941.467901833273;3953.6639385651965;5356.5714742821265;5400.405955344909;5415.323084614423;5418.864528386822;5424.267723857308;5736.856578585569;5740.6268592541355;5740.827775166752;5741.712914354265;5766.192733017381;5189.4032186299055;5209.140491818884;5230.0585894539345;5254.369475662868;5319.5744340452675;4844.612431005582;4907.852764417074;4911.607071434348;4915.21356582945;4942.555170034714;5532.446755324436;5846.035404158351;5889.646621202742;5893.5874488785375;5895.734691938873;5597.580181486486;5641.774329026793;5650.943490565041;5661.716914154358;5698.0598201296325;5717.142428635571;5792.1311803229855;5809.651420914759;5830.970845145747;5831.912521312099;5471.863203419946;5538.556915446674;5557.499825015768;5609.24275222856;5611.8877622448135;5641.210230567806;5648;5653.886922261614;5655.123455864347;5754.53963682896;5397.136458166675;5436.130219164915;5445;5445.1832225166545;5446.564274858081;5409.6213265071065;5437.13005919051;5481.013417584873;5486.835394938158;5509.779608815603;5389.434109418455;5425.403205647454;5429;5438.15708565173;5451.64564303319;5442.183672449164;5492.5605951524585;5496.203050557567;5497.725113744217;5531.612787105025;5328.626996110235;5340.439253878287;5386.084365657926;5412.161115027019;5423.267858839006 03:41:37 INFO - PROCESS | 26616 | |1;ext.html;536.7450461031011;566.2666846433867;584.6258394627439;586.01549397013;594.8275000249926;33109.99999999997;33362.16594585137;33407.16482087946;33652.66347336526;41799.164016719646;46082.769586152106;47036.52963470364;47230.527694723045;47288;47413.76293118538;8976.820463590724;9156.313276504256;9160.587773550173;9162.633494660206;9190.678326258583;8838.602262898185;8975.730728078135;8989.325800564951;8991.595378207963;8991.685291014815;8995.055519170492;9071.909280907206;9081.364304498687;9093;9093.727188184364;8921.95539022304;9024.548772561346;9024.729258122234;9025.909740902573;9031.367804253705;8930.821383572356;9042.095790420904;9077.63689452421;9081.727548173565;9082.909170908273;41985.58014419878;42546.787266063475;42662.146757064686;42713.145737085084;42813;3611.1694310308776;3716.1081340478363;3998.260321840469;4074.327735923569;4201.663866890642;32415.51376729351;32639.18402039968;32666.510002349984;32939.6706032939;33035.33929321424;4248.745075295492;4256.489221293434;4283.75907851225;4317.805698743564;4350.869473915787;366654;374418;374575;374670;375179;56649.71675141598;56985.43014569884;57119.71521139108;60650.39349606536;61772;58029.4197058024;69996;70764;70862.2913770866;70924.29075709177;17146;17398.565035874206;17424.303027878996;17438.65122697539;17480.5629859252;11486.885131148581;11653.18427710069;13413.128146670435;13476.124051936593;13707.862921370857;20501.38495845127;21792.128314867547;21832.23587174473;21846.45383865416;21908.671369929463;8038.397120216007;8149.511029338259;8163.265306122477;8282;8368.163183681583;1048.7116043088213;1122.9243817942852;1158.8030034894089;1166.9241499302518;1178.0987544528443;29683.703162968526;30176.84911575428;30231.848840756094;30746.385072298428;31267.37465250728;1180.4923882730336;1203.0315595945174;1232.7287996640725;1242.1180961517423;1265.6013355792895;15237.510156358358;15820.604484887739;16039.198040097948;16601.584960375847;18046.501412612906;457260;460936;461334;461581;463993;59925.10112348318;60504;60543.39456605466;60554.39445605576;60574;1418.581518452059;1432.5917113622777;1435.7487439698011;1438.7266419380285;1443.487561915526;33122.83438582792;33141.337173256885;33212.83393583017;33355.16612084717;34327.4850877232;50268.49731502638;50707;51027;51028;51045.74477127591;341244;343329;343375;343973;344219;28542.42915141727;28688;34055;35003.29993400168;35054;40046.799766000986;43854;45632.54367456283;50832.74583627058;51750.482495176075;36050.09874753152;37042.444363334034;38447.615523844404;40389.79805100956;40718.59281407148;39080.60919390884;39774.80112599534;40344.596554034084;40508.59491405048;40574.39138412867;38762.80618596889;39228;43548.34677479777;44017.559824402626;44047.55952440434;29500.409991799614;32931.67068329286;33752.66247337593;39178.41232381573;41497.1700565993;27240.863795680896;27946.47529341342;28084.297892552033;28211.71788282091;29146.854265729384 03:41:37 INFO - PROCESS | 26616 | |2;jquery.html;382.69002108292284;384.6768714280004;387.8002828543301;392.319325969443;396.75401251224247;14418.523416252921;16054.197290135477;16796;19389.32137375192;19390.418287451364;17940.55148621285;18157;18565.164567594456;18570.16434260458;18579.44261672152;5998.7600495980105;6179.81460556184;6183.072539119124;6207;6219.067139929001;4558.452985641711;4724.267738500538;6143.385661433866;6561.8031459056065;6866.588004719708;6583.3087525809815;6757.729690812386;6782.389584937355;6834.794956151323;6860.416864566493;5379.946200537984;6770.72917083316;6782.2200446948245;6785.287544807823;6818.1136452261135;5386.542143917772;5386.542143917772;5397.4062853086125;5399.811006614789;5400.729963501809;11708;12075.154739168262;12146.878531214663;12159.392030398445;14515.491957781533;2266.5240299537118;2271.3640180749417;2280.5175249153017;2284.0749496453795;2366.2782851230368;9772.26707996896;10013.59945602175;10195.745106372326;10225.233107516891;10288.074073333435;1877.4649224970954;1932.120884997323;1952.160570954489;1986.99006504968;2027.3816485971772;59463.70268148675;59667.70166149185;61111;61429.6928515359;61803.69098154525;10593.205509586813;10928.945355273332;10991.395473249047;11004.779904401867;11032.889671103187;14536;14600.634984125481;14625.195614241105;14632.19522926228;14641.707165856624;8313.12712165214;8465.068842427328;8470.830583388297;8526.147385261424;8533.359998000175;8113.472624279403;8118.188181181835;8161.469504482189;8259.917400825914;8290.41967062312;4476.26141686618;4614.307853821953;4775.235962246094;4885.340479035356;4911.705297682151;1897.9905100474684;1948.8733232339853;1956.9315073972343;1957.351290684624;1970.1626808606286;976.2824324121765;1037.092544023979;1072.7908057928785;1109.1514991031868;1121.265571050963;14493.637659058397;15251.161186134646;16426.917865410836;16510.917445412695;16887.493375198763;1014.9746256343503;1054.0987455725244;1087.5704096881846;1103.8454616353717;1117.8938000890066;8528.488290702579;10009.349392289623;10015.849762253572;10075.848862267072;10088.293819432569;555198;556339;559207;576945;629405;64003.03995439979;70743;75808.62095689596;76095.61952190203;76222.23777762262;1173.2373956927895;1203.5667159822458;1206.0351718625066;1213.0416970593133;1223.113242898909;15508.457203997807;15714.685706286038;15756;15848.92075539615;15966.361345546047;31822.204444889063;32255.51616725704;32917;33748;34730.652693472744;42552;42674.78662606667;43178.13643727045;43865.34201987037;44525;7288.3440490354005;7311.597862117422;7387.7783666490095;7413.332800048021;7736;8120.832875178567;9603.759906002406;10803.45982700846;10917.945410272898;11407.25852819564;9996.3002589818;10021;10054.64808731691;10223.948880255552;10300.124489418184;9999.000099989942;10063.29556931037;10239.7440063999;10420.583176672848;10451.843222351823;10188.388696678223;10240.948795255976;10453.320534165256;10487.423191724529;10538.367697938149;7560.508566943131;7595;7596.620168991418;7608.80977975555;7871.212878712083;9519.190868776232;10195.490225488844;10423.374597524173;10578.259521833397;10712.464376781285 03:41:37 INFO - PROCESS | 26616 | |3;mootools.html;1415.7380884536356;1522.7791970164326;1541.5529496446031;1729.8097209306975;1861.8324350808425;7698.692052317908;8350.791230219247;8466.999999999993;8476.15238476152;8481.279091277233;8297.958510207456;8476.957615211932;8496.022957359906;8502.064772874994;8505.362097842672;2146.549224662823;2201.3836125884777;2205.305328821424;2400.939976500584;2428.6842710447704;2427.7693619106158;2496.588062969617;2497.2008957133635;2497.9750202497926;2501.8498890066653;2381.1903952656094;2417.4802417480237;2427.356750461129;2429.210506585358;2431.4772323950438;2085.009620430291;2135.284679632325;2327.662488939094;2384.8569085854906;2396.952060958771;2407.723111842143;2407.9759202407927;2442.218490083174;2447.7919376852988;2447.8041756659422;8384.03583587889;8417.158284171534;8420.242178203991;8453.070162282143;8461.0269818971;5002.274670172805;5117.7185254810975;5128.1282182029145;5129.820456284049;5136.332276804029;3290.7038366546885;3303.7687361884678;3316.6849149330774;3334.216459132102;3390.0677313738674;1121.6130434999993;1122.9943850280697;1144.0733006264952;1149.9712507187303;1172.724409763705;12094.516219351215;12123.21199122063;12124.27254364741;12124.757504849853;12141.028717702562;4609.078184363141;4615.676902616851;4663.160631086437;4671.48613652498;4688.437387513521;10314.071733544017;10320.587176512856;10320.741981450525;10323.432211228455;10336.121429678562;5190.532852043334;5218.7912483500995;5227.921581176285;5232.659877107976;5238;4744.857654270378;4748.335233067373;4748.358971538798;4758.714477131383;4768.47546769855;4003.819828107742;4005.5994400560294;4008.8797336079965;4040;4065.0447144920918;1207.3963018490754;1224.5958833584896;1234.5555599983998;1236.0544183699476;1236.4065248680683;1066.3548553125402;1112.076976109827;1135.437958210691;1139.1911742662637;1361.5915225432332;7149.356557909813;7970.9202907970175;8093.8381232376205;8098.392620553482;8133.755987320272;519.6440438299777;529.7245432375144;1248.2260998181187;1296.6369416563377;1298.461138627478;6280.183576135073;6328.905066423915;6429.903551446639;6434.935650643527;6440.871182576322;10085.697429076992;10314.1748660107;10503.317284376491;10513.579456821795;10521.947390263;9699.418034917928;10341.534630941625;10350.482475876326;10361.274710770174;10366.222533310032;8008.519488830689;8042.437029408003;8052.879206811903;8142.389320800845;8150.999999999882;7984.600769961363;8016.238457346542;8138.104808471182;8185.4270201085355;8205.95897020511;9266.629334826532;9293.535323233946;9330.066993300887;9387.85918211241;9435.905640943778;9473.621055157717;9557.713268601952;9702.417854928726;10016.799664006534;10016.849747253942;7764.883526747216;7797.571133587707;7807.921920780719;7954.761357159295;7956.085050219067;8202.876956845772;8244.340452763885;8266.214709602578;8288.917110828814;8309.95845020771;7814.765557033298;7840.451168418156;7946.284834364935;8041.798955026171;8129.878051829109;7795.376369890509;7799.9220007799195;7841.372690184886;7917.802054948673;7924.722634707758;6667.333266673294;6812.863742725217;7959.323457505945;7984.081830589556;8009.279164875189;6855.691493882887;6956.652167391711;6996.790096297119;7002.4398048157045;7004.334588214316;7146.3568278855155;7173.784786456415;7214.134303883568;7240.493165478577;7244.89132663 03:41:37 INFO - PROCESS | 26616 | |4;prototype.html;365.87011610878136;367.9779213247207;370.55348305292125;374.35984466562167;374.533705536607;5855.531557475402;5886.529077673787;5891.998360278758;5897.262842144732;5931.406859314077;5671.2060311556415;5690.5447564194865;5762.222100016507;5804;5932.525397968163;4604.401427814396;4629.305604159386;4635.605973492257;4636.327732478789;4642.8375006874685;4451.421315229016;4648.48866624671;4652.395188625474;4659.277811939155;4673.8831529211875;4498.595126438619;4517.209488339544;4603.217453032976;4620.584147426731;4634.976825115869;4595.632349412039;4648.279516674921;4648.349231107648;4654.4647365553055;4659.881628409191;4152.8131234094535;4157.833686652531;4158.043649960496;4159.209750147463;4165.083681590046;5611.410801865786;5661.8584535386535;5685.289338832646;5685.431456854323;5694.2312787773535;5391.514763671288;5402.756875940592;5407.215953686733;5408.080626293539;5410.269613602152;6281.623102613812;6284.591501552431;6300.873982520324;6304.747810087591;6307.842303942392;4574.748388838612;4576.427946506687;4577.496475387705;4577.633789296849;4577.656675749332;6440;6498.285188629247;6562.245341785708;6562.753076915323;6586.143801305848;4715.269133284346;4717.914879577647;4720.197566413718;4724.692894961817;4737.099951009297;4799.616030717534;4808.711477311373;4809.879753006133;4811.109944660249;4819.518048195223;5412.972935135378;5419.647722897999;5424.701641409761;5431.891362172734;5437.429069947678;6148.9692551536955;6378;6381.074744162071;6389.722055588901;6390.968045159838;1675.572728954109;1700.5663555793194;1701.4555342290596;1705.6759215748968;1705.8379453951854;1153.5616465743133;1184.7748927703708;1188.756304957499;1204.175140029083;1207.1791181996327;6080.331163572004;6092.847678807977;6094.939050609526;6095.75616975316;6099.817005489843;6387.584806987531;6533.673316334164;6534.705938232791;6547.803565893031;6553.803385898431;5960.105984102419;6015.608985415934;6035.2154219952;6085.543584231112;6156.891759483336;3495.2485215678753;3543;3547.8048707321345;3548.556430446194;3548.6628770266784;6589.209294884645;6780.72877084911;6783.660816959133;6785.389314961677;6789.932100679029;6755.831104222434;6766.221884483249;6768.526203165731;6768.593884366954;6773;6754.257031726506;6777.220619628707;6785.457163426914;6789.524733268722;6790.117284752951;6455.483561315177;6591.604503729792;6597.109390232449;6598.802035938929;6606.8017959461295;6491.675416229075;6491.805245842632;6492.870142597216;6502;6506.869862602816;6782.525223234326;6783.898241526283;6788.25329213796;6788.355106264897;6789.524733268624;4756.881077973078;4768.737719425465;4771.117343291502;4774.806298425394;4775.283707443911;6398.648074355955;6570.145881035626;6571.638559879252;6572.112764776885;6591.077249185214;6400.807975760735;6408.9038664421005;6409.4231519163495;6415.486761059011;6419.26178489461;6276.74893004293;6393.552451328363;6394.136791533084;6396.360363963567;6398.5201109916015;6252.09344645033;6262.53031022666;6263.4362907338555;6271.310155882758;6273.74905003813;6358.078078678658;6362.268339141058;6365.458935990493;6369.267534233437;6371.5221358397375;6093.421124993119;6180.721867515883;6201;6216.316205217513;6234.345393733593 03:41:37 INFO - PROCESS | 26616 | |5;yui.html;811.0672726364681;842.5239739547155;903.4985583001431;910.7404389748923;924.884389451319;14752.852471475282;14930.178840163786;15037.774433383507;15048.87133464989;15070.095794252353;13829.239391833446;14252.572422827332;14256.643583910407;14266.144031358126;14274.357653905574;742.0724094881398;746.138210367027;847.7414388611471;862.6506264962669;870.2559311788425;862.3058437957442;868.9044205137429;868.9652413903436;869.3306154261215;869.6695255802786;891.3493150000503;891.9687810926619;895.2166854002747;895.6238379880466;895.9552022398886;771.3559178086305;779.3764988009598;898.1602201941206;908.4458480326995;909.5861383070687;655.4559715436225;662.8110988368292;672.451951659401;672.8217022489044;673.0409166937095;13111.934440327737;13188.406521706545;13189.274589897552;13201.669958251121;13205.669858253525;14165.150090994573;14232.715345693028;14494.71010579793;14519.564413067625;14522.782158267635;11392.886071139348;11407.885921140765;11518.308901465854;11557.76884462306;11661.650150495414;3857.7492462989817;3905.2384784966944;3952.268830266381;3955.881323560298;3958.623930726605;53301.46698533004;53552.73223633896;54849;55070.173947391224;55104.448955510336;10653.467326633638;10727.92720727921;10870.347779133277;10947;10997.450127493594;17498.91250543739;17528.12359382026;17595.56011099733;17608.735868961976;17620.295188192584;7980.68077276914;8044.477108987897;8063.233992770677;8105.918940810634;8252.876206856901;4486.685931984795;4521.412216411845;4550.47669518003;4579.267317229227;4668.066386722669;3249;3254.365398747269;3276.2955964467756;3277.7869438486423;3282.40916635008;577.2870504926412;587.632729544035;589.375262222046;599.6312267955176;605.8757954619292;602.7829981206762;638.2213699286863;668.6155460610169;744.5383862005591;772.748856621589;8590.398672092893;9953.452560109263;10022.498875056219;10092.04125608066;10250.641227557;583.4894467341077;621.8631900981867;645.8062581225613;709.8686742952467;741.6032422653855;4476.239039363316;4513.345564893072;4538.909221815611;4544.068465964469;4554.43069616298;59427.10859337114;61633.075503867476;62106.68946655238;62227;63192.368076319566;52118.47881521212;54037;54213.45786542163;56330.155047674314;56448.71775641095;47862.52137478581;48322;48451.27323090156;48946.51053489491;49990.25014624783;9464.716058518256;9582.089701478348;9755.589087876957;9953.601855925683;10038.397696138256;35267;37334.25331493409;37919.62080379161;38007.61992380151;38697.4195387075;45486.772566136955;45884.54115458803;46529.30206046844;47105.05789884252;49901;11952.223105498115;12002.099842511672;12468.563600273947;12984.67982471383;13222.933885330513;13883.514077007256;13887.375068121757;14019.369128389042;14064.08583442073;14212.715745684822;12446.128770986306;12720.554780582635;13154.934225328812;13179.60461186166;13261.270630115436;13126.278054707083;13227.272500012592;13232.470701172231;13315.800262995868;13394;12791.360431978177;13017.674558136123;13185.73628527405;13227.470901163846;13299.26854023038;10033.344797164957;10335.17318614494;10519.526621302213;10676.62631807883;10696.679099627023;9951.303408761318;9960.053794889474;9977.151942084714;10046.748831279276;10529.526171322155 03:41:37 INFO - PROCESS | 26616 | __end_tp_report 03:41:37 INFO - PROCESS | 26616 | __start_cc_report 03:41:37 INFO - PROCESS | 26616 | _x_x_mozilla_cycle_collect,797 03:41:37 INFO - PROCESS | 26616 | __end_cc_report 03:41:37 INFO - PROCESS | 26616 | __startTimestamp1457264497257__endTimestamp 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | ------- Summary: start ------- 03:41:37 INFO - PROCESS | 26616 | Number of tests: 6 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#0] dojo.html Cycles:165 Average:5234.39 Median:5424.27 stddev:554.06 (10.2%) stddev-sans-first:533.27 03:41:37 INFO - PROCESS | 26616 | Values: 3242.4 3273.3 3333.8 3334.0 3360.3 5209.6 5223.2 5232.6 5234.3 5285.5 5159.4 5174.9 5189.8 5194.5 5284.8 4747.9 4749.5 4781.0 4825.9 4828.0 4688.9 4779.6 4783.5 4800.1 4876.5 4830.4 4860.1 4863.1 4865.2 4887.7 4791.9 4827.0 4851.2 4855.7 4882.8 4683.4 4712.5 4720.2 4733.3 4787.0 5087.2 5101.9 5122.4 5147.4 5164.9 5520.1 5659.1 5691.1 5698.0 5708.1 5573.6 5596.6 5638.4 5657.9 5693.4 5236.2 5256.3 5264.6 5271.2 5272.4 5629.7 5667.0 5685.5 5686.8 5689.9 5440.2 5510.6 5513.4 5519.0 5552.0 5642.7 5663.3 5665.4 5670.8 5673.1 5505.1 5590.1 5623.8 5636.6 5662.9 5617.3 5625.0 5625.8 5631.4 5645.7 4334.0 4344.3 4348.2 4349.2 4370.1 3867.9 3881.7 3928.8 3941.5 3953.7 5356.6 5400.4 5415.3 5418.9 5424.3 5736.9 5740.6 5740.8 5741.7 5766.2 5189.4 5209.1 5230.1 5254.4 5319.6 4844.6 4907.9 4911.6 4915.2 4942.6 5532.4 5846.0 5889.6 5893.6 5895.7 5597.6 5641.8 5650.9 5661.7 5698.1 5717.1 5792.1 5809.7 5831.0 5831.9 5471.9 5538.6 5557.5 5609.2 5611.9 5641.2 5648.0 5653.9 5655.1 5754.5 5397.1 5436.1 5445.0 5445.2 5446.6 5409.6 5437.1 5481.0 5486.8 5509.8 5389.4 5425.4 5429.0 5438.2 5451.6 5442.2 5492.6 5496.2 5497.7 5531.6 5328.6 5340.4 5386.1 5412.2 5423.3 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#1] ext.html Cycles:180 Average:56479.91 Median:40449.20 stddev:104279.88 (257.8%) stddev-sans-first:104487.82 03:41:37 INFO - PROCESS | 26616 | Values: 536.7 566.3 584.6 586.0 594.8 33110.0 33362.2 33407.2 33652.7 41799.2 46082.8 47036.5 47230.5 47288.0 47413.8 8976.8 9156.3 9160.6 9162.6 9190.7 8838.6 8975.7 8989.3 8991.6 8991.7 8995.1 9071.9 9081.4 9093.0 9093.7 8922.0 9024.5 9024.7 9025.9 9031.4 8930.8 9042.1 9077.6 9081.7 9082.9 41985.6 42546.8 42662.1 42713.1 42813.0 3611.2 3716.1 3998.3 4074.3 4201.7 32415.5 32639.2 32666.5 32939.7 33035.3 4248.7 4256.5 4283.8 4317.8 4350.9 366654.0 374418.0 374575.0 374670.0 375179.0 56649.7 56985.4 57119.7 60650.4 61772.0 58029.4 69996.0 70764.0 70862.3 70924.3 17146.0 17398.6 17424.3 17438.7 17480.6 11486.9 11653.2 13413.1 13476.1 13707.9 20501.4 21792.1 21832.2 21846.5 21908.7 8038.4 8149.5 8163.3 8282.0 8368.2 1048.7 1122.9 1158.8 1166.9 1178.1 29683.7 30176.8 30231.8 30746.4 31267.4 1180.5 1203.0 1232.7 1242.1 1265.6 15237.5 15820.6 16039.2 16601.6 18046.5 457260.0 460936.0 461334.0 461581.0 463993.0 59925.1 60504.0 60543.4 60554.4 60574.0 1418.6 1432.6 1435.7 1438.7 1443.5 33122.8 33141.3 33212.8 33355.2 34327.5 50268.5 50707.0 51027.0 51028.0 51045.7 341244.0 343329.0 343375.0 343973.0 344219.0 28542.4 28688.0 34055.0 35003.3 35054.0 40046.8 43854.0 45632.5 50832.7 51750.5 36050.1 37042.4 38447.6 40389.8 40718.6 39080.6 39774.8 40344.6 40508.6 40574.4 38762.8 39228.0 43548.3 44017.6 44047.6 29500.4 32931.7 33752.7 39178.4 41497.2 27240.9 27946.5 28084.3 28211.7 29146.9 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#2] jquery.html Cycles:180 Average:28845.49 Median:2325.18 stddev:94059.38 (4045.3%) stddev-sans-first:94298.96 03:41:37 INFO - PROCESS | 26616 | Values: 382.7 384.7 387.8 392.3 396.8 14418.5 16054.2 16796.0 19389.3 19390.4 17940.6 18157.0 18565.2 18570.2 18579.4 5998.8 6179.8 6183.1 6207.0 6219.1 4558.5 4724.3 6143.4 6561.8 6866.6 6583.3 6757.7 6782.4 6834.8 6860.4 5379.9 6770.7 6782.2 6785.3 6818.1 5386.5 5386.5 5397.4 5399.8 5400.7 11708.0 12075.2 12146.9 12159.4 14515.5 2266.5 2271.4 2280.5 2284.1 2366.3 9772.3 10013.6 10195.7 10225.2 10288.1 1877.5 1932.1 1952.2 1987.0 2027.4 59463.7 59667.7 61111.0 61429.7 61803.7 10593.2 10928.9 10991.4 11004.8 11032.9 14536.0 14600.6 14625.2 14632.2 14641.7 8313.1 8465.1 8470.8 8526.1 8533.4 8113.5 8118.2 8161.5 8259.9 8290.4 4476.3 4614.3 4775.2 4885.3 4911.7 1898.0 1948.9 1956.9 1957.4 1970.2 976.3 1037.1 1072.8 1109.2 1121.3 14493.6 15251.2 16426.9 16510.9 16887.5 1015.0 1054.1 1087.6 1103.8 1117.9 8528.5 10009.3 10015.8 10075.8 10088.3 555198.0 556339.0 559207.0 576945.0 629405.0 64003.0 70743.0 75808.6 76095.6 76222.2 1173.2 1203.6 1206.0 1213.0 1223.1 15508.5 15714.7 15756.0 15848.9 15966.4 31822.2 32255.5 32917.0 33748.0 34730.7 42552.0 42674.8 43178.1 43865.3 44525.0 7288.3 7311.6 7387.8 7413.3 7736.0 8120.8 9603.8 10803.5 10917.9 11407.3 9996.3 10021.0 10054.6 10223.9 10300.1 9999.0 10063.3 10239.7 10420.6 10451.8 10188.4 10240.9 10453.3 10487.4 10538.4 7560.5 7595.0 7596.6 7608.8 7871.2 9519.2 10195.5 10423.4 10578.3 10712.5 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#3] mootools.html Cycles:180 Average:6012.52 Median:5122.92 stddev:3194.83 (62.4%) stddev-sans-first:3185.10 03:41:37 INFO - PROCESS | 26616 | Values: 1415.7 1522.8 1541.6 1729.8 1861.8 7698.7 8350.8 8467.0 8476.2 8481.3 8298.0 8477.0 8496.0 8502.1 8505.4 2146.5 2201.4 2205.3 2400.9 2428.7 2427.8 2496.6 2497.2 2498.0 2501.8 2381.2 2417.5 2427.4 2429.2 2431.5 2085.0 2135.3 2327.7 2384.9 2397.0 2407.7 2408.0 2442.2 2447.8 2447.8 8384.0 8417.2 8420.2 8453.1 8461.0 5002.3 5117.7 5128.1 5129.8 5136.3 3290.7 3303.8 3316.7 3334.2 3390.1 1121.6 1123.0 1144.1 1150.0 1172.7 12094.5 12123.2 12124.3 12124.8 12141.0 4609.1 4615.7 4663.2 4671.5 4688.4 10314.1 10320.6 10320.7 10323.4 10336.1 5190.5 5218.8 5227.9 5232.7 5238.0 4744.9 4748.3 4748.4 4758.7 4768.5 4003.8 4005.6 4008.9 4040.0 4065.0 1207.4 1224.6 1234.6 1236.1 1236.4 1066.4 1112.1 1135.4 1139.2 1361.6 7149.4 7970.9 8093.8 8098.4 8133.8 519.6 529.7 1248.2 1296.6 1298.5 6280.2 6328.9 6429.9 6434.9 6440.9 10085.7 10314.2 10503.3 10513.6 10521.9 9699.4 10341.5 10350.5 10361.3 10366.2 8008.5 8042.4 8052.9 8142.4 8151.0 7984.6 8016.2 8138.1 8185.4 8206.0 9266.6 9293.5 9330.1 9387.9 9435.9 9473.6 9557.7 9702.4 10016.8 10016.8 7764.9 7797.6 7807.9 7954.8 7956.1 8202.9 8244.3 8266.2 8288.9 8310.0 7814.8 7840.5 7946.3 8041.8 8129.9 7795.4 7799.9 7841.4 7917.8 7924.7 6667.3 6812.9 7959.3 7984.1 8009.3 6855.7 6956.7 6996.8 7002.4 7004.3 7146.4 7173.8 7214.1 7240.5 7244.9 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#4] prototype.html Cycles:180 Average:5348.81 Median:5987.86 stddev:1561.22 (26.1%) stddev-sans-first:1520.14 03:41:37 INFO - PROCESS | 26616 | Values: 365.9 368.0 370.6 374.4 374.5 5855.5 5886.5 5892.0 5897.3 5931.4 5671.2 5690.5 5762.2 5804.0 5932.5 4604.4 4629.3 4635.6 4636.3 4642.8 4451.4 4648.5 4652.4 4659.3 4673.9 4498.6 4517.2 4603.2 4620.6 4635.0 4595.6 4648.3 4648.3 4654.5 4659.9 4152.8 4157.8 4158.0 4159.2 4165.1 5611.4 5661.9 5685.3 5685.4 5694.2 5391.5 5402.8 5407.2 5408.1 5410.3 6281.6 6284.6 6300.9 6304.7 6307.8 4574.7 4576.4 4577.5 4577.6 4577.7 6440.0 6498.3 6562.2 6562.8 6586.1 4715.3 4717.9 4720.2 4724.7 4737.1 4799.6 4808.7 4809.9 4811.1 4819.5 5413.0 5419.6 5424.7 5431.9 5437.4 6149.0 6378.0 6381.1 6389.7 6391.0 1675.6 1700.6 1701.5 1705.7 1705.8 1153.6 1184.8 1188.8 1204.2 1207.2 6080.3 6092.8 6094.9 6095.8 6099.8 6387.6 6533.7 6534.7 6547.8 6553.8 5960.1 6015.6 6035.2 6085.5 6156.9 3495.2 3543.0 3547.8 3548.6 3548.7 6589.2 6780.7 6783.7 6785.4 6789.9 6755.8 6766.2 6768.5 6768.6 6773.0 6754.3 6777.2 6785.5 6789.5 6790.1 6455.5 6591.6 6597.1 6598.8 6606.8 6491.7 6491.8 6492.9 6502.0 6506.9 6782.5 6783.9 6788.3 6788.4 6789.5 4756.9 4768.7 4771.1 4774.8 4775.3 6398.6 6570.1 6571.6 6572.1 6591.1 6400.8 6408.9 6409.4 6415.5 6419.3 6276.7 6393.6 6394.1 6396.4 6398.5 6252.1 6262.5 6263.4 6271.3 6273.7 6358.1 6362.3 6365.5 6369.3 6371.5 6093.4 6180.7 6201.0 6216.3 6234.3 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - PROCESS | 26616 | [#5] yui.html Cycles:180 Average:14936.52 Median:4541.49 stddev:17113.12 (376.8%) stddev-sans-first:17128.25 03:41:37 INFO - PROCESS | 26616 | Values: 811.1 842.5 903.5 910.7 924.9 14752.9 14930.2 15037.8 15048.9 15070.1 13829.2 14252.6 14256.6 14266.1 14274.4 742.1 746.1 847.7 862.7 870.3 862.3 868.9 869.0 869.3 869.7 891.3 892.0 895.2 895.6 896.0 771.4 779.4 898.2 908.4 909.6 655.5 662.8 672.5 672.8 673.0 13111.9 13188.4 13189.3 13201.7 13205.7 14165.2 14232.7 14494.7 14519.6 14522.8 11392.9 11407.9 11518.3 11557.8 11661.7 3857.7 3905.2 3952.3 3955.9 3958.6 53301.5 53552.7 54849.0 55070.2 55104.4 10653.5 10727.9 10870.3 10947.0 10997.5 17498.9 17528.1 17595.6 17608.7 17620.3 7980.7 8044.5 8063.2 8105.9 8252.9 4486.7 4521.4 4550.5 4579.3 4668.1 3249.0 3254.4 3276.3 3277.8 3282.4 577.3 587.6 589.4 599.6 605.9 602.8 638.2 668.6 744.5 772.7 8590.4 9953.5 10022.5 10092.0 10250.6 583.5 621.9 645.8 709.9 741.6 4476.2 4513.3 4538.9 4544.1 4554.4 59427.1 61633.1 62106.7 62227.0 63192.4 52118.5 54037.0 54213.5 56330.2 56448.7 47862.5 48322.0 48451.3 48946.5 49990.3 9464.7 9582.1 9755.6 9953.6 10038.4 35267.0 37334.3 37919.6 38007.6 38697.4 45486.8 45884.5 46529.3 47105.1 49901.0 11952.2 12002.1 12468.6 12984.7 13222.9 13883.5 13887.4 14019.4 14064.1 14212.7 12446.1 12720.6 13154.9 13179.6 13261.3 13126.3 13227.3 13232.5 13315.8 13394.0 12791.4 13017.7 13185.7 13227.5 13299.3 10033.3 10335.2 10519.5 10676.6 10696.7 9951.3 9960.1 9977.2 10046.7 10529.5 03:41:37 INFO - PROCESS | 26616 | -------- Summary: end -------- 03:41:37 INFO - PROCESS | 26616 | 03:41:37 INFO - TEST-INFO | 26616: exit 0 03:41:37 INFO - TEST-OK | dromaeo_css | took 1110551ms 03:41:37 INFO - TEST-START | kraken 03:41:37 INFO - operating with platform_type : linux_ 03:41:37 INFO - Initialising browser for kraken test... 03:41:37 INFO - TEST-INFO | started process 26810 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYrrOX4/profile http://localhost:34352/getInfo.html) 03:41:41 INFO - PROCESS | 26810 | __metrics Screen width/height:1600/1200 03:41:41 INFO - PROCESS | 26810 | colorDepth:24 03:41:41 INFO - PROCESS | 26810 | Browser inner width/height: 1024/697 03:41:41 INFO - PROCESS | 26810 | __metrics 03:41:41 INFO - PROCESS | 26810 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:42 INFO - TEST-INFO | 26810: exit 0 03:41:42 INFO - Browser initialized. 03:41:42 INFO - Running cycle 1/1 for kraken test... 03:41:42 INFO - TEST-INFO | started process 26895 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYrrOX4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:54 INFO - PROCESS | 26895 | RSS: Main: 138612736 03:41:54 INFO - PROCESS | 26895 | 03:41:57 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34352/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:57 INFO - PROCESS | 26895 | RSS: Main: 171814912 03:41:57 INFO - PROCESS | 26895 | 03:42:00 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34352/tests/kraken/driver.html?testName=audio-dft) 03:42:00 INFO - PROCESS | 26895 | RSS: Main: 171491328 03:42:00 INFO - PROCESS | 26895 | 03:42:03 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34352/tests/kraken/driver.html?testName=audio-fft) 03:42:04 INFO - PROCESS | 26895 | RSS: Main: 169078784 03:42:04 INFO - PROCESS | 26895 | 03:42:06 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34352/tests/kraken/driver.html?testName=audio-oscillator) 03:42:06 INFO - PROCESS | 26895 | RSS: Main: 169410560 03:42:06 INFO - PROCESS | 26895 | 03:42:08 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:09 INFO - PROCESS | 26895 | RSS: Main: 167182336 03:42:09 INFO - PROCESS | 26895 | 03:42:12 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34352/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:12 INFO - PROCESS | 26895 | RSS: Main: 166756352 03:42:12 INFO - PROCESS | 26895 | 03:42:16 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34352/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:16 INFO - PROCESS | 26895 | RSS: Main: 167780352 03:42:16 INFO - PROCESS | 26895 | 03:42:19 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34352/tests/kraken/driver.html?testName=json-parse-financial) 03:42:20 INFO - PROCESS | 26895 | RSS: Main: 167227392 03:42:20 INFO - PROCESS | 26895 | 03:42:21 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:22 INFO - PROCESS | 26895 | RSS: Main: 169865216 03:42:22 INFO - PROCESS | 26895 | 03:42:24 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:24 INFO - PROCESS | 26895 | RSS: Main: 170315776 03:42:24 INFO - PROCESS | 26895 | 03:42:26 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:27 INFO - PROCESS | 26895 | RSS: Main: 177364992 03:42:27 INFO - PROCESS | 26895 | 03:42:29 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:30 INFO - PROCESS | 26895 | RSS: Main: 186224640 03:42:30 INFO - PROCESS | 26895 | 03:42:32 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:33 INFO - PROCESS | 26895 | RSS: Main: 184680448 03:42:33 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | Cycle 1(1): loaded http://localhost:34352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34352/tests/kraken/driver.html?testName=ai-astar) 03:42:34 INFO - PROCESS | 26895 | RSS: Main: 246140928 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | __start_tp_report 03:42:34 INFO - PROCESS | 26895 | _x_x_mozilla_page_load 03:42:34 INFO - PROCESS | 26895 | _x_x_mozilla_page_load_details 03:42:34 INFO - PROCESS | 26895 | |i|pagename|runs| 03:42:34 INFO - PROCESS | 26895 | |0;ai-astar;109;110;105;110;110;110;99;110;110;108 03:42:34 INFO - PROCESS | 26895 | |1;audio-beat-detection;151;127;151;166;123;159;151;127;168;125 03:42:34 INFO - PROCESS | 26895 | |2;audio-dft;162;161;161;160;160;162;160;164;159;159 03:42:34 INFO - PROCESS | 26895 | |3;audio-fft;75;76;72;140;72;75;73;76;157;75 03:42:34 INFO - PROCESS | 26895 | |4;audio-oscillator;94;95;137;94;94;95;140;94;95;148 03:42:34 INFO - PROCESS | 26895 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;110;110 03:42:34 INFO - PROCESS | 26895 | |6;imaging-darkroom;146;146;145;146;145;146;146;146;145;146 03:42:34 INFO - PROCESS | 26895 | |7;imaging-desaturate;97;96;96;95;97;96;96;95;96;96 03:42:34 INFO - PROCESS | 26895 | |8;json-parse-financial;54;55;56;56;58;56;60;62;53;53 03:42:34 INFO - PROCESS | 26895 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;64;64 03:42:34 INFO - PROCESS | 26895 | |10;stanford-crypto-aes;77;78;78;79;79;79;78;78;77;79 03:42:34 INFO - PROCESS | 26895 | |11;stanford-crypto-ccm;112;112;112;113;111;109;125;114;111;110 03:42:34 INFO - PROCESS | 26895 | |12;stanford-crypto-pbkdf2;134;137;136;133;134;123;135;133;136;133 03:42:34 INFO - PROCESS | 26895 | |13;stanford-crypto-sha256-iterative;66;64;63;62;63;63;63;63;66;62 03:42:34 INFO - PROCESS | 26895 | __end_tp_report 03:42:34 INFO - PROCESS | 26895 | __start_cc_report 03:42:34 INFO - PROCESS | 26895 | _x_x_mozilla_cycle_collect,930 03:42:34 INFO - PROCESS | 26895 | __end_cc_report 03:42:34 INFO - PROCESS | 26895 | __startTimestamp1457264554980__endTimestamp 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | ------- Summary: start ------- 03:42:34 INFO - PROCESS | 26895 | Number of tests: 14 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.77 03:42:34 INFO - PROCESS | 26895 | Values: 109.0 110.0 105.0 110.0 110.0 110.0 99.0 110.0 110.0 108.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:151.00 stddev:17.66 (11.7%) stddev-sans-first:18.58 03:42:34 INFO - PROCESS | 26895 | Values: 151.0 127.0 151.0 166.0 123.0 159.0 151.0 127.0 168.0 125.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 03:42:34 INFO - PROCESS | 26895 | Values: 162.0 161.0 161.0 160.0 160.0 162.0 160.0 164.0 159.0 159.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.00 stddev:31.60 (42.1%) stddev-sans-first:33.10 03:42:34 INFO - PROCESS | 26895 | Values: 75.0 76.0 72.0 140.0 72.0 75.0 73.0 76.0 157.0 75.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:94.00 stddev:22.98 (24.4%) stddev-sans-first:23.76 03:42:34 INFO - PROCESS | 26895 | Values: 94.0 95.0 137.0 94.0 94.0 95.0 140.0 94.0 95.0 148.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:42:34 INFO - PROCESS | 26895 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 03:42:34 INFO - PROCESS | 26895 | 03:42:34 INFO - PROCESS | 26895 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:42:34 INFO - PROCESS | 26895 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 03:42:35 INFO - PROCESS | 26895 | Values: 97.0 96.0 96.0 95.0 97.0 96.0 96.0 95.0 96.0 96.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.95 (5.3%) stddev-sans-first:3.00 03:42:35 INFO - PROCESS | 26895 | Values: 54.0 55.0 56.0 56.0 58.0 56.0 60.0 62.0 53.0 53.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:42:35 INFO - PROCESS | 26895 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:0.79 (1.0%) stddev-sans-first:0.71 03:42:35 INFO - PROCESS | 26895 | Values: 77.0 78.0 78.0 79.0 79.0 79.0 78.0 78.0 77.0 79.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#11] stanford-crypto-ccm Cycles:10 Average:112.90 Median:112.00 stddev:4.48 (4.0%) stddev-sans-first:4.74 03:42:35 INFO - PROCESS | 26895 | Values: 112.0 112.0 112.0 113.0 111.0 109.0 125.0 114.0 111.0 110.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.40 Median:134.50 stddev:3.92 (2.9%) stddev-sans-first:4.15 03:42:35 INFO - PROCESS | 26895 | Values: 134.0 137.0 136.0 133.0 134.0 123.0 135.0 133.0 136.0 133.0 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - PROCESS | 26895 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.20 03:42:35 INFO - PROCESS | 26895 | Values: 66.0 64.0 63.0 62.0 63.0 63.0 63.0 63.0 66.0 62.0 03:42:35 INFO - PROCESS | 26895 | -------- Summary: end -------- 03:42:35 INFO - PROCESS | 26895 | 03:42:35 INFO - TEST-INFO | 26895: exit 0 03:42:35 INFO - TEST-OK | kraken | took 57989ms 03:42:35 INFO - TEST-START | v8_7 03:42:35 INFO - operating with platform_type : linux_ 03:42:35 INFO - Initialising browser for v8_7 test... 03:42:35 INFO - TEST-INFO | started process 27150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuddawP/profile http://localhost:34352/getInfo.html) 03:42:39 INFO - PROCESS | 27150 | __metrics Screen width/height:1600/1200 03:42:39 INFO - PROCESS | 27150 | colorDepth:24 03:42:39 INFO - PROCESS | 27150 | Browser inner width/height: 1024/697 03:42:39 INFO - PROCESS | 27150 | __metrics 03:42:39 INFO - PROCESS | 27150 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:40 INFO - TEST-INFO | 27150: exit 0 03:42:40 INFO - Browser initialized. 03:42:40 INFO - Running cycle 1/1 for v8_7 test... 03:42:40 INFO - TEST-INFO | started process 27241 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuddawP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:52 INFO - PROCESS | 27241 | RSS: Main: 137830400 03:42:52 INFO - PROCESS | 27241 | 03:43:14 INFO - PROCESS | 27241 | Cycle 1(1): loaded http://localhost:34352/tests/v8_7/run.html (next: http://localhost:34352/tests/v8_7/run.html) 03:43:15 INFO - PROCESS | 27241 | RSS: Main: 423604224 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | __start_tp_report 03:43:15 INFO - PROCESS | 27241 | _x_x_mozilla_page_load 03:43:15 INFO - PROCESS | 27241 | _x_x_mozilla_page_load_details 03:43:15 INFO - PROCESS | 27241 | |i|pagename|runs| 03:43:15 INFO - PROCESS | 27241 | |0;Richards;168.57720836142954 03:43:15 INFO - PROCESS | 27241 | |1;DeltaBlue;169.75046681378373 03:43:15 INFO - PROCESS | 27241 | |2;Encrypt;278.31895352073474 03:43:15 INFO - PROCESS | 27241 | |3;Decrypt;5246.073298429319 03:43:15 INFO - PROCESS | 27241 | |4;RayTrace;985.2216748768473 03:43:15 INFO - PROCESS | 27241 | |5;Earley;577.3672055427252 03:43:15 INFO - PROCESS | 27241 | |6;Boyer;11010.989010989011 03:43:15 INFO - PROCESS | 27241 | |7;RegExp;39725.490196078434 03:43:15 INFO - PROCESS | 27241 | |8;Splay;511.98368179500255 03:43:15 INFO - PROCESS | 27241 | |9;NavierStokes;4830.917874396136 03:43:15 INFO - PROCESS | 27241 | __end_tp_report 03:43:15 INFO - PROCESS | 27241 | __startTimestamp1457264595203__endTimestamp 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | ------- Summary: start ------- 03:43:15 INFO - PROCESS | 27241 | Number of tests: 10 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#0] Richards Cycles:1 Average:168.58 Median:168.58 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 168.6 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#1] DeltaBlue Cycles:1 Average:169.75 Median:169.75 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 169.8 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 278.3 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 5246.1 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#4] RayTrace Cycles:1 Average:985.22 Median:985.22 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 985.2 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#5] Earley Cycles:1 Average:577.37 Median:577.37 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 577.4 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#6] Boyer Cycles:1 Average:11010.99 Median:11010.99 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 11011.0 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#7] RegExp Cycles:1 Average:39725.49 Median:39725.49 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 39725.5 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#8] Splay Cycles:1 Average:511.98 Median:511.98 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 512.0 03:43:15 INFO - PROCESS | 27241 | 03:43:15 INFO - PROCESS | 27241 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:43:15 INFO - PROCESS | 27241 | Values: 4830.9 03:43:15 INFO - PROCESS | 27241 | -------- Summary: end -------- 03:43:15 INFO - PROCESS | 27241 | 03:43:16 INFO - TEST-INFO | 27241: exit 0 03:43:16 INFO - TEST-OK | v8_7 | took 40235ms 03:43:16 INFO - SUITE-END | took 1208s 03:43:16 INFO - Completed test suite (00:20:08) 03:43:16 INFO - Working with test: dromaeo_css 03:43:16 INFO - Generating results file: dromaeo_css 03:43:16 INFO - Working with test: kraken 03:43:16 INFO - Generating results file: kraken 03:43:16 INFO - javascript benchmark 03:43:16 INFO - Working with test: v8_7 03:43:16 INFO - Generating results file: v8_7 03:43:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:43:16 INFO - process_Request line: dromaeo_css 7262.72 graph.html#tests=[[72,52,35]] 03:43:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:16 INFO - process_Request line: kraken 1470.90 graph.html#tests=[[232,52,35]] 03:43:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:16 INFO - process_Request line: v8_7 21828.06 graph.html#tests=[[230,52,35]] 03:43:16 INFO - RETURN: dromaeo_css: 7262.72 03:43:16 INFO - RETURN: kraken: 1470.90 03:43:16 INFO - RETURN: v8_7: 21828.06 03:43:16 INFO - javascript benchmark 03:43:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3242.4001559711455, 3273.2635157089644, 3333.833308334584, 3334.033130392185, 3360.3447327771087, 5209.609279304053, 5223.190405487156, 5232.633715639907, 5234.345706786652, 5285.497877701617, 5159.406668233154, 5174.939137476817, 5189.792408303663, 5194.532492075712, 5284.841454756353, 4747.8575642730775, 4749.548792864673, 4780.952190478086, 4825.855224343275, 4828.0, 4688.906221875561, 4779.569838714515, 4783.497732738065, 4800.087983283165, 4876.487968763282, 4830.372051633282, 4860.05228980349, 4863.051704917542, 4865.172920603488, 4887.706737595738, 4791.880202994918, 4826.95173048272, 4851.151048566504, 4855.684380515255, 4882.780274887638, 4683.437987441494, 4712.458067322267, 4720.173969555314, 4733.313669517901, 4786.976065119687, 5087.236914462823, 5101.948980510221, 5122.359705036871, 5147.356580427447, 5164.889548747, 5520.1167813149705, 5659.066254068074, 5691.146328050784, 5698.0, 5708.0581704019205, 5573.554115670737, 5596.580256480739, 5638.379778224392, 5657.915131273035, 5693.430656934315, 5236.162214045735, 5256.342957130359, 5264.6051546134195, 5271.235670827708, 5272.446393128743, 5629.662220266797, 5667.0, 5685.5167310778215, 5686.829395118153, 5689.943100569024, 5440.183972404092, 5510.614257001971, 5513.421090785409, 5518.972405137949, 5552.0, 5642.6614403135945, 5663.32040155184, 5665.433456654301, 5670.773169073191, 5673.120666296731, 5505.146702261156, 5590.105583106765, 5623.775048998076, 5636.577256705681, 5662.943370566324, 5617.325920889438, 5625.0, 5625.774969001276, 5631.408702086222, 5645.661260324394, 4333.978330108393, 4344.261475549164, 4348.173846969065, 4349.217140914602, 4370.082282720664, 3867.878315288535, 3881.708871834567, 3928.8035598219976, 3941.467901833273, 3953.6639385651965, 5356.5714742821265, 5400.405955344909, 5415.323084614423, 5418.864528386822, 5424.267723857308, 5736.856578585569, 5740.6268592541355, 5740.827775166752, 5741.712914354265, 5766.192733017381, 5189.4032186299055, 5209.140491818884, 5230.0585894539345, 5254.369475662868, 5319.5744340452675, 4844.612431005582, 4907.852764417074, 4911.607071434348, 4915.21356582945, 4942.555170034714, 5532.446755324436, 5846.035404158351, 5889.646621202742, 5893.5874488785375, 5895.734691938873, 5597.580181486486, 5641.774329026793, 5650.943490565041, 5661.716914154358, 5698.0598201296325, 5717.142428635571, 5792.1311803229855, 5809.651420914759, 5830.970845145747, 5831.912521312099, 5471.863203419946, 5538.556915446674, 5557.499825015768, 5609.24275222856, 5611.8877622448135, 5641.210230567806, 5648.0, 5653.886922261614, 5655.123455864347, 5754.53963682896, 5397.136458166675, 5436.130219164915, 5445.0, 5445.1832225166545, 5446.564274858081, 5409.6213265071065, 5437.13005919051, 5481.013417584873, 5486.835394938158, 5509.779608815603, 5389.434109418455, 5425.403205647454, 5429.0, 5438.15708565173, 5451.64564303319, 5442.183672449164, 5492.5605951524585, 5496.203050557567, 5497.725113744217, 5531.612787105025, 5328.626996110235, 5340.439253878287, 5386.084365657926, 5412.161115027019, 5423.267858839006], "unit": "score", "name": "dojo.html", "value": 5200.748947778296}, {"lowerIsBetter": false, "replicates": [536.7450461031011, 566.2666846433867, 584.6258394627439, 586.01549397013, 594.8275000249926, 33109.99999999997, 33362.16594585137, 33407.16482087946, 33652.66347336526, 41799.164016719646, 46082.769586152106, 47036.52963470364, 47230.527694723045, 47288.0, 47413.76293118538, 8976.820463590724, 9156.313276504256, 9160.587773550173, 9162.633494660206, 9190.678326258583, 8838.602262898185, 8975.730728078135, 8989.325800564951, 8991.595378207963, 8991.685291014815, 8995.055519170492, 9071.909280907206, 9081.364304498687, 9093.0, 9093.727188184364, 8921.95539022304, 9024.548772561346, 9024.729258122234, 9025.909740902573, 9031.367804253705, 8930.821383572356, 9042.095790420904, 9077.63689452421, 9081.727548173565, 9082.909170908273, 41985.58014419878, 42546.787266063475, 42662.146757064686, 42713.145737085084, 42813.0, 3611.1694310308776, 3716.1081340478363, 3998.260321840469, 4074.327735923569, 4201.663866890642, 32415.51376729351, 32639.18402039968, 32666.510002349984, 32939.6706032939, 33035.33929321424, 4248.745075295492, 4256.489221293434, 4283.75907851225, 4317.805698743564, 4350.869473915787, 366654.0, 374418.0, 374575.0, 374670.0, 375179.0, 56649.71675141598, 56985.43014569884, 57119.71521139108, 60650.39349606536, 61772.0, 58029.4197058024, 69996.0, 70764.0, 70862.2913770866, 70924.29075709177, 17146.0, 17398.565035874206, 17424.303027878996, 17438.65122697539, 17480.5629859252, 11486.885131148581, 11653.18427710069, 13413.128146670435, 13476.124051936593, 13707.862921370857, 20501.38495845127, 21792.128314867547, 21832.23587174473, 21846.45383865416, 21908.671369929463, 8038.397120216007, 8149.511029338259, 8163.265306122477, 8282.0, 8368.163183681583, 1048.7116043088213, 1122.9243817942852, 1158.8030034894089, 1166.9241499302518, 1178.0987544528443, 29683.703162968526, 30176.84911575428, 30231.848840756094, 30746.385072298428, 31267.37465250728, 1180.4923882730336, 1203.0315595945174, 1232.7287996640725, 1242.1180961517423, 1265.6013355792895, 15237.510156358358, 15820.604484887739, 16039.198040097948, 16601.584960375847, 18046.501412612906, 457260.0, 460936.0, 461334.0, 461581.0, 463993.0, 59925.10112348318, 60504.0, 60543.39456605466, 60554.39445605576, 60574.0, 1418.581518452059, 1432.5917113622777, 1435.7487439698011, 1438.7266419380285, 1443.487561915526, 33122.83438582792, 33141.337173256885, 33212.83393583017, 33355.16612084717, 34327.4850877232, 50268.49731502638, 50707.0, 51027.0, 51028.0, 51045.74477127591, 341244.0, 343329.0, 343375.0, 343973.0, 344219.0, 28542.42915141727, 28688.0, 34055.0, 35003.29993400168, 35054.0, 40046.799766000986, 43854.0, 45632.54367456283, 50832.74583627058, 51750.482495176075, 36050.09874753152, 37042.444363334034, 38447.615523844404, 40389.79805100956, 40718.59281407148, 39080.60919390884, 39774.80112599534, 40344.596554034084, 40508.59491405048, 40574.39138412867, 38762.80618596889, 39228.0, 43548.34677479777, 44017.559824402626, 44047.55952440434, 29500.409991799614, 32931.67068329286, 33752.66247337593, 39178.41232381573, 41497.1700565993, 27240.863795680896, 27946.47529341342, 28084.297892552033, 28211.71788282091, 29146.854265729384], "unit": "score", "name": "ext.html", "value": 20320.816504119}, {"lowerIsBetter": false, "replicates": [382.69002108292284, 384.6768714280004, 387.8002828543301, 392.319325969443, 396.75401251224247, 14418.523416252921, 16054.197290135477, 16796.0, 19389.32137375192, 19390.418287451364, 17940.55148621285, 18157.0, 18565.164567594456, 18570.16434260458, 18579.44261672152, 5998.7600495980105, 6179.81460556184, 6183.072539119124, 6207.0, 6219.067139929001, 4558.452985641711, 4724.267738500538, 6143.385661433866, 6561.8031459056065, 6866.588004719708, 6583.3087525809815, 6757.729690812386, 6782.389584937355, 6834.794956151323, 6860.416864566493, 5379.946200537984, 6770.72917083316, 6782.2200446948245, 6785.287544807823, 6818.1136452261135, 5386.542143917772, 5386.542143917772, 5397.4062853086125, 5399.811006614789, 5400.729963501809, 11708.0, 12075.154739168262, 12146.878531214663, 12159.392030398445, 14515.491957781533, 2266.5240299537118, 2271.3640180749417, 2280.5175249153017, 2284.0749496453795, 2366.2782851230368, 9772.26707996896, 10013.59945602175, 10195.745106372326, 10225.233107516891, 10288.074073333435, 1877.4649224970954, 1932.120884997323, 1952.160570954489, 1986.99006504968, 2027.3816485971772, 59463.70268148675, 59667.70166149185, 61111.0, 61429.6928515359, 61803.69098154525, 10593.205509586813, 10928.945355273332, 10991.395473249047, 11004.779904401867, 11032.889671103187, 14536.0, 14600.634984125481, 14625.195614241105, 14632.19522926228, 14641.707165856624, 8313.12712165214, 8465.068842427328, 8470.830583388297, 8526.147385261424, 8533.359998000175, 8113.472624279403, 8118.188181181835, 8161.469504482189, 8259.917400825914, 8290.41967062312, 4476.26141686618, 4614.307853821953, 4775.235962246094, 4885.340479035356, 4911.705297682151, 1897.9905100474684, 1948.8733232339853, 1956.9315073972343, 1957.351290684624, 1970.1626808606286, 976.2824324121765, 1037.092544023979, 1072.7908057928785, 1109.1514991031868, 1121.265571050963, 14493.637659058397, 15251.161186134646, 16426.917865410836, 16510.917445412695, 16887.493375198763, 1014.9746256343503, 1054.0987455725244, 1087.5704096881846, 1103.8454616353717, 1117.8938000890066, 8528.488290702579, 10009.349392289623, 10015.849762253572, 10075.848862267072, 10088.293819432569, 555198.0, 556339.0, 559207.0, 576945.0, 629405.0, 64003.03995439979, 70743.0, 75808.62095689596, 76095.61952190203, 76222.23777762262, 1173.2373956927895, 1203.5667159822458, 1206.0351718625066, 1213.0416970593133, 1223.113242898909, 15508.457203997807, 15714.685706286038, 15756.0, 15848.92075539615, 15966.361345546047, 31822.204444889063, 32255.51616725704, 32917.0, 33748.0, 34730.652693472744, 42552.0, 42674.78662606667, 43178.13643727045, 43865.34201987037, 44525.0, 7288.3440490354005, 7311.597862117422, 7387.7783666490095, 7413.332800048021, 7736.0, 8120.832875178567, 9603.759906002406, 10803.45982700846, 10917.945410272898, 11407.25852819564, 9996.3002589818, 10021.0, 10054.64808731691, 10223.948880255552, 10300.124489418184, 9999.000099989942, 10063.29556931037, 10239.7440063999, 10420.583176672848, 10451.843222351823, 10188.388696678223, 10240.948795255976, 10453.320534165256, 10487.423191724529, 10538.367697938149, 7560.508566943131, 7595.0, 7596.620168991418, 7608.80977975555, 7871.212878712083, 9519.190868776232, 10195.490225488844, 10423.374597524173, 10578.259521833397, 10712.464376781285], "unit": "score", "name": "jquery.html", "value": 8616.580578218867}, {"lowerIsBetter": false, "replicates": [1415.7380884536356, 1522.7791970164326, 1541.5529496446031, 1729.8097209306975, 1861.8324350808425, 7698.692052317908, 8350.791230219247, 8466.999999999993, 8476.15238476152, 8481.279091277233, 8297.958510207456, 8476.957615211932, 8496.022957359906, 8502.064772874994, 8505.362097842672, 2146.549224662823, 2201.3836125884777, 2205.305328821424, 2400.939976500584, 2428.6842710447704, 2427.7693619106158, 2496.588062969617, 2497.2008957133635, 2497.9750202497926, 2501.8498890066653, 2381.1903952656094, 2417.4802417480237, 2427.356750461129, 2429.210506585358, 2431.4772323950438, 2085.009620430291, 2135.284679632325, 2327.662488939094, 2384.8569085854906, 2396.952060958771, 2407.723111842143, 2407.9759202407927, 2442.218490083174, 2447.7919376852988, 2447.8041756659422, 8384.03583587889, 8417.158284171534, 8420.242178203991, 8453.070162282143, 8461.0269818971, 5002.274670172805, 5117.7185254810975, 5128.1282182029145, 5129.820456284049, 5136.332276804029, 3290.7038366546885, 3303.7687361884678, 3316.6849149330774, 3334.216459132102, 3390.0677313738674, 1121.6130434999993, 1122.9943850280697, 1144.0733006264952, 1149.9712507187303, 1172.724409763705, 12094.516219351215, 12123.21199122063, 12124.27254364741, 12124.757504849853, 12141.028717702562, 4609.078184363141, 4615.676902616851, 4663.160631086437, 4671.48613652498, 4688.437387513521, 10314.071733544017, 10320.587176512856, 10320.741981450525, 10323.432211228455, 10336.121429678562, 5190.532852043334, 5218.7912483500995, 5227.921581176285, 5232.659877107976, 5238.0, 4744.857654270378, 4748.335233067373, 4748.358971538798, 4758.714477131383, 4768.47546769855, 4003.819828107742, 4005.5994400560294, 4008.8797336079965, 4040.0, 4065.0447144920918, 1207.3963018490754, 1224.5958833584896, 1234.5555599983998, 1236.0544183699476, 1236.4065248680683, 1066.3548553125402, 1112.076976109827, 1135.437958210691, 1139.1911742662637, 1361.5915225432332, 7149.356557909813, 7970.9202907970175, 8093.8381232376205, 8098.392620553482, 8133.755987320272, 519.6440438299777, 529.7245432375144, 1248.2260998181187, 1296.6369416563377, 1298.461138627478, 6280.183576135073, 6328.905066423915, 6429.903551446639, 6434.935650643527, 6440.871182576322, 10085.697429076992, 10314.1748660107, 10503.317284376491, 10513.579456821795, 10521.947390263, 9699.418034917928, 10341.534630941625, 10350.482475876326, 10361.274710770174, 10366.222533310032, 8008.519488830689, 8042.437029408003, 8052.879206811903, 8142.389320800845, 8150.999999999882, 7984.600769961363, 8016.238457346542, 8138.104808471182, 8185.4270201085355, 8205.95897020511, 9266.629334826532, 9293.535323233946, 9330.066993300887, 9387.85918211241, 9435.905640943778, 9473.621055157717, 9557.713268601952, 9702.417854928726, 10016.799664006534, 10016.849747253942, 7764.883526747216, 7797.571133587707, 7807.921920780719, 7954.761357159295, 7956.085050219067, 8202.876956845772, 8244.340452763885, 8266.214709602578, 8288.917110828814, 8309.95845020771, 7814.765557033298, 7840.451168418156, 7946.284834364935, 8041.798955026171, 8129.878051829109, 7795.376369890509, 7799.9220007799195, 7841.372690184886, 7917.802054948673, 7924.722634707758, 6667.333266673294, 6812.863742725217, 7959.323457505945, 7984.081830589556, 8009.279164875189, 6855.691493882887, 6956.652167391711, 6996.790096297119, 7002.4398048157045, 7004.334588214316, 7146.3568278855155, 7173.784786456415, 7214.134303883568, 7240.493165478577, 7244.89132663], "unit": "score", "name": "mootools.html", "value": 4867.075705175491}, {"lowerIsBetter": false, "replicates": [365.87011610878136, 367.9779213247207, 370.55348305292125, 374.35984466562167, 374.533705536607, 5855.531557475402, 5886.529077673787, 5891.998360278758, 5897.262842144732, 5931.406859314077, 5671.2060311556415, 5690.5447564194865, 5762.222100016507, 5804.0, 5932.525397968163, 4604.401427814396, 4629.305604159386, 4635.605973492257, 4636.327732478789, 4642.8375006874685, 4451.421315229016, 4648.48866624671, 4652.395188625474, 4659.277811939155, 4673.8831529211875, 4498.595126438619, 4517.209488339544, 4603.217453032976, 4620.584147426731, 4634.976825115869, 4595.632349412039, 4648.279516674921, 4648.349231107648, 4654.4647365553055, 4659.881628409191, 4152.8131234094535, 4157.833686652531, 4158.043649960496, 4159.209750147463, 4165.083681590046, 5611.410801865786, 5661.8584535386535, 5685.289338832646, 5685.431456854323, 5694.2312787773535, 5391.514763671288, 5402.756875940592, 5407.215953686733, 5408.080626293539, 5410.269613602152, 6281.623102613812, 6284.591501552431, 6300.873982520324, 6304.747810087591, 6307.842303942392, 4574.748388838612, 4576.427946506687, 4577.496475387705, 4577.633789296849, 4577.656675749332, 6440.0, 6498.285188629247, 6562.245341785708, 6562.753076915323, 6586.143801305848, 4715.269133284346, 4717.914879577647, 4720.197566413718, 4724.692894961817, 4737.099951009297, 4799.616030717534, 4808.711477311373, 4809.879753006133, 4811.109944660249, 4819.518048195223, 5412.972935135378, 5419.647722897999, 5424.701641409761, 5431.891362172734, 5437.429069947678, 6148.9692551536955, 6378.0, 6381.074744162071, 6389.722055588901, 6390.968045159838, 1675.572728954109, 1700.5663555793194, 1701.4555342290596, 1705.6759215748968, 1705.8379453951854, 1153.5616465743133, 1184.7748927703708, 1188.756304957499, 1204.175140029083, 1207.1791181996327, 6080.331163572004, 6092.847678807977, 6094.939050609526, 6095.75616975316, 6099.817005489843, 6387.584806987531, 6533.673316334164, 6534.705938232791, 6547.803565893031, 6553.803385898431, 5960.105984102419, 6015.608985415934, 6035.2154219952, 6085.543584231112, 6156.891759483336, 3495.2485215678753, 3543.0, 3547.8048707321345, 3548.556430446194, 3548.6628770266784, 6589.209294884645, 6780.72877084911, 6783.660816959133, 6785.389314961677, 6789.932100679029, 6755.831104222434, 6766.221884483249, 6768.526203165731, 6768.593884366954, 6773.0, 6754.257031726506, 6777.220619628707, 6785.457163426914, 6789.524733268722, 6790.117284752951, 6455.483561315177, 6591.604503729792, 6597.109390232449, 6598.802035938929, 6606.8017959461295, 6491.675416229075, 6491.805245842632, 6492.870142597216, 6502.0, 6506.869862602816, 6782.525223234326, 6783.898241526283, 6788.25329213796, 6788.355106264897, 6789.524733268624, 4756.881077973078, 4768.737719425465, 4771.117343291502, 4774.806298425394, 4775.283707443911, 6398.648074355955, 6570.145881035626, 6571.638559879252, 6572.112764776885, 6591.077249185214, 6400.807975760735, 6408.9038664421005, 6409.4231519163495, 6415.486761059011, 6419.26178489461, 6276.74893004293, 6393.552451328363, 6394.136791533084, 6396.360363963567, 6398.5201109916015, 6252.09344645033, 6262.53031022666, 6263.4362907338555, 6271.310155882758, 6273.74905003813, 6358.078078678658, 6362.268339141058, 6365.458935990493, 6369.267534233437, 6371.5221358397375, 6093.421124993119, 6180.721867515883, 6201.0, 6216.316205217513, 6234.345393733593], "unit": "score", "name": "prototype.html", "value": 4858.573551320352}, {"lowerIsBetter": false, "replicates": [811.0672726364681, 842.5239739547155, 903.4985583001431, 910.7404389748923, 924.884389451319, 14752.852471475282, 14930.178840163786, 15037.774433383507, 15048.87133464989, 15070.095794252353, 13829.239391833446, 14252.572422827332, 14256.643583910407, 14266.144031358126, 14274.357653905574, 742.0724094881398, 746.138210367027, 847.7414388611471, 862.6506264962669, 870.2559311788425, 862.3058437957442, 868.9044205137429, 868.9652413903436, 869.3306154261215, 869.6695255802786, 891.3493150000503, 891.9687810926619, 895.2166854002747, 895.6238379880466, 895.9552022398886, 771.3559178086305, 779.3764988009598, 898.1602201941206, 908.4458480326995, 909.5861383070687, 655.4559715436225, 662.8110988368292, 672.451951659401, 672.8217022489044, 673.0409166937095, 13111.934440327737, 13188.406521706545, 13189.274589897552, 13201.669958251121, 13205.669858253525, 14165.150090994573, 14232.715345693028, 14494.71010579793, 14519.564413067625, 14522.782158267635, 11392.886071139348, 11407.885921140765, 11518.308901465854, 11557.76884462306, 11661.650150495414, 3857.7492462989817, 3905.2384784966944, 3952.268830266381, 3955.881323560298, 3958.623930726605, 53301.46698533004, 53552.73223633896, 54849.0, 55070.173947391224, 55104.448955510336, 10653.467326633638, 10727.92720727921, 10870.347779133277, 10947.0, 10997.450127493594, 17498.91250543739, 17528.12359382026, 17595.56011099733, 17608.735868961976, 17620.295188192584, 7980.68077276914, 8044.477108987897, 8063.233992770677, 8105.918940810634, 8252.876206856901, 4486.685931984795, 4521.412216411845, 4550.47669518003, 4579.267317229227, 4668.066386722669, 3249.0, 3254.365398747269, 3276.2955964467756, 3277.7869438486423, 3282.40916635008, 577.2870504926412, 587.632729544035, 589.375262222046, 599.6312267955176, 605.8757954619292, 602.7829981206762, 638.2213699286863, 668.6155460610169, 744.5383862005591, 772.748856621589, 8590.398672092893, 9953.452560109263, 10022.498875056219, 10092.04125608066, 10250.641227557, 583.4894467341077, 621.8631900981867, 645.8062581225613, 709.8686742952467, 741.6032422653855, 4476.239039363316, 4513.345564893072, 4538.909221815611, 4544.068465964469, 4554.43069616298, 59427.10859337114, 61633.075503867476, 62106.68946655238, 62227.0, 63192.368076319566, 52118.47881521212, 54037.0, 54213.45786542163, 56330.155047674314, 56448.71775641095, 47862.52137478581, 48322.0, 48451.27323090156, 48946.51053489491, 49990.25014624783, 9464.716058518256, 9582.089701478348, 9755.589087876957, 9953.601855925683, 10038.397696138256, 35267.0, 37334.25331493409, 37919.62080379161, 38007.61992380151, 38697.4195387075, 45486.772566136955, 45884.54115458803, 46529.30206046844, 47105.05789884252, 49901.0, 11952.223105498115, 12002.099842511672, 12468.563600273947, 12984.67982471383, 13222.933885330513, 13883.514077007256, 13887.375068121757, 14019.369128389042, 14064.08583442073, 14212.715745684822, 12446.128770986306, 12720.554780582635, 13154.934225328812, 13179.60461186166, 13261.270630115436, 13126.278054707083, 13227.272500012592, 13232.470701172231, 13315.800262995868, 13394.0, 12791.360431978177, 13017.674558136123, 13185.73628527405, 13227.470901163846, 13299.26854023038, 10033.344797164957, 10335.17318614494, 10519.526621302213, 10676.62631807883, 10696.679099627023, 9951.303408761318, 9960.053794889474, 9977.151942084714, 10046.748831279276, 10529.526171322155], "unit": "score", "name": "yui.html", "value": 6814.566335379157}], "name": "dromaeo_css", "value": 7262.720363026856}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 110.0, 110.0, 99.0, 110.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 151.0, 166.0, 123.0, 159.0, 151.0, 127.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 164.0, 159.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 72.0, 140.0, 72.0, 75.0, 73.0, 76.0, 157.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 137.0, 94.0, 94.0, 95.0, 140.0, 94.0, 95.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 56.0, 56.0, 58.0, 56.0, 60.0, 62.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 77.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 112.0, 113.0, 111.0, 109.0, 125.0, 114.0, 111.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.9}, {"lowerIsBetter": true, "replicates": [134.0, 137.0, 136.0, 133.0, 134.0, 123.0, 135.0, 133.0, 136.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.4}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 66.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1470.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.57720836142954], "unit": "score", "name": "Richards", "value": 209.41146399999997}, {"lowerIsBetter": false, "replicates": [169.75046681378373], "unit": "score", "name": "DeltaBlue", "value": 389.5011380000001}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [985.2216748768473], "unit": "score", "name": "RayTrace", "value": 751.0888350000004}, {"lowerIsBetter": false, "replicates": [577.3672055427252], "unit": "score", "name": "Earley", "value": 1154.3139159999996}, {"lowerIsBetter": false, "replicates": [11010.989010989011], "unit": "score", "name": "Boyer", "value": 60.527078842315376}, {"lowerIsBetter": false, "replicates": [39725.490196078434], "unit": "score", "name": "RegExp", "value": 22.932001480750255}, {"lowerIsBetter": false, "replicates": [511.98368179500255], "unit": "score", "name": "Splay", "value": 159.16718227091627}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21828.061297158318}]} 03:43:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21828.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1470.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7262.72"}}} 03:43:16 INFO - Return code: 0 03:43:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:16 INFO - # TBPL SUCCESS # 03:43:16 INFO - Running post-action listener: _resource_record_post_action 03:43:16 INFO - Running post-run listener: _resource_record_post_run 03:43:17 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359624704; Read time: 12; Write time: 285420 03:43:17 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 106082304; Read time: 0; Write time: 120236 03:43:17 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252944384; Read time: 12; Write time: 165184 03:43:17 INFO - Running post-run listener: _upload_blobber_files 03:43:17 INFO - Blob upload gear active. 03:43:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:43:17 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 03:43:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:43:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:18 INFO - (blobuploader) - INFO - Done attempting. 03:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 03:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:19 INFO - (blobuploader) - INFO - Done attempting. 03:43:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:19 INFO - Return code: 0 03:43:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:43:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8d819b22b275ad08e15bac62623ab53afb0d59dbd3c6599cbc7a0e5c37a4849abde8da1304861b7744f77400ca68be8f54e30e45a4ef2cb8bc5489579d5435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89e63d4e25cf941d3aa769cca6738725e9fc9b301ce2894127f69091798f2a30295bae25c591d8b61817dd65887a335dae5174a9debc12a106c002aa1e0aec03"} 03:43:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:43:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:43:19 INFO - Contents: 03:43:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8d819b22b275ad08e15bac62623ab53afb0d59dbd3c6599cbc7a0e5c37a4849abde8da1304861b7744f77400ca68be8f54e30e45a4ef2cb8bc5489579d5435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89e63d4e25cf941d3aa769cca6738725e9fc9b301ce2894127f69091798f2a30295bae25c591d8b61817dd65887a335dae5174a9debc12a106c002aa1e0aec03"} 03:43:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:19 INFO - Copying logs to upload dir... 03:43:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:43:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1338.799757 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-03-06 03:43:19.132816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 03:43:19.136309) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8d819b22b275ad08e15bac62623ab53afb0d59dbd3c6599cbc7a0e5c37a4849abde8da1304861b7744f77400ca68be8f54e30e45a4ef2cb8bc5489579d5435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89e63d4e25cf941d3aa769cca6738725e9fc9b301ce2894127f69091798f2a30295bae25c591d8b61817dd65887a335dae5174a9debc12a106c002aa1e0aec03"} build_url:https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/YuK8wtcOTby_s_TDkV2UOw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8d819b22b275ad08e15bac62623ab53afb0d59dbd3c6599cbc7a0e5c37a4849abde8da1304861b7744f77400ca68be8f54e30e45a4ef2cb8bc5489579d5435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89e63d4e25cf941d3aa769cca6738725e9fc9b301ce2894127f69091798f2a30295bae25c591d8b61817dd65887a335dae5174a9debc12a106c002aa1e0aec03"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 03:43:19.160322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:43:19.160611) ========= 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=41bf3e9aed84707956354da8000001c5-1457259806.577022-1622256965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 03:43:19.242447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 03:43:19.242743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 03:43:19.243041) ========= ========= Total master_lag: 0.32 =========