builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1450475017.62 results: success (0) buildid: 20151218113004 builduid: 489264d093d34db8b348832859a5cca7 revision: 7faa07d9677be9b76ae64bbe96e7db2af1829b8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.622173) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.622755) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.623090) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.647313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.647622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.677479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.677756) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.732433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.732709) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.733161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.733464) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 13:43:37-- 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% 224M=0s 2015-12-18 13:43:37 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.861908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.862278) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022334 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:37.913792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 13:43:37.914361) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7faa07d9677be9b76ae64bbe96e7db2af1829b8b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7faa07d9677be9b76ae64bbe96e7db2af1829b8b --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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 13:43:38,009 truncating revision to first 12 chars 2015-12-18 13:43:38,009 Setting DEBUG logging. 2015-12-18 13:43:38,009 attempt 1/10 2015-12-18 13:43:38,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7faa07d9677b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 13:43:38,731 unpacking tar archive at: b2g-inbound-7faa07d9677b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 13:43:39.169727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:39.170066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:39.177417) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:39.177675) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 13:43:39.178094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-18 13:43:39.178422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:39 INFO - MultiFileLogger online at 20151218 13:43:39 in /builds/slave/test-pgo 13:43:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 13:43:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:43:39 INFO - {'append_to_log': False, 13:43:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:43:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:43:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:43:39 INFO - 'branch': 'B2G-Inbound', 13:43:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:39 INFO - 'config_files': ('talos/linux_config.py',), 13:43:39 INFO - 'default_actions': ('clobber', 13:43:39 INFO - 'read-buildbot-config', 13:43:39 INFO - 'download-and-extract', 13:43:39 INFO - 'populate-webroot', 13:43:39 INFO - 'create-virtualenv', 13:43:39 INFO - 'install', 13:43:39 INFO - 'run-tests'), 13:43:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:39 INFO - 'download_minidump_stackwalk': True, 13:43:39 INFO - 'download_symbols': 'ondemand', 13:43:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:39 INFO - 'installer_path': 'installer.exe', 13:43:39 INFO - 'log_level': 'info', 13:43:39 INFO - 'log_name': 'talos', 13:43:39 INFO - 'log_to_console': True, 13:43:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:39 INFO - 'opt_config_files': (), 13:43:39 INFO - 'pip_index': False, 13:43:39 INFO - 'sps_profile': False, 13:43:39 INFO - 'sps_profile_interval': 0, 13:43:39 INFO - 'suite': 'dromaeojs', 13:43:39 INFO - 'system_bits': '64', 13:43:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:39 INFO - 'title': 'talos-linux64-ix-016', 13:43:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:39 INFO - 'use_talos_json': True, 13:43:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:43:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:39 INFO - 'work_dir': 'build'} 13:43:39 INFO - ##### 13:43:39 INFO - ##### Running clobber step. 13:43:39 INFO - ##### 13:43:39 INFO - Running pre-action listener: _resource_record_pre_action 13:43:39 INFO - Running main action method: clobber 13:43:39 INFO - rmtree: /builds/slave/test-pgo/build 13:43:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:43:39 INFO - Running post-action listener: _resource_record_post_action 13:43:39 INFO - ##### 13:43:39 INFO - ##### Running read-buildbot-config step. 13:43:39 INFO - ##### 13:43:39 INFO - Running pre-action listener: _resource_record_pre_action 13:43:39 INFO - Running main action method: read_buildbot_config 13:43:39 INFO - Using buildbot properties: 13:43:39 INFO - { 13:43:39 INFO - "project": "", 13:43:39 INFO - "product": "firefox", 13:43:39 INFO - "script_repo_revision": "production", 13:43:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:43:39 INFO - "repository": "", 13:43:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 13:43:39 INFO - "buildid": "20151218113004", 13:43:39 INFO - "pgo_build": "True", 13:43:39 INFO - "basedir": "/builds/slave/test-pgo", 13:43:39 INFO - "buildnumber": 1068, 13:43:39 INFO - "slavename": "talos-linux64-ix-016", 13:43:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:43:39 INFO - "platform": "ubuntu64_hw", 13:43:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 13:43:39 INFO - "branch": "b2g-inbound", 13:43:39 INFO - "repo_path": "integration/b2g-inbound", 13:43:39 INFO - "revision": "7faa07d9677be9b76ae64bbe96e7db2af1829b8b", 13:43:39 INFO - "stage_platform": "linux64-pgo", 13:43:39 INFO - "builduid": "489264d093d34db8b348832859a5cca7", 13:43:39 INFO - "slavebuilddir": "test" 13:43:39 INFO - } 13:43:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:43:39 INFO - Running post-action listener: _resource_record_post_action 13:43:39 INFO - ##### 13:43:39 INFO - ##### Running download-and-extract step. 13:43:39 INFO - ##### 13:43:39 INFO - Running pre-action listener: _resource_record_pre_action 13:43:39 INFO - Running main action method: download_and_extract 13:43:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:43:39 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')]} 13:43:39 INFO - https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/test_packages.json 13:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/test_packages.json 13:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:43:40 INFO - Downloaded 1302 bytes. 13:43:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:43:40 INFO - Using the following test package requirements: 13:43:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'jsshell-linux-x86_64.zip'], 13:43:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:40 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')]} 13:43:40 INFO - https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:42 INFO - Downloaded 23120939 bytes. 13:43:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:43:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:43:43 INFO - Return code: 0 13:43:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:43 INFO - https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:46 INFO - Downloaded 23120939 bytes. 13:43:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:43:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:43:47 INFO - Return code: 0 13:43: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')]} 13:43:47 INFO - https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:43:49 INFO - Downloaded 11132039 bytes. 13:43:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:43:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:43:49 INFO - Return code: 0 13:43:49 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')]} 13:43:49 INFO - https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:43:53 INFO - Downloaded 54643724 bytes. 13:43:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:53 INFO - mkdir: /builds/slave/test-pgo/properties 13:43:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:43:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:43:53 INFO - Contents: 13:43:53 INFO - build_url:https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:43:53 INFO - Running post-action listener: _resource_record_post_action 13:43:53 INFO - Running post-action listener: set_extra_try_arguments 13:43:53 INFO - ##### 13:43:53 INFO - ##### Running populate-webroot step. 13:43:53 INFO - ##### 13:43:53 INFO - Running pre-action listener: _resource_record_pre_action 13:43:53 INFO - Running main action method: populate_webroot 13:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:53 INFO - '--tppagecycles', 13:43:53 INFO - '7'], 13:43:53 INFO - 'tests': ['tsvgm']}}, 13:43:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:43:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'tests': ['damp', 'tps']}, 13:43:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['damp', 'tps']}, 13:43:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:53 INFO - 'other': {'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'other_l64': {'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'other_nol64': {'tests': ['a11yr', 13:43:53 INFO - 'ts_paint', 13:43:53 INFO - 'tpaint', 13:43:53 INFO - 'sessionrestore', 13:43:53 INFO - 'sessionrestore_no_auto_restore']}, 13:43:53 INFO - 'svgr': {'tests': ['tsvgx', 13:43:53 INFO - 'tsvgr_opacity', 13:43:53 INFO - 'tart', 13:43:53 INFO - 'tscrollx', 13:43:53 INFO - 'cart']}, 13:43:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['tsvgx', 13:43:53 INFO - 'tsvgr_opacity', 13:43:53 INFO - 'tart', 13:43:53 INFO - 'tscrollx', 13:43:53 INFO - 'cart']}, 13:43:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'tests': ['tp5o']}, 13:43:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'talos_options': ['--e10s'], 13:43:53 INFO - 'tests': ['tp5o']}, 13:43:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'talos_options': ['--xperf_path', 13:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:53 INFO - 'tests': ['tp5n']}, 13:43:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:53 INFO - 'talos_options': ['--e10s', 13:43:53 INFO - '--xperf_path', 13:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:53 INFO - 'tests': ['tp5n']}}, 13:43:53 INFO - 'talos.zip': {'path': '', 13:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:53 INFO - Running post-action listener: _resource_record_post_action 13:43:53 INFO - ##### 13:43:53 INFO - ##### Running create-virtualenv step. 13:43:53 INFO - ##### 13:43:53 INFO - Running pre-action listener: _resource_record_pre_action 13:43:53 INFO - Running main action method: create_virtualenv 13:43:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:43:53 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 13:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:43:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:53 INFO - Using real prefix '/usr' 13:43:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:43:53 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:55 INFO - Installing pip.................done. 13:43:55 INFO - Return code: 0 13:43:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:43:55 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')]} 13:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 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')]} 13:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:43:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:43:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:43:55 INFO - Using env: {'DISPLAY': ':0', 13:43:55 INFO - 'HOME': '/home/cltbld', 13:43:55 INFO - 'LANG': 'en_US.UTF-8', 13:43:55 INFO - 'LANGUAGE': 'en_US:en', 13:43:55 INFO - 'LOGNAME': 'cltbld', 13:43:55 INFO - 'MAIL': '/var/mail/cltbld', 13:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:55 INFO - 'MOZ_NO_REMOTE': '1', 13:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:55 INFO - 'NO_EM_RESTART': '1', 13:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:55 INFO - 'SHELL': '/bin/bash', 13:43:55 INFO - 'SHLVL': '1', 13:43:55 INFO - 'TERM': 'linux', 13:43:55 INFO - 'TMOUT': '86400', 13:43:55 INFO - 'USER': 'cltbld', 13:43:55 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:55 INFO - '_': '/tools/buildbot/bin/python'} 13:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:55 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 13:43:55 INFO - Cleaning up... 13:43:55 INFO - Return code: 0 13:43:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:43:55 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')]} 13:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 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')]} 13:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:43:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:43:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:43:55 INFO - Using env: {'DISPLAY': ':0', 13:43:55 INFO - 'HOME': '/home/cltbld', 13:43:55 INFO - 'LANG': 'en_US.UTF-8', 13:43:55 INFO - 'LANGUAGE': 'en_US:en', 13:43:55 INFO - 'LOGNAME': 'cltbld', 13:43:55 INFO - 'MAIL': '/var/mail/cltbld', 13:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:55 INFO - 'MOZ_NO_REMOTE': '1', 13:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:55 INFO - 'NO_EM_RESTART': '1', 13:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:55 INFO - 'SHELL': '/bin/bash', 13:43:55 INFO - 'SHLVL': '1', 13:43:55 INFO - 'TERM': 'linux', 13:43:55 INFO - 'TMOUT': '86400', 13:43:55 INFO - 'USER': 'cltbld', 13:43:55 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:55 INFO - '_': '/tools/buildbot/bin/python'} 13:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:56 INFO - Downloading/unpacking psutil>=0.7.1 13:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:57 INFO - Installing collected packages: psutil 13:43:57 INFO - Running setup.py install for psutil 13:43:57 INFO - building 'psutil._psutil_linux' extension 13:43:57 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 13:43:58 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 13:43:58 INFO - building 'psutil._psutil_posix' extension 13:43:58 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 13:43:58 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 13:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:58 INFO - Successfully installed psutil 13:43:58 INFO - Cleaning up... 13:43:58 INFO - Return code: 0 13:43:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:43:58 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')]} 13:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:58 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')]} 13:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:43:58 INFO - Using env: {'DISPLAY': ':0', 13:43:58 INFO - 'HOME': '/home/cltbld', 13:43:58 INFO - 'LANG': 'en_US.UTF-8', 13:43:58 INFO - 'LANGUAGE': 'en_US:en', 13:43:58 INFO - 'LOGNAME': 'cltbld', 13:43:58 INFO - 'MAIL': '/var/mail/cltbld', 13:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:58 INFO - 'MOZ_NO_REMOTE': '1', 13:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:58 INFO - 'NO_EM_RESTART': '1', 13:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:58 INFO - 'SHELL': '/bin/bash', 13:43:58 INFO - 'SHLVL': '1', 13:43:58 INFO - 'TERM': 'linux', 13:43:58 INFO - 'TMOUT': '86400', 13:43:58 INFO - 'USER': 'cltbld', 13:43:58 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:58 INFO - '_': '/tools/buildbot/bin/python'} 13:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:44:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:44:00 INFO - Installing collected packages: mozsystemmonitor 13:44:00 INFO - Running setup.py install for mozsystemmonitor 13:44:00 INFO - Successfully installed mozsystemmonitor 13:44:00 INFO - Cleaning up... 13:44:00 INFO - Return code: 0 13:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:00 INFO - Using env: {'DISPLAY': ':0', 13:44:00 INFO - 'HOME': '/home/cltbld', 13:44:00 INFO - 'LANG': 'en_US.UTF-8', 13:44:00 INFO - 'LANGUAGE': 'en_US:en', 13:44:00 INFO - 'LOGNAME': 'cltbld', 13:44:00 INFO - 'MAIL': '/var/mail/cltbld', 13:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:00 INFO - 'MOZ_NO_REMOTE': '1', 13:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:00 INFO - 'NO_EM_RESTART': '1', 13:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:00 INFO - 'SHELL': '/bin/bash', 13:44:00 INFO - 'SHLVL': '1', 13:44:00 INFO - 'TERM': 'linux', 13:44:00 INFO - 'TMOUT': '86400', 13:44:00 INFO - 'USER': 'cltbld', 13:44:00 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:00 INFO - '_': '/tools/buildbot/bin/python'} 13:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:44:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:03 INFO - Downloading docopt-0.6.1.tar.gz 13:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:44:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:03 INFO - Running setup.py install for blobuploader 13:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:44:03 INFO - Running setup.py install for requests 13:44:03 INFO - Running setup.py install for docopt 13:44:03 INFO - Successfully installed blobuploader requests docopt 13:44:03 INFO - Cleaning up... 13:44:03 INFO - Return code: 0 13:44:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:44:03 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')]} 13:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:03 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')]} 13:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:03 INFO - Using env: {'DISPLAY': ':0', 13:44:03 INFO - 'HOME': '/home/cltbld', 13:44:03 INFO - 'LANG': 'en_US.UTF-8', 13:44:03 INFO - 'LANGUAGE': 'en_US:en', 13:44:03 INFO - 'LOGNAME': 'cltbld', 13:44:03 INFO - 'MAIL': '/var/mail/cltbld', 13:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:03 INFO - 'MOZ_NO_REMOTE': '1', 13:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:03 INFO - 'NO_EM_RESTART': '1', 13:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:03 INFO - 'SHELL': '/bin/bash', 13:44:03 INFO - 'SHLVL': '1', 13:44:03 INFO - 'TERM': 'linux', 13:44:03 INFO - 'TMOUT': '86400', 13:44:03 INFO - 'USER': 'cltbld', 13:44:03 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:03 INFO - '_': '/tools/buildbot/bin/python'} 13:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:44:03 INFO - Running setup.py (path:/tmp/pip-1tQIN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:44:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:44:03 INFO - Running setup.py (path:/tmp/pip-lktrNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:44:04 INFO - Running setup.py (path:/tmp/pip-EFIv5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:44:04 INFO - Running setup.py (path:/tmp/pip-JhCeLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:44:04 INFO - Running setup.py (path:/tmp/pip-4ccjHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:44:04 INFO - Running setup.py (path:/tmp/pip-OppzdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:44:04 INFO - Running setup.py (path:/tmp/pip-sjDp2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:44:04 INFO - Running setup.py (path:/tmp/pip-8A6i8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:44:04 INFO - Running setup.py (path:/tmp/pip-XtDpWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:44:04 INFO - Running setup.py (path:/tmp/pip-XdpkJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:44:04 INFO - Running setup.py (path:/tmp/pip-srj7na-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:44:04 INFO - Running setup.py (path:/tmp/pip-a8MEj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:44:04 INFO - Running setup.py (path:/tmp/pip-cuK7WG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:44:04 INFO - Running setup.py (path:/tmp/pip-j79Edf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:44:04 INFO - Running setup.py (path:/tmp/pip-F8_P8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:44:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:44:05 INFO - Running setup.py (path:/tmp/pip-Qq4W6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:44:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:44:05 INFO - Running setup.py (path:/tmp/pip-npdbQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:05 INFO - Running setup.py install for manifestparser 13:44:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Running setup.py install for mozcrash 13:44:05 INFO - Running setup.py install for mozdebug 13:44:05 INFO - Running setup.py install for mozdevice 13:44:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Running setup.py install for mozfile 13:44:05 INFO - Running setup.py install for mozhttpd 13:44:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Running setup.py install for mozinfo 13:44:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Running setup.py install for mozInstall 13:44:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:44:05 INFO - Running setup.py install for mozleak 13:44:06 INFO - Running setup.py install for mozlog 13:44:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Running setup.py install for moznetwork 13:44:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Running setup.py install for mozprocess 13:44:06 INFO - Running setup.py install for mozprofile 13:44:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Running setup.py install for mozrunner 13:44:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Running setup.py install for mozscreenshot 13:44:06 INFO - Running setup.py install for moztest 13:44:06 INFO - Running setup.py install for mozversion 13:44:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:44:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:06 INFO - Cleaning up... 13:44:06 INFO - Return code: 0 13:44:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:44:06 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')]} 13:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:06 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')]} 13:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:06 INFO - Using env: {'DISPLAY': ':0', 13:44:06 INFO - 'HOME': '/home/cltbld', 13:44:06 INFO - 'LANG': 'en_US.UTF-8', 13:44:06 INFO - 'LANGUAGE': 'en_US:en', 13:44:06 INFO - 'LOGNAME': 'cltbld', 13:44:06 INFO - 'MAIL': '/var/mail/cltbld', 13:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:06 INFO - 'MOZ_NO_REMOTE': '1', 13:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:06 INFO - 'NO_EM_RESTART': '1', 13:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:06 INFO - 'SHELL': '/bin/bash', 13:44:06 INFO - 'SHLVL': '1', 13:44:06 INFO - 'TERM': 'linux', 13:44:06 INFO - 'TMOUT': '86400', 13:44:06 INFO - 'USER': 'cltbld', 13:44:06 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:06 INFO - '_': '/tools/buildbot/bin/python'} 13:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:44:07 INFO - Running setup.py (path:/tmp/pip-iLihSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:44:07 INFO - Running setup.py (path:/tmp/pip-qo7g5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:44:07 INFO - Running setup.py (path:/tmp/pip-8fZhaB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:44:07 INFO - Running setup.py (path:/tmp/pip-8UURqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:44:07 INFO - Running setup.py (path:/tmp/pip-R0t23u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:44:07 INFO - Running setup.py (path:/tmp/pip-QTEFgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:44:07 INFO - Running setup.py (path:/tmp/pip-CZasei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:44:07 INFO - Running setup.py (path:/tmp/pip-jnCBqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:44:07 INFO - Running setup.py (path:/tmp/pip-Vki_MU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:44:07 INFO - Running setup.py (path:/tmp/pip-3EnPT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:44:07 INFO - Running setup.py (path:/tmp/pip-RNrf83-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:44:07 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)) 13:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:44:07 INFO - Running setup.py (path:/tmp/pip-XnHBmf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:44:08 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)) 13:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:44:08 INFO - Running setup.py (path:/tmp/pip-y1aM5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:44:08 INFO - Running setup.py (path:/tmp/pip-3g5gSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:44:08 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)) 13:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:44:08 INFO - Running setup.py (path:/tmp/pip-hgJctM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:44:08 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)) 13:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:44:08 INFO - Running setup.py (path:/tmp/pip-7v48YM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:44:08 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)) 13:44:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:44:08 INFO - Running setup.py (path:/tmp/pip-ZCUsni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:10 INFO - Downloading blessings-1.5.1.tar.gz 13:44:10 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:10 INFO - Installing collected packages: blessings 13:44:10 INFO - Running setup.py install for blessings 13:44:10 INFO - Successfully installed blessings 13:44:10 INFO - Cleaning up... 13:44:10 INFO - Return code: 0 13:44:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:44:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:44:10 INFO - Reading from file tmpfile_stdout 13:44:10 INFO - Current package versions: 13:44:10 INFO - argparse == 1.2.1 13:44:10 INFO - blessings == 1.5.1 13:44:10 INFO - blobuploader == 1.2.4 13:44:10 INFO - docopt == 0.6.1 13:44:10 INFO - manifestparser == 1.1 13:44:10 INFO - mozInstall == 1.12 13:44:10 INFO - mozcrash == 0.16 13:44:10 INFO - mozdebug == 0.1 13:44:10 INFO - mozdevice == 0.47 13:44:10 INFO - mozfile == 1.2 13:44:10 INFO - mozhttpd == 0.7 13:44:10 INFO - mozinfo == 0.9 13:44:10 INFO - mozleak == 0.1 13:44:10 INFO - mozlog == 3.1 13:44:10 INFO - moznetwork == 0.27 13:44:10 INFO - mozprocess == 0.22 13:44:10 INFO - mozprofile == 0.27 13:44:10 INFO - mozrunner == 6.11 13:44:10 INFO - mozscreenshot == 0.1 13:44:10 INFO - mozsystemmonitor == 0.0 13:44:10 INFO - moztest == 0.7 13:44:10 INFO - mozversion == 1.4 13:44:10 INFO - psutil == 3.1.1 13:44:10 INFO - requests == 1.2.3 13:44:10 INFO - wsgiref == 0.1.2 13:44:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:10 INFO - Using env: {'DISPLAY': ':0', 13:44:10 INFO - 'HOME': '/home/cltbld', 13:44:10 INFO - 'LANG': 'en_US.UTF-8', 13:44:10 INFO - 'LANGUAGE': 'en_US:en', 13:44:10 INFO - 'LOGNAME': 'cltbld', 13:44:10 INFO - 'MAIL': '/var/mail/cltbld', 13:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:10 INFO - 'MOZ_NO_REMOTE': '1', 13:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:10 INFO - 'NO_EM_RESTART': '1', 13:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:10 INFO - 'SHELL': '/bin/bash', 13:44:10 INFO - 'SHLVL': '1', 13:44:10 INFO - 'TERM': 'linux', 13:44:10 INFO - 'TMOUT': '86400', 13:44:10 INFO - 'USER': 'cltbld', 13:44:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:10 INFO - '_': '/tools/buildbot/bin/python'} 13:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:44:10 INFO - Cleaning up... 13:44:10 INFO - Return code: 0 13:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:10 INFO - Using env: {'DISPLAY': ':0', 13:44:10 INFO - 'HOME': '/home/cltbld', 13:44:10 INFO - 'LANG': 'en_US.UTF-8', 13:44:10 INFO - 'LANGUAGE': 'en_US:en', 13:44:10 INFO - 'LOGNAME': 'cltbld', 13:44:10 INFO - 'MAIL': '/var/mail/cltbld', 13:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:10 INFO - 'MOZ_NO_REMOTE': '1', 13:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:10 INFO - 'NO_EM_RESTART': '1', 13:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:10 INFO - 'SHELL': '/bin/bash', 13:44:10 INFO - 'SHLVL': '1', 13:44:10 INFO - 'TERM': 'linux', 13:44:10 INFO - 'TMOUT': '86400', 13:44:10 INFO - 'USER': 'cltbld', 13:44:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:10 INFO - '_': '/tools/buildbot/bin/python'} 13:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:10 INFO - Downloading/unpacking jsonschema 13:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:44:12 INFO - Downloading/unpacking functools32 (from jsonschema) 13:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:12 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:12 INFO - warning: no files found matching '*.txt' 13:44:12 INFO - no previously-included directories found matching 'build' 13:44:12 INFO - no previously-included directories found matching 'dist' 13:44:12 INFO - no previously-included directories found matching '.git*' 13:44:12 INFO - Installing collected packages: jsonschema, functools32 13:44:12 INFO - Running setup.py install for functools32 13:44:13 INFO - warning: no files found matching '*.txt' 13:44:13 INFO - no previously-included directories found matching 'build' 13:44:13 INFO - no previously-included directories found matching 'dist' 13:44:13 INFO - no previously-included directories found matching '.git*' 13:44:13 INFO - Successfully installed jsonschema functools32 13:44:13 INFO - Cleaning up... 13:44:13 INFO - Return code: 0 13:44:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:44:13 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')]} 13:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 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')]} 13:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fbecd3f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', '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 13:44:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 13:44:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:44:13 INFO - Using env: {'DISPLAY': ':0', 13:44:13 INFO - 'HOME': '/home/cltbld', 13:44:13 INFO - 'LANG': 'en_US.UTF-8', 13:44:13 INFO - 'LANGUAGE': 'en_US:en', 13:44:13 INFO - 'LOGNAME': 'cltbld', 13:44:13 INFO - 'MAIL': '/var/mail/cltbld', 13:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:13 INFO - 'MOZ_NO_REMOTE': '1', 13:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:13 INFO - 'NO_EM_RESTART': '1', 13:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:13 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:13 INFO - 'SHELL': '/bin/bash', 13:44:13 INFO - 'SHLVL': '1', 13:44:13 INFO - 'TERM': 'linux', 13:44:13 INFO - 'TMOUT': '86400', 13:44:13 INFO - 'USER': 'cltbld', 13:44:13 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:13 INFO - '_': '/tools/buildbot/bin/python'} 13:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:13 INFO - Downloading/unpacking flake8 13:44:13 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 13:44:13 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 13:44:13 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 13:44:13 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 13:44:13 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 13:44:13 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 13:44:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:44:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:44:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:44:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:44:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:15 INFO - no previously-included directories found matching 'docs/_build' 13:44:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:44:15 INFO - Running setup.py install for pep8 13:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:15 INFO - no previously-included directories found matching 'docs/_build' 13:44:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:44:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:44:15 INFO - Cleaning up... 13:44:15 INFO - Return code: 0 13:44:15 INFO - Running post-action listener: _resource_record_post_action 13:44:15 INFO - Running post-action listener: _start_resource_monitoring 13:44:15 INFO - Starting resource monitoring. 13:44:15 INFO - ##### 13:44:15 INFO - ##### Running install step. 13:44:15 INFO - ##### 13:44:15 INFO - Running pre-action listener: _resource_record_pre_action 13:44:15 INFO - Running main action method: install 13:44:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:44:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:44:16 INFO - Reading from file tmpfile_stdout 13:44:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:44:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:44:16 INFO - Reading from file tmpfile_stdout 13:44:16 INFO - Output received: 13:44:16 INFO - Usage: mozinstall [options] installer 13:44:16 INFO - Options: 13:44:16 INFO - -h, --help show this help message and exit 13:44:16 INFO - -d DEST, --destination=DEST 13:44:16 INFO - Directory to install application into. [default: 13:44:16 INFO - "/builds/slave/test-pgo"] 13:44:16 INFO - --app=APP Application being installed. [default: firefox] 13:44:16 INFO - mkdir: /builds/slave/test-pgo/build/application 13:44:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:44:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:44:31 INFO - Reading from file tmpfile_stdout 13:44:31 INFO - Output received: 13:44:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:44:31 INFO - Running post-action listener: _resource_record_post_action 13:44:31 INFO - ##### 13:44:31 INFO - ##### Running run-tests step. 13:44:31 INFO - ##### 13:44:31 INFO - Running pre-action listener: _resource_record_pre_action 13:44:31 INFO - Running main action method: run_tests 13:44:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:44:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:44:31 INFO - Python 2.7.3 13:44:31 INFO - Return code: 0 13:44:31 INFO - grabbing minidump binary from tooltool 13:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:31 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 0x1d65350>, '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 0x1d66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d666e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:44:31 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 13:44:31 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 13:44:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:44:31 INFO - Return code: 0 13:44:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:44:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:44:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:44:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:44:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:44:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:44:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:44:32 INFO - Return code: 0 13:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 13:44:32 INFO - Using env: {'DISPLAY': ':0', 13:44:32 INFO - 'HOME': '/home/cltbld', 13:44:32 INFO - 'LANG': 'en_US.UTF-8', 13:44:32 INFO - 'LANGUAGE': 'en_US:en', 13:44:32 INFO - 'LOGNAME': 'cltbld', 13:44:32 INFO - 'MAIL': '/var/mail/cltbld', 13:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:32 INFO - 'MOZ_NO_REMOTE': '1', 13:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:32 INFO - 'NO_EM_RESTART': '1', 13:44:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:44:32 INFO - 'PWD': '/builds/slave/test-pgo', 13:44:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:44:32 INFO - 'SHELL': '/bin/bash', 13:44:32 INFO - 'SHLVL': '1', 13:44:32 INFO - 'TERM': 'linux', 13:44:32 INFO - 'TMOUT': '86400', 13:44:32 INFO - 'USER': 'cltbld', 13:44:32 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394', 13:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:32 INFO - '_': '/tools/buildbot/bin/python'} 13:44:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 13:44:33 INFO - mozversion INFO | application_buildid: 20151218113004 13:44:33 INFO - mozversion INFO | application_changeset: 7faa07d9677be9b76ae64bbe96e7db2af1829b8b 13:44:33 INFO - mozversion INFO | application_display_name: Nightly 13:44:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:44:33 INFO - mozversion INFO | application_name: Firefox 13:44:33 INFO - mozversion INFO | application_remotingname: firefox 13:44:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:44:33 INFO - mozversion INFO | application_vendor: Mozilla 13:44:33 INFO - mozversion INFO | application_version: 46.0a1 13:44:33 INFO - mozversion INFO | platform_buildid: 20151218113004 13:44:33 INFO - mozversion INFO | platform_changeset: 7faa07d9677be9b76ae64bbe96e7db2af1829b8b 13:44:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:44:33 INFO - mozversion INFO | platform_version: 46.0a1 13:44:33 INFO - 2015-12-18 13:44:33,107 DEBUG : using testdate: 1450475073 13:44:33 INFO - 2015-12-18 13:44:33,107 DEBUG : actual date: 1450475073 13:44:33 INFO - 2015-12-18 13:44:33,115 INFO : starting webserver on 'localhost:56674' 13:44:33 INFO - 2015-12-18 13:44:33,116 INFO : Starting test suite talos-linux64-ix-016 13:44:33 INFO - 2015-12-18 13:44:33,117 INFO : Starting test dromaeo_css 13:44:33 INFO - 2015-12-18 13:44:33,117 DEBUG : operating with platform_type : linux_ 13:44:33 INFO - 2015-12-18 13:44:33,117 INFO : Initialising browser for dromaeo_css test... 13:44:33 INFO - 2015-12-18 13:44:33,134 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYPFkz/profile http://localhost:56674/getInfo.html 13:44:37 INFO - 2015-12-18 13:44:37,054 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:44:37 INFO - 2015-12-18 13:44:37,054 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:44:37 INFO - 2015-12-18 13:44:37,054 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:44:37 INFO - 2015-12-18 13:44:37,054 DEBUG : BROWSER_OUTPUT: __metrics 13:44:37 INFO - 2015-12-18 13:44:37,191 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:44:37 INFO - 2015-12-18 13:44:37,247 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:44:38 INFO - 2015-12-18 13:44:38,302 INFO : Browser initialized. 13:44:38 INFO - 2015-12-18 13:44:38,303 INFO : Running cycle 1/1 for dromaeo_css test... 13:44:38 INFO - 2015-12-18 13:44:38,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYPFkz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:44:50 INFO - 2015-12-18 13:44:50,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 150200320 13:44:50 INFO - 2015-12-18 13:44:50,080 DEBUG : BROWSER_OUTPUT: 13:45:41 INFO - 2015-12-18 13:45:41,569 DEBUG : BROWSER_OUTPUT: 1450475141566 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] 13:47:50 INFO - 2015-12-18 13:47:50,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56674/tests/dromaeo/cssquery-ext.html) 13:47:51 INFO - 2015-12-18 13:47:51,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 276164608 13:47:51 INFO - 2015-12-18 13:47:51,507 DEBUG : BROWSER_OUTPUT: 13:50:53 INFO - 2015-12-18 13:50:53,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-ext.html (next: http://localhost:56674/tests/dromaeo/cssquery-jquery.html) 13:50:54 INFO - 2015-12-18 13:50:54,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 228524032 13:50:54 INFO - 2015-12-18 13:50:54,501 DEBUG : BROWSER_OUTPUT: 13:53:56 INFO - 2015-12-18 13:53:56,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56674/tests/dromaeo/cssquery-mootools.html) 13:53:56 INFO - 2015-12-18 13:53:56,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 222478336 13:53:56 INFO - 2015-12-18 13:53:56,876 DEBUG : BROWSER_OUTPUT: 13:56:58 INFO - 2015-12-18 13:56:58,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56674/tests/dromaeo/cssquery-prototype.html) 13:56:59 INFO - 2015-12-18 13:56:59,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 208232448 13:56:59 INFO - 2015-12-18 13:56:59,275 DEBUG : BROWSER_OUTPUT: 14:00:01 INFO - 2015-12-18 14:00:01,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56674/tests/dromaeo/cssquery-yui.html) 14:00:02 INFO - 2015-12-18 14:00:02,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 211140608 14:00:02 INFO - 2015-12-18 14:00:02,250 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/dromaeo/cssquery-yui.html (next: http://localhost:56674/tests/dromaeo/cssquery-dojo.html) 14:03:05 INFO - 2015-12-18 14:03:05,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 286113792 14:03:05 INFO - 2015-12-18 14:03:05,335 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:03:05 INFO - 2015-12-18 14:03:05,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:03:05 INFO - 2015-12-18 14:03:05,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:03:05 INFO - 2015-12-18 14:03:05,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:03:05 INFO - 2015-12-18 14:03:05,337 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3069.7237248647616;3154.621445426549;3198.248411623268;3206.422843888099;3213.3412650406667;5059.544640982311;5215.556677682402;5322.654027488211;5349.063913815082;5371.382291036532;5285.8942821143555;5317.867053323669;5386.622936394454;5411.296531450916;5419.160030195326;4820.614350851941;4866.31871537985;4912.0912631163255;5033.370828646419;5073.3404657394485;4642.930356044662;4959.900801983958;4982.651214414992;5028.647994640377;5054.494550544934;4807.759612019385;4830.154722923475;4894.583960363373;4922.064807686528;4931.7040977541465;4758.547937945889;4760.071786001731;4769.809207631691;4786.952130478686;4802.375691160162;4747.620190384795;4786.569208771192;4822.903541929177;4831.444383895861;4835.975820120877;5137.178051511778;5174.741262936838;5191.0656081905245;5228.111221092423;5277.630565860353;5767.625104368202;5778.451047150514;5794.130880367937;5801.7389217485315;5803.622764520335;5622.3253209614695;5790.942090579082;5795.652260864362;5804.419558044204;5822.534197264251;5252.501012403815;5275.709835959021;5371.274877891474;5424.484673955968;5471.8084867029465;5752.913706294409;5759.971200143972;5764.740586673526;5768.3366412862215;5825.271841019872;5496.5053145217125;5589.965856316594;5590.24531688225;5602.299712535933;5614.129809879475;5644.3508996465935;5663.631863928831;5797.652140871562;5877.941220587825;5929.436703513159;5691.0609749391715;5717.256756621613;5717.3996730342715;5733.8566535836935;5736.627119237236;5577.8047768327915;5735.8566035849435;5758.827235182951;5759.280089988752;5764;4384.846530371422;4439.489458712289;4494.280915053576;4532.614727748112;4538.841140560065;3969.702272329587;3970.404439334123;4001.479807625048;4007.6793856491413;4008.939865902014;5203.869903252449;5444.891102177934;5446.945530544644;5453.318335208099;5465.152901300305;5681.602287839894;5724.255846739898;5730.598858079894;5756.280464941882;5786.421357864264;5406.053940560386;5428.4842939920645;5432.049391356497;5442.074847275972;5449.863753406196;4934.6545741798445;4993;5055.191169412877;5097.898042039138;5150.587952963754;5837.88324233513;5902.321233058254;5910.408959104056;5935.109733540004;5984.1921340618455;5768.394318596655;5795.420457954339;5797.043487824461;5801.883962320814;5808.128780682931;5595.692236926845;5890.057590785454;5898.469137777621;5924.377940316377;5927.2590926134235;5493.2858728366655;5499.4775496329385;5514.448555144453;5574.275344205227;5612.270404847343;5809;5827.504662103599;5830.5627077968475;5835.4748072673665;5839.270091238595;5433.701146436984;5653.321601407857;5689.288838895138;5723.255976723;5723.6851973141875;5567.4432556744005;5589.161625756006;5655.236543066633;5727.599068065196;5733.541316694571;5455.890882182413;5555.638883472561;5585.469380408855;5591.720413979366;5598.35618903815;5435.347758269033;5654.519365853948;5680.318361796611;5684.71576421169;5687.289088863892;5410.891782164256;5482.369527504388;5487.862803429946;5527.806526771544;5543.944560554342 14:03:05 INFO - 2015-12-18 14:03:05,339 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.3960921984782;581.3227589857814;589.631480324797;599.110321173058;605.9969700151498;30478.085657430285;31177.376452470937;40871.18257634845;41560;41628.791856040756;44568.554314456844;45412.31881521772;45541.31688024674;45557.31664025034;45573.77213113938;7564.735234266802;8744.912550874506;8894.11058894112;8903.732888013337;8906.999999999967;7621.771346859603;10515.421651809147;10750.301230420037;10752.946235268813;10758.462076896163;10482.633107841228;10499.632512862052;10592.947035264813;10596.258261921668;10598.311109777878;7734.651940662684;7836.255555722198;10432.582696692123;10574.894251057467;10575.365478071302;10318.432486213254;10492.16062714981;10494.422806745626;10498.842517362245;10501.579936802518;39752.20495590101;40290;40313;40342.59657403418;40370.59629403727;3167.0815463515783;3315.9171020724434;3845.4231865220163;3922.0587059105897;3977.5226972763166;30065;30345.848270758725;30582.541261881088;30610.54084188739;31709.682903171135;3787.394016957301;3796.7532110412735;3825.9617403825882;3903.258380907647;3914.197589494147;280124;280870;282451;282806;284756;50403.49596503988;51474.74262628663;58375.41624583785;58466.707666462244;59159.70420147958;52881.47118528842;53117.82909307194;53121.2031819523;53437.73281133647;53456.19815702768;14226.857731422553;14314.427422902967;14351.354189061518;14362.210078445785;14431.42274309016;10514.421706806046;10518;10560;10574.101201397814;10615.469226538642;19218.71507686217;19476.220951161795;19481.902590486956;19587.216511339386;19739.40781776549;7756.418268629763;7836.568988705676;7869.213078692085;7936.523808571505;8064;966.1884017425397;983.0808194338316;1033.7105610429091;1078.2991055813627;1080.7892460970193;28721.56917646237;28798.856005719837;28890;29020.564691529646;29185.708142918724;1009.2531526670358;1035.9896401036044;1043.045613263855;1080.448971024783;1138.351139850294;13725.313734313244;15565.766513502307;15735.921320393325;15777.368905243891;16045.679086418206;314341;314540;319262;320689;320693;52831;53090.73454632702;53126.734366327924;53127.20309195365;53143.73428132835;1347.6765576261823;1360.7822748360215;1364.2360278244214;1375.0580852116132;1375.1336657905456;28060.579091314055;28723.712762872103;29131.41737165287;29163.125106246847;29454.852725736233;41643;42130.789346053076;45741.771291143334;46814.29778553393;47623.76188119176;198937;199091;200768;201209;201294;28502.287442814097;28561.857190713912;28902.566461503517;29236;29291.267718307212;38890;39472.605273946894;39546.2090758189;39725;40228.79885600553;34697.653023470455;35738.463923040654;35795.46306805452;36065.459018115274;36402.27195456129;35933.28133437369;36752.26495470022;36861.26277474489;36961;36963.26073478461;35044.82477587698;35246.29507409889;35272;35332;35671.82164089163;27775;29186.270343241587;29946.640531417474;31703.365932680757;31961.840190798895;24159.637605435582;24309.850430125196;24617.261482155565;24631.63052554249;24675.876620616782 14:03:05 INFO - 2015-12-18 14:03:05,340 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.66496828013385;356.0848619049042;356.39946689827644;357.85149163097316;358.587624232133;14058.297085145727;14197.373485905115;16424.425145119923;16712.49862504125;17440.82559174408;13525.594232173025;13734.313284335793;17554.561135971606;17848;17966.101694915236;5172.198309262061;5204.869878253055;5259.500347466985;5296.417394086648;5306.946930530703;3958.1094253792953;4082.2243773682903;5156.189876517307;5330.3603567571945;5331.120365139747;5638.520725738317;5766.106253530709;5786.218860453848;5794.739236734357;5796.50729687977;5113.667611605234;5672.659640421588;5711.2575365202465;5862.853428664275;5885.5585831062845;5204.271402003723;5213.843584692465;5216.686998780086;5237.240600112962;5256.369235691704;20809;20920.47698807527;21300.254491092892;21390.893045534674;21407.46481337979;2127.574485102986;2138.7112739780086;2233.5197932444603;2297.873616951067;2344.355302291883;13156.868431315756;13259.933700331436;13284.53504127351;13708.24604646744;13780;1734.540346808097;1752.7195648696274;1762.2774662388358;1814.936477223291;1876.3245231716571;58737.706311468595;58967.70516147392;59245.7037714813;61333.69333153305;61854.28874267513;9882.555285012191;10087.394756314645;10198.949005254926;10219.13137383316;10255.897441025643;13317.334133293296;13371.598852034454;13398.062135650605;13406.530771423148;13421.731565368833;7434.851302974019;7510.361619262315;7533.623318834037;7565.773026809205;7606.201348858401;7203.351698347174;7228.96385518069;7242.022326985895;7272.709091636381;7278.09023872016;5937.495312898365;6047.274327080779;6073.453389194994;6090.969545152246;6091.299500557404;1611.4440518021263;1657.312215430583;1685.7471379292958;1721.9741703874452;1767.081117818727;909.5315912305168;933.5239028095721;943.2595412601075;999.6651121874108;1025.0467065628889;17266.136693165543;17628.647427051386;18116.456506304832;18748.625027499373;18797.718034229496;925.8842644669417;940.351157701184;963.3786207895868;980.5293459139652;995.9103680668775;8663.306935445149;10590.523426445829;10635.468226588795;10787.67636970892;10809.35143891369;518184;518541;541123;572105;581760;62439.37560624426;70914.64542677253;74181;79473.60263198648;80070.19929800744;1095.1403148528527;1102.4542851288504;1104.221523825717;1111.699841042914;1120.7758448310371;16025.759613606038;16182.919085404497;16353.264103115627;16354;16735.832641673427;36004.27991440209;36980.81509592435;37348.06629834276;37695.81152094222;37728.2454350906;46836.29745553888;49932.750336248086;49970;50462;51769.741151294;9349.672761453316;10133.695989120339;10151.94924025375;10165.949170254102;10167.186625070124;17754.112294385486;17955.371561995267;18023.098845057957;18384.448466546026;18447.446576602724;14751.483698070517;14872.925635371754;14892.925535372255;15262.771058434355;15287.847121528643;14531.636709082357;14880;14892.62768430798;15230.390784368501;15395.153266570445;14856.480023199136;14960.102393856403;15116.470923517623;15433.768493472831;15773.842261577238;8921.330900182382;9654.082862128087;9701.514924253901;9819.901800982185;9856.457894815854;9534.380265282734;9546;13848.09987350819;13945.233012184022;14579.635509112357 14:03:05 INFO - 2015-12-18 14:03:05,340 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1298.0783643613033;1369.417997351126;1440.5966329427758;1559.9298031588585;1760.419061709636;6753.898691519631;7220.422366210703;7514.699412023526;7554.282343177403;7576.924230757684;7218.6751596178165;7362.595057271861;7366.447516436262;7367.705291788336;7385;1964.8428125749906;2027.401916434648;2034.6541088015074;2237.7090978172814;2306.7347255065715;2234.8100411465043;2267.240474441064;2268.1947908492493;2273.5111950930545;2273.863568185914;2206.9889650551727;2207.2164381644448;2280.6921065656175;2280.8859557022165;2281.543691261746;2277.6128058229974;2288.553732022256;2290.5075408787025;2308.7114110736156;2317.316391664463;2232.0402227042364;2268.8184945204507;2287.611106111965;2288.6910267113894;2291.919782807594;7564.432667549956;7631.12242092161;7637.541747495168;7651.808704782369;7660.195679453688;4517.299818528133;4588.472325682523;4592.33411155384;4606.700564463299;4626.583607475343;3021.894233701832;3032.5754394384803;3050.100220434977;3067.7852550321486;3155.4793459079224;1054.947252637365;1064.6486659402456;1069.58820853971;1090.6455401994303;1109.2180013090751;10029.69910902674;10084.596616135346;10096.34373765703;10144.543495542719;10146.086852183265;4096.795160241976;4137.089840235143;4197.223513649923;4231.19607274623;4237.300845360481;8502.659893604186;8520.659173632985;8520.8721869172;8523.232909038215;8526;4637.420322459692;4649.325847752057;4661.883452913704;4666.0901124280435;4673.322368256584;4242.278812601865;4253.404523366731;4255.936160957588;4292.785360731951;4293.0984493256765;3260.136063943057;3297.20866991925;3489.2672538766637;3586.4620306953643;3671.834767435472;1156.3177725142207;1163.0753550927034;1166.830809532613;1177.4289469607234;1179.1215544419463;1003.5935446144323;1034.0796690945065;1036.9637062702768;1174.4186627619383;1352.594221733476;6710.496712746563;6770.424513916274;6802.727890884408;6814;6826.522143449911;1100.471773548701;1105.2926127278547;1107.3245320354577;1118.2284223885656;1126.6732647532288;5293.417724050351;5353.250544923714;5360.678359298377;5365.865853353619;5373.328333958255;8813.603387847563;8830.470171789713;9055.18503334703;9122.36143469964;9130.589123489459;8914.33142514314;8982.101789820965;8996.59515321812;9001.234895033995;9011.819763604692;6772.2211945625895;7068.893966590505;7074.009638650593;7148.821279467951;7179.569225846466;6733.966330168318;6740.157480314961;6762.357576030269;6764.5941243523575;6769.763058292936;7819.765407037798;7999.360051195774;8120.837583248183;8120.918790812017;8128.634211460617;7887.250711182429;8089.069756978023;8104.189581041848;8244.175582441947;8259;6445.807525607777;6475.481961442979;6542.640154791532;6600.570962887397;6636.701348439428;6425.58233714807;6586.341365863375;6686;6831.11195544576;7149.463790215651;6557.344265573404;6581.177352830896;6653.467722582085;6715.093462382712;6831.385175334244;6527.934720652923;6633;6721.361470660279;6725.058491811053;6824.669189508197;6660.467162627075;6682;6690.13028306317;6695.966520167368;6707.262201157771;6151.046587778901;6201.844953876189;6223.471004964629;6233.345498722751;6246.031865060922;6197.101420294122;6218.06728990655;6218.440340369389;6218.595791273553;6223.439890409885 14:03:05 INFO - 2015-12-18 14:03:05,341 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.4540403460515;346.1553808706754;347.73398350262056;349.82159098859574;352.6403068869754;5821.67980761058;5951.553633477485;5985.610935289204;6000.3699611540815;6026.186464827247;5672.659640421578;5706.457886500786;5781.277340332458;5870.677112758796;5891.381404952483;4545.636349092065;4558.726476411426;4580.473245576752;4580.519045500225;4593.655475839309;4558.133954548642;4568.908621827562;4570.223062079454;4576.039031803325;4588.678792484528;4306.978465107686;4433.423654924872;4459.996500787313;4563.338315944203;4577.771111444431;4544.545545445429;4558.270676691746;4561.543845615445;4571.4514258289055;4582.19811532982;4039.7778122203267;4047.2107938951917;4049.2104039712267;4053.1893621275567;4053.7770422626745;5589.552835773128;5591.10542313232;5596.076647353182;5598.748056337475;5609.3268807742925;5175.430702622709;5319.840404787863;5321.4412486688725;5326.414094449608;5329.840104796862;6287.842803929892;6298.212723409574;6298.6535740534255;6299.496040316763;6302.1177035215105;4393.890152746175;4429.13631841791;4434.379186913835;4435.356873253392;4440.045390241114;6366.554341196118;6467;6507.511936604774;6526.738930442777;6552.705128269239;4529.343245229424;4540.72755634663;4543.341215523797;4543.545645435496;4547.249703798836;4580.496145424001;4585.037142200175;4593.586577208067;4595.4025976622825;4598.103369842848;5242.370915490165;5288.0745869472685;5290.444503327172;5296.841094767163;5300.92048619271;6175.96912015437;6299.716512756937;6307.400796924285;6314.179156709598;6325.082862984841;1594.3383495849325;1623.1965177237344;1623.2127418202163;1623.9756403653955;1624.5045261195448;1070.4380200394698;1074.8656417947757;1092.1754075672816;1093.4532733633184;1095.7972775036644;6096.9390306096375;6097.17688112108;6114.938850611526;6122.234720659918;6132.5707200495535;6491.545591808623;6534;6541.084248205255;6544.574602650812;6552.57408268461;5945;6038.124471951543;6067.393260673897;6166.290876549165;6174.598651087665;3544.2557063017057;3544.57465104184;3560.6795388415167;3565.625609311037;3567.5362202913457;6730.226024007204;6738.157730283715;6742.898856517156;6744.527883048139;6755.966220168868;6584.934150658528;6740.966295168493;6745.359190876957;6760.425363844129;6764.222114456802;6699.933000670028;6734.730610775612;6744.797656070227;6754.075088599726;6756.695948682321;6578.440832529289;6587.571807832475;6594.70323835419;6597.505187111082;6599.8020059398295;6290.119383286435;6481;6509.381608747161;6522.902156467751;6528.053432252392;6730.461563074844;6736.4274036705465;6742.393184613408;6746.460283177236;6750.1562304711915;4543.931841022453;4587.7017993830295;4588.449386073693;4589.2657174851865;4591;6362.745490180526;6570.8357291068105;6601.966990165019;6606.372394622503;6622.403983641303;6426;6432.581882177644;6436.645984470899;6439.903401448888;6442.194725659293;6367.745290188341;6401.071844582602;6409.8718025640155;6413.647249401328;6421.93578064232;6155.907661384993;6287.056941458635;6287.339829317856;6287.402696743802;6292.968535157295;6411.262704788823;6420.775272865428;6422;6423;6432.871342573216;6217.720202590804;6255.499560035278;6266.436020758154;6270.561060725706;6278.372162783685 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: |5;yui.html;837.3803385494734;848.7750746052297;860.6772460327377;873.9300855931526;877.6840337478507;15691.450799222015;16173.75739363909;16190.352385904549;16190.514284571482;16199.676006479878;14682.632934176625;14684.85315146851;14745.41018359267;14775.630609234775;14783.556493305192;685.4550632247375;698.6122701900443;813.2680587471293;828.4490813608943;831.5301854452215;811.7402431222012;816.1675091406762;824.5217773691245;830.5473516933286;831.4387788242942;863.3007264116055;873.3624454148476;878.2315473960285;878.907714689958;879.0111124984393;720.7837648705367;729.0485915879775;848.4485084694998;870.7692461497708;871.1245198575455;639.1307821362942;639.1978067525273;639.2169592249458;639.2967735490969;639.66097968077;13370.398332074983;13485;13493.865061349457;13533.458661653522;13551.25468099254;11503.137264705098;11734.47194876224;11911.702207444796;12114.757704845853;12152.513899444011;10136.949315253376;10147.898521014842;10153.136983356424;10606.78786424275;10763.62327318548;3616.6021737608844;3643.526341575578;3651.8539258429632;3672.596014438436;3854;45837.770811146394;47104.76447617774;47137.764311178566;47186;47200.29199562009;9901.405915645084;10026.398416095057;10227.539760710786;10410.219233557513;10546.472676366151;18585.721214181798;18608.16263268156;18623.161957711935;18638.720419193724;18642.627147456977;7396.482246242711;7534.243179869017;7546.471746977769;7570.545767253982;7589.1272503662785;4247.97876010618;4256;4284.8500302489265;4288.699791014599;4307.504636966726;2963.3184367595572;2970.7920445569034;2994.041906589914;3002.834844083596;3003.339265361617;552.5358698693117;558.0847410247197;565.3216140631259;566.1507738392411;571.3543695623919;575.8502789274735;617.4257940115735;638.32656547343;642.2581917884851;643.7264162730821;8255.834883302421;8256.711015114442;8520.19058189471;8582.785430364165;8668.436551624125;488.9535494128052;504.8990201959623;609.5502829345759;618.5793660310942;678.5521555773166;3865.768053916774;4007.8998025049023;4132.8140233689555;4169.478815148106;4207.558206388347;52445;56982;57429.42570574324;57526.13710794342;57987.71006144942;48691.51308486941;49225.753871230416;49492.25761613579;49978.250326245136;53143.73428132912;44238.557614424084;44451.55548444474;44896.77551612221;46219.53780462153;46250;8496.660133594587;8754.12458754145;8838.646454141763;9003.324750643858;9105.362624616213;32923.91146897353;33172;33942.3211535763;34105.48841767326;34155.14612134716;49187.262191066446;49228.50771492383;49304;50439;54340;11606.651800446;11662.766744665229;11703.356315402734;11730.589429369931;12005.219660722025;12239.388030598257;12368.44342004594;12398;13033.413496392495;13062.150960187557;11562.595309164139;11585.710357241136;11650.126240532163;11900.702482438008;11953.820692689442;11523;11653.59212427561;11814.704632384259;12045.09661775388;12319;11224.66326010221;11519.30884146954;11536.172660728796;11635.360055196707;11855.110866685205;10063.798724025624;10093.646722364681;10132.544035518273;10177.236707247133;10227;9628.277879159232;9948.452835093849;10005.54975026111;10015.349002314826;10027.649032284127 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: __startTimestamp1450476185334__endTimestamp 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,343 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5327.40 Median:5496.51 stddev:589.22 (10.7%) stddev-sans-first:563.78 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: Values: 3069.7 3154.6 3198.2 3206.4 3213.3 5059.5 5215.6 5322.7 5349.1 5371.4 5285.9 5317.9 5386.6 5411.3 5419.2 4820.6 4866.3 4912.1 5033.4 5073.3 4642.9 4959.9 4982.7 5028.6 5054.5 4807.8 4830.2 4894.6 4922.1 4931.7 4758.5 4760.1 4769.8 4787.0 4802.4 4747.6 4786.6 4822.9 4831.4 4836.0 5137.2 5174.7 5191.1 5228.1 5277.6 5767.6 5778.5 5794.1 5801.7 5803.6 5622.3 5790.9 5795.7 5804.4 5822.5 5252.5 5275.7 5371.3 5424.5 5471.8 5752.9 5760.0 5764.7 5768.3 5825.3 5496.5 5590.0 5590.2 5602.3 5614.1 5644.4 5663.6 5797.7 5877.9 5929.4 5691.1 5717.3 5717.4 5733.9 5736.6 5577.8 5735.9 5758.8 5759.3 5764.0 4384.8 4439.5 4494.3 4532.6 4538.8 3969.7 3970.4 4001.5 4007.7 4008.9 5203.9 5444.9 5446.9 5453.3 5465.2 5681.6 5724.3 5730.6 5756.3 5786.4 5406.1 5428.5 5432.0 5442.1 5449.9 4934.7 4993.0 5055.2 5097.9 5150.6 5837.9 5902.3 5910.4 5935.1 5984.2 5768.4 5795.4 5797.0 5801.9 5808.1 5595.7 5890.1 5898.5 5924.4 5927.3 5493.3 5499.5 5514.4 5574.3 5612.3 5809.0 5827.5 5830.6 5835.5 5839.3 5433.7 5653.3 5689.3 5723.3 5723.7 5567.4 5589.2 5655.2 5727.6 5733.5 5455.9 5555.6 5585.5 5591.7 5598.4 5435.3 5654.5 5680.3 5684.7 5687.3 5410.9 5482.4 5487.9 5527.8 5543.9 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43814.17 Median:158853.54 stddev:70801.76 (44.6%) stddev-sans-first:70925.88 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: Values: 558.4 581.3 589.6 599.1 606.0 30478.1 31177.4 40871.2 41560.0 41628.8 44568.6 45412.3 45541.3 45557.3 45573.8 7564.7 8744.9 8894.1 8903.7 8907.0 7621.8 10515.4 10750.3 10752.9 10758.5 10482.6 10499.6 10592.9 10596.3 10598.3 7734.7 7836.3 10432.6 10574.9 10575.4 10318.4 10492.2 10494.4 10498.8 10501.6 39752.2 40290.0 40313.0 40342.6 40370.6 3167.1 3315.9 3845.4 3922.1 3977.5 30065.0 30345.8 30582.5 30610.5 31709.7 3787.4 3796.8 3826.0 3903.3 3914.2 280124.0 280870.0 282451.0 282806.0 284756.0 50403.5 51474.7 58375.4 58466.7 59159.7 52881.5 53117.8 53121.2 53437.7 53456.2 14226.9 14314.4 14351.4 14362.2 14431.4 10514.4 10518.0 10560.0 10574.1 10615.5 19218.7 19476.2 19481.9 19587.2 19739.4 7756.4 7836.6 7869.2 7936.5 8064.0 966.2 983.1 1033.7 1078.3 1080.8 28721.6 28798.9 28890.0 29020.6 29185.7 1009.3 1036.0 1043.0 1080.4 1138.4 13725.3 15565.8 15735.9 15777.4 16045.7 314341.0 314540.0 319262.0 320689.0 320693.0 52831.0 53090.7 53126.7 53127.2 53143.7 1347.7 1360.8 1364.2 1375.1 1375.1 28060.6 28723.7 29131.4 29163.1 29454.9 41643.0 42130.8 45741.8 46814.3 47623.8 198937.0 199091.0 200768.0 201209.0 201294.0 28502.3 28561.9 28902.6 29236.0 29291.3 38890.0 39472.6 39546.2 39725.0 40228.8 34697.7 35738.5 35795.5 36065.5 36402.3 35933.3 36752.3 36861.3 36961.0 36963.3 35044.8 35246.3 35272.0 35332.0 35671.8 27775.0 29186.3 29946.6 31703.4 31961.8 24159.6 24309.9 24617.3 24631.6 24675.9 14:03:05 INFO - 2015-12-18 14:03:05,344 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,345 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29257.23 Median:1348.51 stddev:89234.00 (6617.2%) stddev-sans-first:89457.93 14:03:05 INFO - 2015-12-18 14:03:05,346 DEBUG : BROWSER_OUTPUT: Values: 352.7 356.1 356.4 357.9 358.6 14058.3 14197.4 16424.4 16712.5 17440.8 13525.6 13734.3 17554.6 17848.0 17966.1 5172.2 5204.9 5259.5 5296.4 5306.9 3958.1 4082.2 5156.2 5330.4 5331.1 5638.5 5766.1 5786.2 5794.7 5796.5 5113.7 5672.7 5711.3 5862.9 5885.6 5204.3 5213.8 5216.7 5237.2 5256.4 20809.0 20920.5 21300.3 21390.9 21407.5 2127.6 2138.7 2233.5 2297.9 2344.4 13156.9 13259.9 13284.5 13708.2 13780.0 1734.5 1752.7 1762.3 1814.9 1876.3 58737.7 58967.7 59245.7 61333.7 61854.3 9882.6 10087.4 10198.9 10219.1 10255.9 13317.3 13371.6 13398.1 13406.5 13421.7 7434.9 7510.4 7533.6 7565.8 7606.2 7203.4 7229.0 7242.0 7272.7 7278.1 5937.5 6047.3 6073.5 6091.0 6091.3 1611.4 1657.3 1685.7 1722.0 1767.1 909.5 933.5 943.3 999.7 1025.0 17266.1 17628.6 18116.5 18748.6 18797.7 925.9 940.4 963.4 980.5 995.9 8663.3 10590.5 10635.5 10787.7 10809.4 518184.0 518541.0 541123.0 572105.0 581760.0 62439.4 70914.6 74181.0 79473.6 80070.2 1095.1 1102.5 1104.2 1111.7 1120.8 16025.8 16182.9 16353.3 16354.0 16735.8 36004.3 36980.8 37348.1 37695.8 37728.2 46836.3 49932.8 49970.0 50462.0 51769.7 9349.7 10133.7 10151.9 10165.9 10167.2 17754.1 17955.4 18023.1 18384.4 18447.4 14751.5 14872.9 14892.9 15262.8 15287.8 14531.6 14880.0 14892.6 15230.4 15395.2 14856.5 14960.1 15116.5 15433.8 15773.8 8921.3 9654.1 9701.5 9819.9 9856.5 9534.4 9546.0 13848.1 13945.2 14579.6 14:03:05 INFO - 2015-12-18 14:03:05,346 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,346 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5225.01 Median:6174.07 stddev:2648.54 (42.9%) stddev-sans-first:2639.51 14:03:05 INFO - 2015-12-18 14:03:05,347 DEBUG : BROWSER_OUTPUT: Values: 1298.1 1369.4 1440.6 1559.9 1760.4 6753.9 7220.4 7514.7 7554.3 7576.9 7218.7 7362.6 7366.4 7367.7 7385.0 1964.8 2027.4 2034.7 2237.7 2306.7 2234.8 2267.2 2268.2 2273.5 2273.9 2207.0 2207.2 2280.7 2280.9 2281.5 2277.6 2288.6 2290.5 2308.7 2317.3 2232.0 2268.8 2287.6 2288.7 2291.9 7564.4 7631.1 7637.5 7651.8 7660.2 4517.3 4588.5 4592.3 4606.7 4626.6 3021.9 3032.6 3050.1 3067.8 3155.5 1054.9 1064.6 1069.6 1090.6 1109.2 10029.7 10084.6 10096.3 10144.5 10146.1 4096.8 4137.1 4197.2 4231.2 4237.3 8502.7 8520.7 8520.9 8523.2 8526.0 4637.4 4649.3 4661.9 4666.1 4673.3 4242.3 4253.4 4255.9 4292.8 4293.1 3260.1 3297.2 3489.3 3586.5 3671.8 1156.3 1163.1 1166.8 1177.4 1179.1 1003.6 1034.1 1037.0 1174.4 1352.6 6710.5 6770.4 6802.7 6814.0 6826.5 1100.5 1105.3 1107.3 1118.2 1126.7 5293.4 5353.3 5360.7 5365.9 5373.3 8813.6 8830.5 9055.2 9122.4 9130.6 8914.3 8982.1 8996.6 9001.2 9011.8 6772.2 7068.9 7074.0 7148.8 7179.6 6734.0 6740.2 6762.4 6764.6 6769.8 7819.8 7999.4 8120.8 8120.9 8128.6 7887.3 8089.1 8104.2 8244.2 8259.0 6445.8 6475.5 6542.6 6600.6 6636.7 6425.6 6586.3 6686.0 6831.1 7149.5 6557.3 6581.2 6653.5 6715.1 6831.4 6527.9 6633.0 6721.4 6725.1 6824.7 6660.5 6682.0 6690.1 6696.0 6707.3 6151.0 6201.8 6223.5 6233.3 6246.0 6197.1 6218.1 6218.4 6218.6 6223.4 14:03:05 INFO - 2015-12-18 14:03:05,348 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,348 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5305.80 Median:6032.16 stddev:1590.14 (26.4%) stddev-sans-first:1550.39 14:03:05 INFO - 2015-12-18 14:03:05,348 DEBUG : BROWSER_OUTPUT: Values: 344.5 346.2 347.7 349.8 352.6 5821.7 5951.6 5985.6 6000.4 6026.2 5672.7 5706.5 5781.3 5870.7 5891.4 4545.6 4558.7 4580.5 4580.5 4593.7 4558.1 4568.9 4570.2 4576.0 4588.7 4307.0 4433.4 4460.0 4563.3 4577.8 4544.5 4558.3 4561.5 4571.5 4582.2 4039.8 4047.2 4049.2 4053.2 4053.8 5589.6 5591.1 5596.1 5598.7 5609.3 5175.4 5319.8 5321.4 5326.4 5329.8 6287.8 6298.2 6298.7 6299.5 6302.1 4393.9 4429.1 4434.4 4435.4 4440.0 6366.6 6467.0 6507.5 6526.7 6552.7 4529.3 4540.7 4543.3 4543.5 4547.2 4580.5 4585.0 4593.6 4595.4 4598.1 5242.4 5288.1 5290.4 5296.8 5300.9 6176.0 6299.7 6307.4 6314.2 6325.1 1594.3 1623.2 1623.2 1624.0 1624.5 1070.4 1074.9 1092.2 1093.5 1095.8 6096.9 6097.2 6114.9 6122.2 6132.6 6491.5 6534.0 6541.1 6544.6 6552.6 5945.0 6038.1 6067.4 6166.3 6174.6 3544.3 3544.6 3560.7 3565.6 3567.5 6730.2 6738.2 6742.9 6744.5 6756.0 6584.9 6741.0 6745.4 6760.4 6764.2 6699.9 6734.7 6744.8 6754.1 6756.7 6578.4 6587.6 6594.7 6597.5 6599.8 6290.1 6481.0 6509.4 6522.9 6528.1 6730.5 6736.4 6742.4 6746.5 6750.2 4543.9 4587.7 4588.4 4589.3 4591.0 6362.7 6570.8 6602.0 6606.4 6622.4 6426.0 6432.6 6436.6 6439.9 6442.2 6367.7 6401.1 6409.9 6413.6 6421.9 6155.9 6287.1 6287.3 6287.4 6293.0 6411.3 6420.8 6422.0 6423.0 6432.9 6217.7 6255.5 6266.4 6270.6 6278.4 14:03:05 INFO - 2015-12-18 14:03:05,348 DEBUG : BROWSER_OUTPUT: 14:03:05 INFO - 2015-12-18 14:03:05,348 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14006.05 Median:4298.10 stddev:15955.01 (371.2%) stddev-sans-first:15969.12 14:03:05 INFO - 2015-12-18 14:03:05,349 DEBUG : BROWSER_OUTPUT: Values: 837.4 848.8 860.7 873.9 877.7 15691.5 16173.8 16190.4 16190.5 16199.7 14682.6 14684.9 14745.4 14775.6 14783.6 685.5 698.6 813.3 828.4 831.5 811.7 816.2 824.5 830.5 831.4 863.3 873.4 878.2 878.9 879.0 720.8 729.0 848.4 870.8 871.1 639.1 639.2 639.2 639.3 639.7 13370.4 13485.0 13493.9 13533.5 13551.3 11503.1 11734.5 11911.7 12114.8 12152.5 10136.9 10147.9 10153.1 10606.8 10763.6 3616.6 3643.5 3651.9 3672.6 3854.0 45837.8 47104.8 47137.8 47186.0 47200.3 9901.4 10026.4 10227.5 10410.2 10546.5 18585.7 18608.2 18623.2 18638.7 18642.6 7396.5 7534.2 7546.5 7570.5 7589.1 4248.0 4256.0 4284.9 4288.7 4307.5 2963.3 2970.8 2994.0 3002.8 3003.3 552.5 558.1 565.3 566.2 571.4 575.9 617.4 638.3 642.3 643.7 8255.8 8256.7 8520.2 8582.8 8668.4 489.0 504.9 609.6 618.6 678.6 3865.8 4007.9 4132.8 4169.5 4207.6 52445.0 56982.0 57429.4 57526.1 57987.7 48691.5 49225.8 49492.3 49978.3 53143.7 44238.6 44451.6 44896.8 46219.5 46250.0 8496.7 8754.1 8838.6 9003.3 9105.4 32923.9 33172.0 33942.3 34105.5 34155.1 49187.3 49228.5 49304.0 50439.0 54340.0 11606.7 11662.8 11703.4 11730.6 12005.2 12239.4 12368.4 12398.0 13033.4 13062.2 11562.6 11585.7 11650.1 11900.7 11953.8 11523.0 11653.6 11814.7 12045.1 12319.0 11224.7 11519.3 11536.2 11635.4 11855.1 10063.8 10093.6 10132.5 10177.2 10227.0 9628.3 9948.5 10005.5 10015.3 10027.6 14:03:05 INFO - 2015-12-18 14:03:05,349 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:03:05 INFO - 2015-12-18 14:03:05,349 DEBUG : BROWSER_OUTPUT: 14:03:06 INFO - 2015-12-18 14:03:06,026 INFO : Browser exited with error code: 0 14:03:06 INFO - 2015-12-18 14:03:06,042 INFO : Completed test dromaeo_css (00:18:32) 14:03:06 INFO - 2015-12-18 14:03:06,042 INFO : Starting test kraken 14:03:06 INFO - 2015-12-18 14:03:06,042 DEBUG : operating with platform_type : linux_ 14:03:06 INFO - 2015-12-18 14:03:06,043 INFO : Initialising browser for kraken test... 14:03:06 INFO - 2015-12-18 14:03:06,049 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZhJJcG/profile http://localhost:56674/getInfo.html 14:03:09 INFO - 2015-12-18 14:03:09,995 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:03:09 INFO - 2015-12-18 14:03:09,995 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:03:09 INFO - 2015-12-18 14:03:09,995 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:03:09 INFO - 2015-12-18 14:03:09,995 DEBUG : BROWSER_OUTPUT: __metrics 14:03:10 INFO - 2015-12-18 14:03:10,096 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:03:10 INFO - 2015-12-18 14:03:10,137 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:10 ERROR - 2015-12-18 14:03:10,152 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:03:10 INFO - 2015-12-18 14:03:10,919 INFO : Browser initialized. 14:03:10 INFO - 2015-12-18 14:03:10,920 INFO : Running cycle 1/1 for kraken test... 14:03:10 INFO - 2015-12-18 14:03:10,920 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZhJJcG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:22 INFO - 2015-12-18 14:03:22,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 149647360 14:03:22 INFO - 2015-12-18 14:03:22,655 DEBUG : BROWSER_OUTPUT: 14:03:25 INFO - 2015-12-18 14:03:25,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56674/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:25 INFO - 2015-12-18 14:03:25,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 187133952 14:03:25 INFO - 2015-12-18 14:03:25,708 DEBUG : BROWSER_OUTPUT: 14:03:28 INFO - 2015-12-18 14:03:28,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56674/tests/kraken/driver.html?testName=audio-dft) 14:03:28 INFO - 2015-12-18 14:03:28,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 176705536 14:03:28 INFO - 2015-12-18 14:03:28,872 DEBUG : BROWSER_OUTPUT: 14:03:31 INFO - 2015-12-18 14:03:31,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56674/tests/kraken/driver.html?testName=audio-fft) 14:03:32 INFO - 2015-12-18 14:03:32,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 160198656 14:03:32 INFO - 2015-12-18 14:03:32,278 DEBUG : BROWSER_OUTPUT: 14:03:34 INFO - 2015-12-18 14:03:34,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56674/tests/kraken/driver.html?testName=audio-oscillator) 14:03:34 INFO - 2015-12-18 14:03:34,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 163061760 14:03:34 INFO - 2015-12-18 14:03:34,828 DEBUG : BROWSER_OUTPUT: 14:03:37 INFO - 2015-12-18 14:03:37,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:37 INFO - 2015-12-18 14:03:37,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 164823040 14:03:37 INFO - 2015-12-18 14:03:37,573 DEBUG : BROWSER_OUTPUT: 14:03:40 INFO - 2015-12-18 14:03:40,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56674/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:41 INFO - 2015-12-18 14:03:41,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 163774464 14:03:41 INFO - 2015-12-18 14:03:41,026 DEBUG : BROWSER_OUTPUT: 14:03:44 INFO - 2015-12-18 14:03:44,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56674/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:44 INFO - 2015-12-18 14:03:44,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 164835328 14:03:44 INFO - 2015-12-18 14:03:44,939 DEBUG : BROWSER_OUTPUT: 14:03:47 INFO - 2015-12-18 14:03:47,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56674/tests/kraken/driver.html?testName=json-parse-financial) 14:03:48 INFO - 2015-12-18 14:03:48,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 165814272 14:03:48 INFO - 2015-12-18 14:03:48,266 DEBUG : BROWSER_OUTPUT: 14:03:49 INFO - 2015-12-18 14:03:49,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:50 INFO - 2015-12-18 14:03:50,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 175263744 14:03:50 INFO - 2015-12-18 14:03:50,382 DEBUG : BROWSER_OUTPUT: 14:03:52 INFO - 2015-12-18 14:03:52,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:52 INFO - 2015-12-18 14:03:52,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 172744704 14:03:52 INFO - 2015-12-18 14:03:52,774 DEBUG : BROWSER_OUTPUT: 14:03:54 INFO - 2015-12-18 14:03:54,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:55 INFO - 2015-12-18 14:03:55,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 181661696 14:03:55 INFO - 2015-12-18 14:03:55,399 DEBUG : BROWSER_OUTPUT: 14:03:57 INFO - 2015-12-18 14:03:57,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:58 INFO - 2015-12-18 14:03:58,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 189353984 14:03:58 INFO - 2015-12-18 14:03:58,398 DEBUG : BROWSER_OUTPUT: 14:04:00 INFO - 2015-12-18 14:04:00,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:01 INFO - 2015-12-18 14:04:01,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 189636608 14:04:01 INFO - 2015-12-18 14:04:01,535 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56674/tests/kraken/driver.html?testName=ai-astar) 14:04:03 INFO - 2015-12-18 14:04:03,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 248324096 14:04:03 INFO - 2015-12-18 14:04:03,452 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,452 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;112;111;110;99;110;111;116 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;128;143;163;130;152;155;127;169;123 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;160;163;160;160;165;161;161 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;85;92;72;72;71;94;89;71 14:04:03 INFO - 2015-12-18 14:04:03,453 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;140;93;93;94;138;93;93;140 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;57;58;59;57;65;56;56 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;67;67;68;67;67;68;68 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;84;86;85;85;85;85;85 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;116;121;130;121;115;117;121;131;121 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;151;152;151;139;141;149;149;151;141 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;70;67;68;67;70;66;67;65;68 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:04:03 INFO - 2015-12-18 14:04:03,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: __startTimestamp1450476243446__endTimestamp 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:4.55 (4.1%) stddev-sans-first:4.82 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 112.0 111.0 110.0 99.0 110.0 111.0 116.0 14:04:03 INFO - 2015-12-18 14:04:03,455 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,456 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.00 stddev:16.51 (10.8%) stddev-sans-first:17.14 14:04:03 INFO - 2015-12-18 14:04:03,456 DEBUG : BROWSER_OUTPUT: Values: 154.0 128.0 143.0 163.0 130.0 152.0 155.0 127.0 169.0 123.0 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:160.50 stddev:1.70 (1.1%) stddev-sans-first:1.76 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 160.0 163.0 160.0 160.0 165.0 161.0 161.0 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:78.50 stddev:9.91 (12.6%) stddev-sans-first:10.10 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 85.0 92.0 72.0 72.0 71.0 94.0 89.0 71.0 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.00 stddev:22.25 (23.9%) stddev-sans-first:23.09 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 140.0 93.0 93.0 94.0 138.0 93.0 93.0 140.0 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,457 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:04:03 INFO - 2015-12-18 14:04:03,458 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:2.59 (4.4%) stddev-sans-first:2.74 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 57.0 58.0 59.0 57.0 65.0 56.0 56.0 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 68.0 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,459 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 84.0 86.0 85.0 85.0 85.0 85.0 85.0 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.00 stddev:5.61 (4.6%) stddev-sans-first:5.66 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: Values: 116.0 116.0 121.0 130.0 121.0 115.0 117.0 121.0 131.0 121.0 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:150.00 stddev:5.17 (3.4%) stddev-sans-first:5.21 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: Values: 142.0 151.0 152.0 151.0 139.0 141.0 149.0 149.0 151.0 141.0 14:04:03 INFO - 2015-12-18 14:04:03,460 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-18 14:04:03,461 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.65 (2.4%) stddev-sans-first:1.67 14:04:03 INFO - 2015-12-18 14:04:03,461 DEBUG : BROWSER_OUTPUT: Values: 66.0 70.0 67.0 68.0 67.0 70.0 66.0 67.0 65.0 68.0 14:04:03 INFO - 2015-12-18 14:04:03,461 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:03 INFO - 2015-12-18 14:04:03,461 DEBUG : BROWSER_OUTPUT: 14:04:04 INFO - 2015-12-18 14:04:04,302 INFO : Browser exited with error code: 0 14:04:04 INFO - 2015-12-18 14:04:04,358 INFO : Completed test kraken (00:00:58) 14:04:04 INFO - 2015-12-18 14:04:04,358 INFO : Starting test v8_7 14:04:04 INFO - 2015-12-18 14:04:04,358 DEBUG : operating with platform_type : linux_ 14:04:04 INFO - 2015-12-18 14:04:04,358 INFO : Initialising browser for v8_7 test... 14:04:04 INFO - 2015-12-18 14:04:04,365 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDRdDx2/profile http://localhost:56674/getInfo.html 14:04:08 INFO - 2015-12-18 14:04:08,302 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:04:08 INFO - 2015-12-18 14:04:08,302 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:04:08 INFO - 2015-12-18 14:04:08,302 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:04:08 INFO - 2015-12-18 14:04:08,302 DEBUG : BROWSER_OUTPUT: __metrics 14:04:08 INFO - 2015-12-18 14:04:08,391 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:04:08 INFO - 2015-12-18 14:04:08,447 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:04:08 ERROR - 2015-12-18 14:04:08,450 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:04:09 INFO - 2015-12-18 14:04:09,235 INFO : Browser initialized. 14:04:09 INFO - 2015-12-18 14:04:09,235 INFO : Running cycle 1/1 for v8_7 test... 14:04:09 INFO - 2015-12-18 14:04:09,236 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDRdDx2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:04:21 INFO - 2015-12-18 14:04:21,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 149688320 14:04:21 INFO - 2015-12-18 14:04:21,052 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56674/tests/v8_7/run.html (next: http://localhost:56674/tests/v8_7/run.html) 14:04:42 INFO - 2015-12-18 14:04:42,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 613060608 14:04:42 INFO - 2015-12-18 14:04:42,745 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,746 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:42 INFO - 2015-12-18 14:04:42,746 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:42 INFO - 2015-12-18 14:04:42,746 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:42 INFO - 2015-12-18 14:04:42,746 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:42 INFO - 2015-12-18 14:04:42,746 DEBUG : BROWSER_OUTPUT: |0;Richards;166.14055490945339 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.6080724254998 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 14:04:42 INFO - 2015-12-18 14:04:42,747 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 14:04:42 INFO - 2015-12-18 14:04:42,748 DEBUG : BROWSER_OUTPUT: |7;RegExp;24926.829268292684 14:04:42 INFO - 2015-12-18 14:04:42,748 DEBUG : BROWSER_OUTPUT: |8;Splay;677.9661016949152 14:04:42 INFO - 2015-12-18 14:04:42,748 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 14:04:42 INFO - 2015-12-18 14:04:42,748 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:42 INFO - 2015-12-18 14:04:42,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1450476282742__endTimestamp 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: Values: 166.1 14:04:42 INFO - 2015-12-18 14:04:42,749 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.61 Median:188.61 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: Values: 188.6 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: Values: 279.6 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,750 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: Values: 5196.9 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: Values: 1960.8 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,751 DEBUG : BROWSER_OUTPUT: Values: 782.5 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: Values: 12512.5 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: Values: 24926.8 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,752 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.97 Median:677.97 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: Values: 678.0 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: Values: 4822.1 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:42 INFO - 2015-12-18 14:04:42,753 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-18 14:04:43,622 INFO : Browser exited with error code: 0 14:04:43 INFO - 2015-12-18 14:04:43,634 INFO : Completed test v8_7 (00:00:39) 14:04:43 INFO - 2015-12-18 14:04:43,695 INFO : Completed test suite (00:20:10) 14:04:43 INFO - 2015-12-18 14:04:43,696 DEBUG : Working with test: dromaeo_css 14:04:43 INFO - 2015-12-18 14:04:43,696 DEBUG : Generating results file: dromaeo_css 14:04:43 INFO - 2015-12-18 14:04:43,697 DEBUG : Working with test: kraken 14:04:43 INFO - 2015-12-18 14:04:43,697 DEBUG : Generating results file: kraken 14:04:43 INFO - 2015-12-18 14:04:43,697 INFO : javascript benchmark 14:04:43 INFO - 2015-12-18 14:04:43,697 DEBUG : Working with test: v8_7 14:04:43 INFO - 2015-12-18 14:04:43,698 DEBUG : Generating results file: v8_7 14:04:43 INFO - 2015-12-18 14:04:43,698 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:43 INFO - 2015-12-18 14:04:43,756 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:04:43 INFO - 2015-12-18 14:04:43,756 DEBUG : process_Request line: dromaeo_css 7000.34 graph.html#tests=[[72,201,35]] 14:04:43 INFO - 2015-12-18 14:04:43,756 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:43 INFO - 2015-12-18 14:04:43,790 DEBUG : process_Request line: kraken 1496.00 graph.html#tests=[[232,201,35]] 14:04:43 INFO - 2015-12-18 14:04:43,790 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:43 INFO - 2015-12-18 14:04:43,827 DEBUG : process_Request line: v8_7 19684.66 graph.html#tests=[[230,201,35]] 14:04:43 INFO - 2015-12-18 14:04:43,828 INFO : javascript benchmark 14:04:43 INFO - 2015-12-18 14:04:43,832 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3069.7237248647616, 3154.621445426549, 3198.248411623268, 3206.422843888099, 3213.3412650406667, 5059.544640982311, 5215.556677682402, 5322.654027488211, 5349.063913815082, 5371.382291036532, 5285.8942821143555, 5317.867053323669, 5386.622936394454, 5411.296531450916, 5419.160030195326, 4820.614350851941, 4866.31871537985, 4912.0912631163255, 5033.370828646419, 5073.3404657394485, 4642.930356044662, 4959.900801983958, 4982.651214414992, 5028.647994640377, 5054.494550544934, 4807.759612019385, 4830.154722923475, 4894.583960363373, 4922.064807686528, 4931.7040977541465, 4758.547937945889, 4760.071786001731, 4769.809207631691, 4786.952130478686, 4802.375691160162, 4747.620190384795, 4786.569208771192, 4822.903541929177, 4831.444383895861, 4835.975820120877, 5137.178051511778, 5174.741262936838, 5191.0656081905245, 5228.111221092423, 5277.630565860353, 5767.625104368202, 5778.451047150514, 5794.130880367937, 5801.7389217485315, 5803.622764520335, 5622.3253209614695, 5790.942090579082, 5795.652260864362, 5804.419558044204, 5822.534197264251, 5252.501012403815, 5275.709835959021, 5371.274877891474, 5424.484673955968, 5471.8084867029465, 5752.913706294409, 5759.971200143972, 5764.740586673526, 5768.3366412862215, 5825.271841019872, 5496.5053145217125, 5589.965856316594, 5590.24531688225, 5602.299712535933, 5614.129809879475, 5644.3508996465935, 5663.631863928831, 5797.652140871562, 5877.941220587825, 5929.436703513159, 5691.0609749391715, 5717.256756621613, 5717.3996730342715, 5733.8566535836935, 5736.627119237236, 5577.8047768327915, 5735.8566035849435, 5758.827235182951, 5759.280089988752, 5764.0, 4384.846530371422, 4439.489458712289, 4494.280915053576, 4532.614727748112, 4538.841140560065, 3969.702272329587, 3970.404439334123, 4001.479807625048, 4007.6793856491413, 4008.939865902014, 5203.869903252449, 5444.891102177934, 5446.945530544644, 5453.318335208099, 5465.152901300305, 5681.602287839894, 5724.255846739898, 5730.598858079894, 5756.280464941882, 5786.421357864264, 5406.053940560386, 5428.4842939920645, 5432.049391356497, 5442.074847275972, 5449.863753406196, 4934.6545741798445, 4993.0, 5055.191169412877, 5097.898042039138, 5150.587952963754, 5837.88324233513, 5902.321233058254, 5910.408959104056, 5935.109733540004, 5984.1921340618455, 5768.394318596655, 5795.420457954339, 5797.043487824461, 5801.883962320814, 5808.128780682931, 5595.692236926845, 5890.057590785454, 5898.469137777621, 5924.377940316377, 5927.2590926134235, 5493.2858728366655, 5499.4775496329385, 5514.448555144453, 5574.275344205227, 5612.270404847343, 5809.0, 5827.504662103599, 5830.5627077968475, 5835.4748072673665, 5839.270091238595, 5433.701146436984, 5653.321601407857, 5689.288838895138, 5723.255976723, 5723.6851973141875, 5567.4432556744005, 5589.161625756006, 5655.236543066633, 5727.599068065196, 5733.541316694571, 5455.890882182413, 5555.638883472561, 5585.469380408855, 5591.720413979366, 5598.35618903815, 5435.347758269033, 5654.519365853948, 5680.318361796611, 5684.71576421169, 5687.289088863892, 5410.891782164256, 5482.369527504388, 5487.862803429946, 5527.806526771544, 5543.944560554342], "unit": "score", "name": "dojo.html", "value": 5289.33665249083}, {"lowerIsBetter": false, "replicates": [558.3960921984782, 581.3227589857814, 589.631480324797, 599.110321173058, 605.9969700151498, 30478.085657430285, 31177.376452470937, 40871.18257634845, 41560.0, 41628.791856040756, 44568.554314456844, 45412.31881521772, 45541.31688024674, 45557.31664025034, 45573.77213113938, 7564.735234266802, 8744.912550874506, 8894.11058894112, 8903.732888013337, 8906.999999999967, 7621.771346859603, 10515.421651809147, 10750.301230420037, 10752.946235268813, 10758.462076896163, 10482.633107841228, 10499.632512862052, 10592.947035264813, 10596.258261921668, 10598.311109777878, 7734.651940662684, 7836.255555722198, 10432.582696692123, 10574.894251057467, 10575.365478071302, 10318.432486213254, 10492.16062714981, 10494.422806745626, 10498.842517362245, 10501.579936802518, 39752.20495590101, 40290.0, 40313.0, 40342.59657403418, 40370.59629403727, 3167.0815463515783, 3315.9171020724434, 3845.4231865220163, 3922.0587059105897, 3977.5226972763166, 30065.0, 30345.848270758725, 30582.541261881088, 30610.54084188739, 31709.682903171135, 3787.394016957301, 3796.7532110412735, 3825.9617403825882, 3903.258380907647, 3914.197589494147, 280124.0, 280870.0, 282451.0, 282806.0, 284756.0, 50403.49596503988, 51474.74262628663, 58375.41624583785, 58466.707666462244, 59159.70420147958, 52881.47118528842, 53117.82909307194, 53121.2031819523, 53437.73281133647, 53456.19815702768, 14226.857731422553, 14314.427422902967, 14351.354189061518, 14362.210078445785, 14431.42274309016, 10514.421706806046, 10518.0, 10560.0, 10574.101201397814, 10615.469226538642, 19218.71507686217, 19476.220951161795, 19481.902590486956, 19587.216511339386, 19739.40781776549, 7756.418268629763, 7836.568988705676, 7869.213078692085, 7936.523808571505, 8064.0, 966.1884017425397, 983.0808194338316, 1033.7105610429091, 1078.2991055813627, 1080.7892460970193, 28721.56917646237, 28798.856005719837, 28890.0, 29020.564691529646, 29185.708142918724, 1009.2531526670358, 1035.9896401036044, 1043.045613263855, 1080.448971024783, 1138.351139850294, 13725.313734313244, 15565.766513502307, 15735.921320393325, 15777.368905243891, 16045.679086418206, 314341.0, 314540.0, 319262.0, 320689.0, 320693.0, 52831.0, 53090.73454632702, 53126.734366327924, 53127.20309195365, 53143.73428132835, 1347.6765576261823, 1360.7822748360215, 1364.2360278244214, 1375.0580852116132, 1375.1336657905456, 28060.579091314055, 28723.712762872103, 29131.41737165287, 29163.125106246847, 29454.852725736233, 41643.0, 42130.789346053076, 45741.771291143334, 46814.29778553393, 47623.76188119176, 198937.0, 199091.0, 200768.0, 201209.0, 201294.0, 28502.287442814097, 28561.857190713912, 28902.566461503517, 29236.0, 29291.267718307212, 38890.0, 39472.605273946894, 39546.2090758189, 39725.0, 40228.79885600553, 34697.653023470455, 35738.463923040654, 35795.46306805452, 36065.459018115274, 36402.27195456129, 35933.28133437369, 36752.26495470022, 36861.26277474489, 36961.0, 36963.26073478461, 35044.82477587698, 35246.29507409889, 35272.0, 35332.0, 35671.82164089163, 27775.0, 29186.270343241587, 29946.640531417474, 31703.365932680757, 31961.840190798895, 24159.637605435582, 24309.850430125196, 24617.261482155565, 24631.63052554249, 24675.876620616782], "unit": "score", "name": "ext.html", "value": 18398.37916320792}, {"lowerIsBetter": false, "replicates": [352.66496828013385, 356.0848619049042, 356.39946689827644, 357.85149163097316, 358.587624232133, 14058.297085145727, 14197.373485905115, 16424.425145119923, 16712.49862504125, 17440.82559174408, 13525.594232173025, 13734.313284335793, 17554.561135971606, 17848.0, 17966.101694915236, 5172.198309262061, 5204.869878253055, 5259.500347466985, 5296.417394086648, 5306.946930530703, 3958.1094253792953, 4082.2243773682903, 5156.189876517307, 5330.3603567571945, 5331.120365139747, 5638.520725738317, 5766.106253530709, 5786.218860453848, 5794.739236734357, 5796.50729687977, 5113.667611605234, 5672.659640421588, 5711.2575365202465, 5862.853428664275, 5885.5585831062845, 5204.271402003723, 5213.843584692465, 5216.686998780086, 5237.240600112962, 5256.369235691704, 20809.0, 20920.47698807527, 21300.254491092892, 21390.893045534674, 21407.46481337979, 2127.574485102986, 2138.7112739780086, 2233.5197932444603, 2297.873616951067, 2344.355302291883, 13156.868431315756, 13259.933700331436, 13284.53504127351, 13708.24604646744, 13780.0, 1734.540346808097, 1752.7195648696274, 1762.2774662388358, 1814.936477223291, 1876.3245231716571, 58737.706311468595, 58967.70516147392, 59245.7037714813, 61333.69333153305, 61854.28874267513, 9882.555285012191, 10087.394756314645, 10198.949005254926, 10219.13137383316, 10255.897441025643, 13317.334133293296, 13371.598852034454, 13398.062135650605, 13406.530771423148, 13421.731565368833, 7434.851302974019, 7510.361619262315, 7533.623318834037, 7565.773026809205, 7606.201348858401, 7203.351698347174, 7228.96385518069, 7242.022326985895, 7272.709091636381, 7278.09023872016, 5937.495312898365, 6047.274327080779, 6073.453389194994, 6090.969545152246, 6091.299500557404, 1611.4440518021263, 1657.312215430583, 1685.7471379292958, 1721.9741703874452, 1767.081117818727, 909.5315912305168, 933.5239028095721, 943.2595412601075, 999.6651121874108, 1025.0467065628889, 17266.136693165543, 17628.647427051386, 18116.456506304832, 18748.625027499373, 18797.718034229496, 925.8842644669417, 940.351157701184, 963.3786207895868, 980.5293459139652, 995.9103680668775, 8663.306935445149, 10590.523426445829, 10635.468226588795, 10787.67636970892, 10809.35143891369, 518184.0, 518541.0, 541123.0, 572105.0, 581760.0, 62439.37560624426, 70914.64542677253, 74181.0, 79473.60263198648, 80070.19929800744, 1095.1403148528527, 1102.4542851288504, 1104.221523825717, 1111.699841042914, 1120.7758448310371, 16025.759613606038, 16182.919085404497, 16353.264103115627, 16354.0, 16735.832641673427, 36004.27991440209, 36980.81509592435, 37348.06629834276, 37695.81152094222, 37728.2454350906, 46836.29745553888, 49932.750336248086, 49970.0, 50462.0, 51769.741151294, 9349.672761453316, 10133.695989120339, 10151.94924025375, 10165.949170254102, 10167.186625070124, 17754.112294385486, 17955.371561995267, 18023.098845057957, 18384.448466546026, 18447.446576602724, 14751.483698070517, 14872.925635371754, 14892.925535372255, 15262.771058434355, 15287.847121528643, 14531.636709082357, 14880.0, 14892.62768430798, 15230.390784368501, 15395.153266570445, 14856.480023199136, 14960.102393856403, 15116.470923517623, 15433.768493472831, 15773.842261577238, 8921.330900182382, 9654.082862128087, 9701.514924253901, 9819.901800982185, 9856.457894815854, 9534.380265282734, 9546.0, 13848.09987350819, 13945.233012184022, 14579.635509112357], "unit": "score", "name": "jquery.html", "value": 9101.30260442744}, {"lowerIsBetter": false, "replicates": [1298.0783643613033, 1369.417997351126, 1440.5966329427758, 1559.9298031588585, 1760.419061709636, 6753.898691519631, 7220.422366210703, 7514.699412023526, 7554.282343177403, 7576.924230757684, 7218.6751596178165, 7362.595057271861, 7366.447516436262, 7367.705291788336, 7385.0, 1964.8428125749906, 2027.401916434648, 2034.6541088015074, 2237.7090978172814, 2306.7347255065715, 2234.8100411465043, 2267.240474441064, 2268.1947908492493, 2273.5111950930545, 2273.863568185914, 2206.9889650551727, 2207.2164381644448, 2280.6921065656175, 2280.8859557022165, 2281.543691261746, 2277.6128058229974, 2288.553732022256, 2290.5075408787025, 2308.7114110736156, 2317.316391664463, 2232.0402227042364, 2268.8184945204507, 2287.611106111965, 2288.6910267113894, 2291.919782807594, 7564.432667549956, 7631.12242092161, 7637.541747495168, 7651.808704782369, 7660.195679453688, 4517.299818528133, 4588.472325682523, 4592.33411155384, 4606.700564463299, 4626.583607475343, 3021.894233701832, 3032.5754394384803, 3050.100220434977, 3067.7852550321486, 3155.4793459079224, 1054.947252637365, 1064.6486659402456, 1069.58820853971, 1090.6455401994303, 1109.2180013090751, 10029.69910902674, 10084.596616135346, 10096.34373765703, 10144.543495542719, 10146.086852183265, 4096.795160241976, 4137.089840235143, 4197.223513649923, 4231.19607274623, 4237.300845360481, 8502.659893604186, 8520.659173632985, 8520.8721869172, 8523.232909038215, 8526.0, 4637.420322459692, 4649.325847752057, 4661.883452913704, 4666.0901124280435, 4673.322368256584, 4242.278812601865, 4253.404523366731, 4255.936160957588, 4292.785360731951, 4293.0984493256765, 3260.136063943057, 3297.20866991925, 3489.2672538766637, 3586.4620306953643, 3671.834767435472, 1156.3177725142207, 1163.0753550927034, 1166.830809532613, 1177.4289469607234, 1179.1215544419463, 1003.5935446144323, 1034.0796690945065, 1036.9637062702768, 1174.4186627619383, 1352.594221733476, 6710.496712746563, 6770.424513916274, 6802.727890884408, 6814.0, 6826.522143449911, 1100.471773548701, 1105.2926127278547, 1107.3245320354577, 1118.2284223885656, 1126.6732647532288, 5293.417724050351, 5353.250544923714, 5360.678359298377, 5365.865853353619, 5373.328333958255, 8813.603387847563, 8830.470171789713, 9055.18503334703, 9122.36143469964, 9130.589123489459, 8914.33142514314, 8982.101789820965, 8996.59515321812, 9001.234895033995, 9011.819763604692, 6772.2211945625895, 7068.893966590505, 7074.009638650593, 7148.821279467951, 7179.569225846466, 6733.966330168318, 6740.157480314961, 6762.357576030269, 6764.5941243523575, 6769.763058292936, 7819.765407037798, 7999.360051195774, 8120.837583248183, 8120.918790812017, 8128.634211460617, 7887.250711182429, 8089.069756978023, 8104.189581041848, 8244.175582441947, 8259.0, 6445.807525607777, 6475.481961442979, 6542.640154791532, 6600.570962887397, 6636.701348439428, 6425.58233714807, 6586.341365863375, 6686.0, 6831.11195544576, 7149.463790215651, 6557.344265573404, 6581.177352830896, 6653.467722582085, 6715.093462382712, 6831.385175334244, 6527.934720652923, 6633.0, 6721.361470660279, 6725.058491811053, 6824.669189508197, 6660.467162627075, 6682.0, 6690.13028306317, 6695.966520167368, 6707.262201157771, 6151.046587778901, 6201.844953876189, 6223.471004964629, 6233.345498722751, 6246.031865060922, 6197.101420294122, 6218.06728990655, 6218.440340369389, 6218.595791273553, 6223.439890409885], "unit": "score", "name": "mootools.html", "value": 4336.5512015463055}, {"lowerIsBetter": false, "replicates": [344.4540403460515, 346.1553808706754, 347.73398350262056, 349.82159098859574, 352.6403068869754, 5821.67980761058, 5951.553633477485, 5985.610935289204, 6000.3699611540815, 6026.186464827247, 5672.659640421578, 5706.457886500786, 5781.277340332458, 5870.677112758796, 5891.381404952483, 4545.636349092065, 4558.726476411426, 4580.473245576752, 4580.519045500225, 4593.655475839309, 4558.133954548642, 4568.908621827562, 4570.223062079454, 4576.039031803325, 4588.678792484528, 4306.978465107686, 4433.423654924872, 4459.996500787313, 4563.338315944203, 4577.771111444431, 4544.545545445429, 4558.270676691746, 4561.543845615445, 4571.4514258289055, 4582.19811532982, 4039.7778122203267, 4047.2107938951917, 4049.2104039712267, 4053.1893621275567, 4053.7770422626745, 5589.552835773128, 5591.10542313232, 5596.076647353182, 5598.748056337475, 5609.3268807742925, 5175.430702622709, 5319.840404787863, 5321.4412486688725, 5326.414094449608, 5329.840104796862, 6287.842803929892, 6298.212723409574, 6298.6535740534255, 6299.496040316763, 6302.1177035215105, 4393.890152746175, 4429.13631841791, 4434.379186913835, 4435.356873253392, 4440.045390241114, 6366.554341196118, 6467.0, 6507.511936604774, 6526.738930442777, 6552.705128269239, 4529.343245229424, 4540.72755634663, 4543.341215523797, 4543.545645435496, 4547.249703798836, 4580.496145424001, 4585.037142200175, 4593.586577208067, 4595.4025976622825, 4598.103369842848, 5242.370915490165, 5288.0745869472685, 5290.444503327172, 5296.841094767163, 5300.92048619271, 6175.96912015437, 6299.716512756937, 6307.400796924285, 6314.179156709598, 6325.082862984841, 1594.3383495849325, 1623.1965177237344, 1623.2127418202163, 1623.9756403653955, 1624.5045261195448, 1070.4380200394698, 1074.8656417947757, 1092.1754075672816, 1093.4532733633184, 1095.7972775036644, 6096.9390306096375, 6097.17688112108, 6114.938850611526, 6122.234720659918, 6132.5707200495535, 6491.545591808623, 6534.0, 6541.084248205255, 6544.574602650812, 6552.57408268461, 5945.0, 6038.124471951543, 6067.393260673897, 6166.290876549165, 6174.598651087665, 3544.2557063017057, 3544.57465104184, 3560.6795388415167, 3565.625609311037, 3567.5362202913457, 6730.226024007204, 6738.157730283715, 6742.898856517156, 6744.527883048139, 6755.966220168868, 6584.934150658528, 6740.966295168493, 6745.359190876957, 6760.425363844129, 6764.222114456802, 6699.933000670028, 6734.730610775612, 6744.797656070227, 6754.075088599726, 6756.695948682321, 6578.440832529289, 6587.571807832475, 6594.70323835419, 6597.505187111082, 6599.8020059398295, 6290.119383286435, 6481.0, 6509.381608747161, 6522.902156467751, 6528.053432252392, 6730.461563074844, 6736.4274036705465, 6742.393184613408, 6746.460283177236, 6750.1562304711915, 4543.931841022453, 4587.7017993830295, 4588.449386073693, 4589.2657174851865, 4591.0, 6362.745490180526, 6570.8357291068105, 6601.966990165019, 6606.372394622503, 6622.403983641303, 6426.0, 6432.581882177644, 6436.645984470899, 6439.903401448888, 6442.194725659293, 6367.745290188341, 6401.071844582602, 6409.8718025640155, 6413.647249401328, 6421.93578064232, 6155.907661384993, 6287.056941458635, 6287.339829317856, 6287.402696743802, 6292.968535157295, 6411.262704788823, 6420.775272865428, 6422.0, 6423.0, 6432.871342573216, 6217.720202590804, 6255.499560035278, 6266.436020758154, 6270.561060725706, 6278.372162783685], "unit": "score", "name": "prototype.html", "value": 4793.389014177213}, {"lowerIsBetter": false, "replicates": [837.3803385494734, 848.7750746052297, 860.6772460327377, 873.9300855931526, 877.6840337478507, 15691.450799222015, 16173.75739363909, 16190.352385904549, 16190.514284571482, 16199.676006479878, 14682.632934176625, 14684.85315146851, 14745.41018359267, 14775.630609234775, 14783.556493305192, 685.4550632247375, 698.6122701900443, 813.2680587471293, 828.4490813608943, 831.5301854452215, 811.7402431222012, 816.1675091406762, 824.5217773691245, 830.5473516933286, 831.4387788242942, 863.3007264116055, 873.3624454148476, 878.2315473960285, 878.907714689958, 879.0111124984393, 720.7837648705367, 729.0485915879775, 848.4485084694998, 870.7692461497708, 871.1245198575455, 639.1307821362942, 639.1978067525273, 639.2169592249458, 639.2967735490969, 639.66097968077, 13370.398332074983, 13485.0, 13493.865061349457, 13533.458661653522, 13551.25468099254, 11503.137264705098, 11734.47194876224, 11911.702207444796, 12114.757704845853, 12152.513899444011, 10136.949315253376, 10147.898521014842, 10153.136983356424, 10606.78786424275, 10763.62327318548, 3616.6021737608844, 3643.526341575578, 3651.8539258429632, 3672.596014438436, 3854.0, 45837.770811146394, 47104.76447617774, 47137.764311178566, 47186.0, 47200.29199562009, 9901.405915645084, 10026.398416095057, 10227.539760710786, 10410.219233557513, 10546.472676366151, 18585.721214181798, 18608.16263268156, 18623.161957711935, 18638.720419193724, 18642.627147456977, 7396.482246242711, 7534.243179869017, 7546.471746977769, 7570.545767253982, 7589.1272503662785, 4247.97876010618, 4256.0, 4284.8500302489265, 4288.699791014599, 4307.504636966726, 2963.3184367595572, 2970.7920445569034, 2994.041906589914, 3002.834844083596, 3003.339265361617, 552.5358698693117, 558.0847410247197, 565.3216140631259, 566.1507738392411, 571.3543695623919, 575.8502789274735, 617.4257940115735, 638.32656547343, 642.2581917884851, 643.7264162730821, 8255.834883302421, 8256.711015114442, 8520.19058189471, 8582.785430364165, 8668.436551624125, 488.9535494128052, 504.8990201959623, 609.5502829345759, 618.5793660310942, 678.5521555773166, 3865.768053916774, 4007.8998025049023, 4132.8140233689555, 4169.478815148106, 4207.558206388347, 52445.0, 56982.0, 57429.42570574324, 57526.13710794342, 57987.71006144942, 48691.51308486941, 49225.753871230416, 49492.25761613579, 49978.250326245136, 53143.73428132912, 44238.557614424084, 44451.55548444474, 44896.77551612221, 46219.53780462153, 46250.0, 8496.660133594587, 8754.12458754145, 8838.646454141763, 9003.324750643858, 9105.362624616213, 32923.91146897353, 33172.0, 33942.3211535763, 34105.48841767326, 34155.14612134716, 49187.262191066446, 49228.50771492383, 49304.0, 50439.0, 54340.0, 11606.651800446, 11662.766744665229, 11703.356315402734, 11730.589429369931, 12005.219660722025, 12239.388030598257, 12368.44342004594, 12398.0, 13033.413496392495, 13062.150960187557, 11562.595309164139, 11585.710357241136, 11650.126240532163, 11900.702482438008, 11953.820692689442, 11523.0, 11653.59212427561, 11814.704632384259, 12045.09661775388, 12319.0, 11224.66326010221, 11519.30884146954, 11536.172660728796, 11635.360055196707, 11855.110866685205, 10063.798724025624, 10093.646722364681, 10132.544035518273, 10177.236707247133, 10227.0, 9628.277879159232, 9948.452835093849, 10005.54975026111, 10015.349002314826, 10027.649032284127], "unit": "score", "name": "yui.html", "value": 6391.521283293919}], "name": "dromaeo_css", "value": 7000.342160221209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 112.0, 111.0, 110.0, 99.0, 110.0, 111.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 143.0, 163.0, 130.0, 152.0, 155.0, 127.0, 169.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 163.0, 160.0, 160.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 85.0, 92.0, 72.0, 72.0, 71.0, 94.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 93.0, 93.0, 94.0, 138.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 57.0, 58.0, 59.0, 57.0, 65.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 84.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 121.0, 130.0, 121.0, 115.0, 117.0, 121.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [142.0, 151.0, 152.0, 151.0, 139.0, 141.0, 149.0, 149.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 67.0, 68.0, 67.0, 70.0, 66.0, 67.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1496.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [188.6080724254998], "unit": "score", "name": "DeltaBlue", "value": 350.5576359999999}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [24926.829268292684], "unit": "score", "name": "RegExp", "value": 36.54636497064577}, {"lowerIsBetter": false, "replicates": [677.9661016949152], "unit": "score", "name": "Splay", "value": 120.19922500000001}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19684.661155990132}]} 14:04:43 INFO - RETURN: dromaeo_css: 7000.34 14:04:43 INFO - RETURN: kraken: 1496.00 14:04:43 INFO - RETURN: v8_7: 19684.66 14:04:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19684.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7000.34"}}} 14:04:43 INFO - Return code: 0 14:04:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:04:43 ERROR - # TBPL SUCCESS # 14:04:43 INFO - Running post-action listener: _resource_record_post_action 14:04:43 INFO - Running post-run listener: _resource_record_post_run 14:04:45 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 45056; Write bytes: 552620032; Read time: 332; Write time: 490552 14:04:45 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 40960; Write bytes: 242429952; Read time: 312; Write time: 327468 14:04:45 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310190080; Read time: 20; Write time: 163084 14:04:45 INFO - Running post-run listener: _upload_blobber_files 14:04:45 INFO - Blob upload gear active. 14:04:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:04:45 INFO - Copying logs to upload dir... 14:04:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.856100 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-18 14:04:45.063293) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:45.066617) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009166 build_url: 'https://queue.taskcluster.net/v1/task/6zcgEkr0SyWs6dATVthJcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:45.118194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:45.118646) ========= 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=d6a7e047ef025f707024e163000001c3-1450473417.168971-1567824394 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:45.169142) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 14:04:45.169490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 14:04:45.169817) ========= ========= Total master_lag: 0.24 =========