builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1457432639.1 results: success (0) buildid: 20160307110832 builduid: b0fbdd96eb50429c953c1789946b3361 revision: a06ac8e3220a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.101947) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.102445) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.102738) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006288 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.125145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.125452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.138435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.138782) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.187898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.188192) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.188551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.188819) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 02:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-03-08 02:23:59 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.300738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.301046) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.350127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.350482) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 02:23:59,570 Setting DEBUG logging. 2016-03-08 02:23:59,570 attempt 1/10 2016-03-08 02:23:59,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a06ac8e3220a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 02:23:59,827 unpacking tar archive at: mozilla-aurora-a06ac8e3220a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544714 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.907777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.908107) ========= echo a06ac8e3220a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a06ac8e3220a'] 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a06ac8e3220a program finished with exit code 0 elapsedTime=0.003067 script_repo_revision: 'a06ac8e3220a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.955473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.955759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 02:23:59.965346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-08 02:23:59.965633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:00 INFO - MultiFileLogger online at 20160308 02:24:00 in /builds/slave/test-pgo 02:24:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:24:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:24:00 INFO - {'append_to_log': False, 02:24:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:24:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:24:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:24:00 INFO - 'branch': 'Mozilla-Aurora', 02:24:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:00 INFO - 'config_files': ('talos/linux_config.py',), 02:24:00 INFO - 'default_actions': ('clobber', 02:24:00 INFO - 'read-buildbot-config', 02:24:00 INFO - 'download-and-extract', 02:24:00 INFO - 'populate-webroot', 02:24:00 INFO - 'create-virtualenv', 02:24:00 INFO - 'install', 02:24:00 INFO - 'run-tests'), 02:24:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:00 INFO - 'download_minidump_stackwalk': True, 02:24:00 INFO - 'download_symbols': 'ondemand', 02:24:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:00 INFO - 'installer_path': 'installer.exe', 02:24:00 INFO - 'log_level': 'info', 02:24:00 INFO - 'log_name': 'talos', 02:24:00 INFO - 'log_to_console': True, 02:24:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:00 INFO - 'opt_config_files': (), 02:24:00 INFO - 'pip_index': False, 02:24:00 INFO - 'sps_profile': False, 02:24:00 INFO - 'sps_profile_interval': 0, 02:24:00 INFO - 'suite': 'dromaeojs', 02:24:00 INFO - 'system_bits': '32', 02:24:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:00 INFO - 'title': 'talos-linux64-ix-023', 02:24:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:00 INFO - 'use_talos_json': True, 02:24:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:24:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:00 INFO - 'work_dir': 'build'} 02:24:00 INFO - ##### 02:24:00 INFO - ##### Running clobber step. 02:24:00 INFO - ##### 02:24:00 INFO - Running pre-action listener: _resource_record_pre_action 02:24:00 INFO - Running main action method: clobber 02:24:00 INFO - rmtree: /builds/slave/test-pgo/build 02:24:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:24:01 INFO - Running post-action listener: _resource_record_post_action 02:24:01 INFO - ##### 02:24:01 INFO - ##### Running read-buildbot-config step. 02:24:01 INFO - ##### 02:24:01 INFO - Running pre-action listener: _resource_record_pre_action 02:24:01 INFO - Running main action method: read_buildbot_config 02:24:01 INFO - Using buildbot properties: 02:24:01 INFO - { 02:24:01 INFO - "project": "", 02:24:01 INFO - "product": "firefox", 02:24:01 INFO - "script_repo_revision": "production", 02:24:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:24:01 INFO - "repository": "", 02:24:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:24:01 INFO - "buildid": "20160307110832", 02:24:01 INFO - "pgo_build": "True", 02:24:01 INFO - "basedir": "/builds/slave/test-pgo", 02:24:01 INFO - "buildnumber": 100, 02:24:01 INFO - "slavename": "talos-linux64-ix-023", 02:24:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:24:01 INFO - "platform": "ubuntu64_hw", 02:24:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:24:01 INFO - "branch": "mozilla-aurora", 02:24:01 INFO - "repo_path": "releases/mozilla-aurora", 02:24:01 INFO - "revision": "a06ac8e3220a", 02:24:01 INFO - "stage_platform": "linux64-pgo", 02:24:01 INFO - "builduid": "b0fbdd96eb50429c953c1789946b3361", 02:24:01 INFO - "slavebuilddir": "test" 02:24:01 INFO - } 02:24:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 02:24:01 INFO - Running post-action listener: _resource_record_post_action 02:24:01 INFO - ##### 02:24:01 INFO - ##### Running download-and-extract step. 02:24:01 INFO - ##### 02:24:01 INFO - Running pre-action listener: _resource_record_pre_action 02:24:01 INFO - Running main action method: download_and_extract 02:24:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:24:01 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')]} 02:24:01 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:02 INFO - Downloaded 1448 bytes. 02:24:02 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:02 INFO - Using the following test package requirements: 02:24:02 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'jsshell-linux-x86_64.zip'], 02:24:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:02 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:02 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:06 INFO - Downloaded 23397998 bytes. 02:24:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:24:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:24:07 INFO - Return code: 0 02:24:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:07 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')]} 02:24:07 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:08 INFO - Downloaded 23397998 bytes. 02:24:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:24:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:24:10 INFO - Return code: 0 02:24: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')]} 02:24:10 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:24:11 INFO - Downloaded 10803659 bytes. 02:24:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:24:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:24:11 INFO - Return code: 0 02:24:11 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')]} 02:24:11 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:24:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:24:13 INFO - Downloaded 56123602 bytes. 02:24:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:13 INFO - mkdir: /builds/slave/test-pgo/properties 02:24:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:24:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:24:13 INFO - Contents: 02:24:13 INFO - build_url:https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:13 INFO - Running post-action listener: _resource_record_post_action 02:24:13 INFO - Running post-action listener: set_extra_try_arguments 02:24:13 INFO - ##### 02:24:13 INFO - ##### Running populate-webroot step. 02:24:13 INFO - ##### 02:24:13 INFO - Running pre-action listener: _resource_record_pre_action 02:24:13 INFO - Running main action method: populate_webroot 02:24:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:13 INFO - '--tppagecycles', 02:24:13 INFO - '7'], 02:24:13 INFO - 'tests': ['tsvgm']}}, 02:24:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:24:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:24:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'tests': ['damp', 'tps']}, 02:24:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['damp', 'tps']}, 02:24:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:24:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:13 INFO - 'other': {'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'other_l64': {'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'other_nol64': {'tests': ['a11yr', 02:24:13 INFO - 'ts_paint', 02:24:13 INFO - 'tpaint', 02:24:13 INFO - 'sessionrestore', 02:24:13 INFO - 'sessionrestore_no_auto_restore']}, 02:24:13 INFO - 'svgr': {'tests': ['tsvgx', 02:24:13 INFO - 'tsvgr_opacity', 02:24:13 INFO - 'tart', 02:24:13 INFO - 'tscrollx', 02:24:13 INFO - 'cart']}, 02:24:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['tsvgx', 02:24:13 INFO - 'tsvgr_opacity', 02:24:13 INFO - 'tart', 02:24:13 INFO - 'tscrollx', 02:24:13 INFO - 'cart']}, 02:24:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'tests': ['tp5o']}, 02:24:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'talos_options': ['--e10s'], 02:24:13 INFO - 'tests': ['tp5o']}, 02:24:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'talos_options': ['--xperf_path', 02:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:13 INFO - 'tests': ['tp5n']}, 02:24:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:13 INFO - 'talos_options': ['--e10s', 02:24:13 INFO - '--xperf_path', 02:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:13 INFO - 'tests': ['tp5n']}}, 02:24:13 INFO - 'talos.zip': {'path': '', 02:24:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:13 INFO - Running post-action listener: _resource_record_post_action 02:24:13 INFO - ##### 02:24:13 INFO - ##### Running create-virtualenv step. 02:24:13 INFO - ##### 02:24:13 INFO - Running pre-action listener: _resource_record_pre_action 02:24:13 INFO - Running main action method: create_virtualenv 02:24:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:24:13 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 02:24:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:24:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:13 INFO - Using real prefix '/usr' 02:24:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:24:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:16 INFO - Installing pip.................done. 02:24:16 INFO - Return code: 0 02:24:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:24:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:16 INFO - Using env: {'DISPLAY': ':0', 02:24:16 INFO - 'HOME': '/home/cltbld', 02:24:16 INFO - 'LANG': 'en_US.UTF-8', 02:24:16 INFO - 'LANGUAGE': 'en_US:en', 02:24:16 INFO - 'LOGNAME': 'cltbld', 02:24:16 INFO - 'MAIL': '/var/mail/cltbld', 02:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:16 INFO - 'MOZ_NO_REMOTE': '1', 02:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:16 INFO - 'NO_EM_RESTART': '1', 02:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:16 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:16 INFO - 'SHELL': '/bin/bash', 02:24:16 INFO - 'SHLVL': '1', 02:24:16 INFO - 'TERM': 'linux', 02:24:16 INFO - 'TMOUT': '86400', 02:24:16 INFO - 'USER': 'cltbld', 02:24:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:16 INFO - '_': '/tools/buildbot/bin/python'} 02:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:16 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 02:24:16 INFO - Cleaning up... 02:24:16 INFO - Return code: 0 02:24:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:24:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:24:16 INFO - Using env: {'DISPLAY': ':0', 02:24:16 INFO - 'HOME': '/home/cltbld', 02:24:16 INFO - 'LANG': 'en_US.UTF-8', 02:24:16 INFO - 'LANGUAGE': 'en_US:en', 02:24:16 INFO - 'LOGNAME': 'cltbld', 02:24:16 INFO - 'MAIL': '/var/mail/cltbld', 02:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:16 INFO - 'MOZ_NO_REMOTE': '1', 02:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:16 INFO - 'NO_EM_RESTART': '1', 02:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:16 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:16 INFO - 'SHELL': '/bin/bash', 02:24:16 INFO - 'SHLVL': '1', 02:24:16 INFO - 'TERM': 'linux', 02:24:16 INFO - 'TMOUT': '86400', 02:24:16 INFO - 'USER': 'cltbld', 02:24:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:16 INFO - '_': '/tools/buildbot/bin/python'} 02:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:16 INFO - Downloading/unpacking psutil>=0.7.1 02:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:18 INFO - Installing collected packages: psutil 02:24:18 INFO - Running setup.py install for psutil 02:24:18 INFO - building 'psutil._psutil_linux' extension 02:24:18 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 02:24:18 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 02:24:19 INFO - building 'psutil._psutil_posix' extension 02:24:19 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 02:24:19 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 02:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:19 INFO - Successfully installed psutil 02:24:19 INFO - Cleaning up... 02:24:19 INFO - Return code: 0 02:24:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 02:24:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:24:19 INFO - Using env: {'DISPLAY': ':0', 02:24:19 INFO - 'HOME': '/home/cltbld', 02:24:19 INFO - 'LANG': 'en_US.UTF-8', 02:24:19 INFO - 'LANGUAGE': 'en_US:en', 02:24:19 INFO - 'LOGNAME': 'cltbld', 02:24:19 INFO - 'MAIL': '/var/mail/cltbld', 02:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:19 INFO - 'MOZ_NO_REMOTE': '1', 02:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:19 INFO - 'NO_EM_RESTART': '1', 02:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:19 INFO - 'SHELL': '/bin/bash', 02:24:19 INFO - 'SHLVL': '1', 02:24:19 INFO - 'TERM': 'linux', 02:24:19 INFO - 'TMOUT': '86400', 02:24:19 INFO - 'USER': 'cltbld', 02:24:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:19 INFO - '_': '/tools/buildbot/bin/python'} 02:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:24:19 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 02:24:19 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 02:24:19 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 02:24:19 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 02:24:19 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 02:24:19 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 02:24:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:24:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:24:21 INFO - Installing collected packages: mozsystemmonitor 02:24:21 INFO - Running setup.py install for mozsystemmonitor 02:24:21 INFO - Successfully installed mozsystemmonitor 02:24:21 INFO - Cleaning up... 02:24:21 INFO - Return code: 0 02:24:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 02:24:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:24:21 INFO - Using env: {'DISPLAY': ':0', 02:24:21 INFO - 'HOME': '/home/cltbld', 02:24:21 INFO - 'LANG': 'en_US.UTF-8', 02:24:21 INFO - 'LANGUAGE': 'en_US:en', 02:24:21 INFO - 'LOGNAME': 'cltbld', 02:24:21 INFO - 'MAIL': '/var/mail/cltbld', 02:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:21 INFO - 'MOZ_NO_REMOTE': '1', 02:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:21 INFO - 'NO_EM_RESTART': '1', 02:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:21 INFO - 'SHELL': '/bin/bash', 02:24:21 INFO - 'SHLVL': '1', 02:24:21 INFO - 'TERM': 'linux', 02:24:21 INFO - 'TMOUT': '86400', 02:24:21 INFO - 'USER': 'cltbld', 02:24:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:21 INFO - '_': '/tools/buildbot/bin/python'} 02:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:21 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 02:24:21 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 02:24:21 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 02:24:21 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 02:24:21 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 02:24:21 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 02:24:23 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:23 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 02:24:23 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 02:24:23 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 02:24:23 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 02:24:23 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 02:24:23 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 02:24:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:24:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 INFO - Downloading docopt-0.6.1.tar.gz 02:24:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:24 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:24 INFO - Running setup.py install for blobuploader 02:24:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:24:24 INFO - Running setup.py install for requests 02:24:24 INFO - Running setup.py install for docopt 02:24:25 INFO - Successfully installed blobuploader requests docopt 02:24:25 INFO - Cleaning up... 02:24:25 INFO - Return code: 0 02:24:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24:25 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')]} 02:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:25 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')]} 02:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 02:24:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:25 INFO - Using env: {'DISPLAY': ':0', 02:24:25 INFO - 'HOME': '/home/cltbld', 02:24:25 INFO - 'LANG': 'en_US.UTF-8', 02:24:25 INFO - 'LANGUAGE': 'en_US:en', 02:24:25 INFO - 'LOGNAME': 'cltbld', 02:24:25 INFO - 'MAIL': '/var/mail/cltbld', 02:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:25 INFO - 'MOZ_NO_REMOTE': '1', 02:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:25 INFO - 'NO_EM_RESTART': '1', 02:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:25 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:25 INFO - 'SHELL': '/bin/bash', 02:24:25 INFO - 'SHLVL': '1', 02:24:25 INFO - 'TERM': 'linux', 02:24:25 INFO - 'TMOUT': '86400', 02:24:25 INFO - 'USER': 'cltbld', 02:24:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:25 INFO - '_': '/tools/buildbot/bin/python'} 02:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:25 INFO - Running setup.py (path:/tmp/pip-j8YapP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:25 INFO - Running setup.py (path:/tmp/pip-_MlBwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:25 INFO - Running setup.py (path:/tmp/pip-j2pRy_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:25 INFO - Running setup.py (path:/tmp/pip-s76fW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:25 INFO - Running setup.py (path:/tmp/pip-KXAJxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:25 INFO - Running setup.py (path:/tmp/pip-Px4R53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:25 INFO - Running setup.py (path:/tmp/pip-9uDvQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:25 INFO - Running setup.py (path:/tmp/pip-I3VjU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:25 INFO - Running setup.py (path:/tmp/pip-4V5utI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:26 INFO - Running setup.py (path:/tmp/pip-7q6MGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:26 INFO - Running setup.py (path:/tmp/pip-mYipot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:26 INFO - Running setup.py (path:/tmp/pip-cMoWs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:26 INFO - Running setup.py (path:/tmp/pip-wpGwmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:26 INFO - Running setup.py (path:/tmp/pip-VupEtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:26 INFO - Running setup.py (path:/tmp/pip-0LB_sy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:26 INFO - Running setup.py (path:/tmp/pip-z4DmCe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:26 INFO - Running setup.py (path:/tmp/pip-lLm0kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:26 INFO - Running setup.py install for manifestparser 02:24:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:24:26 INFO - Running setup.py install for mozcrash 02:24:26 INFO - Running setup.py install for mozdebug 02:24:26 INFO - Running setup.py install for mozdevice 02:24:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:24:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozfile 02:24:27 INFO - Running setup.py install for mozhttpd 02:24:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozinfo 02:24:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozInstall 02:24:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozleak 02:24:27 INFO - Running setup.py install for mozlog 02:24:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for moznetwork 02:24:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozprocess 02:24:27 INFO - Running setup.py install for mozprofile 02:24:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:24:27 INFO - Running setup.py install for mozrunner 02:24:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:24:28 INFO - Running setup.py install for mozscreenshot 02:24:28 INFO - Running setup.py install for moztest 02:24:28 INFO - Running setup.py install for mozversion 02:24:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:24:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:28 INFO - Cleaning up... 02:24:28 INFO - Return code: 0 02:24:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24:28 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')]} 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 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')]} 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 02:24:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:28 INFO - Using env: {'DISPLAY': ':0', 02:24:28 INFO - 'HOME': '/home/cltbld', 02:24:28 INFO - 'LANG': 'en_US.UTF-8', 02:24:28 INFO - 'LANGUAGE': 'en_US:en', 02:24:28 INFO - 'LOGNAME': 'cltbld', 02:24:28 INFO - 'MAIL': '/var/mail/cltbld', 02:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:28 INFO - 'MOZ_NO_REMOTE': '1', 02:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:28 INFO - 'NO_EM_RESTART': '1', 02:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:28 INFO - 'SHELL': '/bin/bash', 02:24:28 INFO - 'SHLVL': '1', 02:24:28 INFO - 'TERM': 'linux', 02:24:28 INFO - 'TMOUT': '86400', 02:24:28 INFO - 'USER': 'cltbld', 02:24:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:28 INFO - '_': '/tools/buildbot/bin/python'} 02:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:28 INFO - Running setup.py (path:/tmp/pip-UJMdvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:28 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)) 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:28 INFO - Running setup.py (path:/tmp/pip-73Gydr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:28 INFO - Running setup.py (path:/tmp/pip-8AgLxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:28 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)) 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:28 INFO - Running setup.py (path:/tmp/pip-bSi3rf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:28 INFO - Running setup.py (path:/tmp/pip-9A62K7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:28 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)) 02:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:28 INFO - Running setup.py (path:/tmp/pip-WeC5KC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:29 INFO - Running setup.py (path:/tmp/pip-vEt38E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:29 INFO - Running setup.py (path:/tmp/pip-zqycre-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:29 INFO - Running setup.py (path:/tmp/pip-0rztF3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:29 INFO - Running setup.py (path:/tmp/pip-lwk3YA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:29 INFO - Running setup.py (path:/tmp/pip-d10aoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:29 INFO - Running setup.py (path:/tmp/pip-0WSls1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:29 INFO - Running setup.py (path:/tmp/pip-RwX_eN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:29 INFO - Running setup.py (path:/tmp/pip-PT03sh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:29 INFO - Running setup.py (path:/tmp/pip-SSz00y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:29 INFO - Running setup.py (path:/tmp/pip-7QJz7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:29 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)) 02:24:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:29 INFO - Running setup.py (path:/tmp/pip-hoXbKW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:29 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)) 02:24:29 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:29 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:29 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)) 02:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:31 INFO - Downloading blessings-1.6.tar.gz 02:24:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:31 INFO - Installing collected packages: blessings 02:24:31 INFO - Running setup.py install for blessings 02:24:31 INFO - Successfully installed blessings 02:24:31 INFO - Cleaning up... 02:24:31 INFO - Return code: 0 02:24:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:24:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:24:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:24:32 INFO - Reading from file tmpfile_stdout 02:24:32 INFO - Current package versions: 02:24:32 INFO - argparse == 1.2.1 02:24:32 INFO - blessings == 1.6 02:24:32 INFO - blobuploader == 1.2.4 02:24:32 INFO - docopt == 0.6.1 02:24:32 INFO - manifestparser == 1.1 02:24:32 INFO - mozInstall == 1.12 02:24:32 INFO - mozcrash == 0.17 02:24:32 INFO - mozdebug == 0.1 02:24:32 INFO - mozdevice == 0.48 02:24:32 INFO - mozfile == 1.2 02:24:32 INFO - mozhttpd == 0.7 02:24:32 INFO - mozinfo == 0.9 02:24:32 INFO - mozleak == 0.1 02:24:32 INFO - mozlog == 3.1 02:24:32 INFO - moznetwork == 0.27 02:24:32 INFO - mozprocess == 0.22 02:24:32 INFO - mozprofile == 0.28 02:24:32 INFO - mozrunner == 6.11 02:24:32 INFO - mozscreenshot == 0.1 02:24:32 INFO - mozsystemmonitor == 0.0 02:24:32 INFO - moztest == 0.7 02:24:32 INFO - mozversion == 1.4 02:24:32 INFO - psutil == 3.1.1 02:24:32 INFO - requests == 1.2.3 02:24:32 INFO - wsgiref == 0.1.2 02:24:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 02:24:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:32 INFO - Using env: {'DISPLAY': ':0', 02:24:32 INFO - 'HOME': '/home/cltbld', 02:24:32 INFO - 'LANG': 'en_US.UTF-8', 02:24:32 INFO - 'LANGUAGE': 'en_US:en', 02:24:32 INFO - 'LOGNAME': 'cltbld', 02:24:32 INFO - 'MAIL': '/var/mail/cltbld', 02:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:32 INFO - 'MOZ_NO_REMOTE': '1', 02:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:32 INFO - 'NO_EM_RESTART': '1', 02:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:32 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:32 INFO - 'SHELL': '/bin/bash', 02:24:32 INFO - 'SHLVL': '1', 02:24:32 INFO - 'TERM': 'linux', 02:24:32 INFO - 'TMOUT': '86400', 02:24:32 INFO - 'USER': 'cltbld', 02:24:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:32 INFO - '_': '/tools/buildbot/bin/python'} 02:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 02:24:32 INFO - Cleaning up... 02:24:32 INFO - Return code: 0 02:24:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 02:24:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:24:32 INFO - Using env: {'DISPLAY': ':0', 02:24:32 INFO - 'HOME': '/home/cltbld', 02:24:32 INFO - 'LANG': 'en_US.UTF-8', 02:24:32 INFO - 'LANGUAGE': 'en_US:en', 02:24:32 INFO - 'LOGNAME': 'cltbld', 02:24:32 INFO - 'MAIL': '/var/mail/cltbld', 02:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:32 INFO - 'MOZ_NO_REMOTE': '1', 02:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:32 INFO - 'NO_EM_RESTART': '1', 02:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:32 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:32 INFO - 'SHELL': '/bin/bash', 02:24:32 INFO - 'SHLVL': '1', 02:24:32 INFO - 'TERM': 'linux', 02:24:32 INFO - 'TMOUT': '86400', 02:24:32 INFO - 'USER': 'cltbld', 02:24:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:32 INFO - '_': '/tools/buildbot/bin/python'} 02:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:32 INFO - Downloading/unpacking jsonschema 02:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:34 INFO - Downloading/unpacking functools32 (from jsonschema) 02:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:34 INFO - warning: no files found matching '*.txt' 02:24:34 INFO - no previously-included directories found matching 'build' 02:24:34 INFO - no previously-included directories found matching 'dist' 02:24:34 INFO - no previously-included directories found matching '.git*' 02:24:34 INFO - Installing collected packages: jsonschema, functools32 02:24:34 INFO - Running setup.py install for functools32 02:24:34 INFO - warning: no files found matching '*.txt' 02:24:34 INFO - no previously-included directories found matching 'build' 02:24:34 INFO - no previously-included directories found matching 'dist' 02:24:34 INFO - no previously-included directories found matching '.git*' 02:24:34 INFO - Successfully installed jsonschema functools32 02:24:34 INFO - Cleaning up... 02:24:34 INFO - Return code: 0 02:24:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed6a407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, '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': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', '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 02:24:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:24:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:24:34 INFO - Using env: {'DISPLAY': ':0', 02:24:34 INFO - 'HOME': '/home/cltbld', 02:24:34 INFO - 'LANG': 'en_US.UTF-8', 02:24:34 INFO - 'LANGUAGE': 'en_US:en', 02:24:34 INFO - 'LOGNAME': 'cltbld', 02:24:34 INFO - 'MAIL': '/var/mail/cltbld', 02:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:34 INFO - 'MOZ_NO_REMOTE': '1', 02:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:34 INFO - 'NO_EM_RESTART': '1', 02:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:34 INFO - 'SHELL': '/bin/bash', 02:24:34 INFO - 'SHLVL': '1', 02:24:34 INFO - 'TERM': 'linux', 02:24:34 INFO - 'TMOUT': '86400', 02:24:34 INFO - 'USER': 'cltbld', 02:24:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:34 INFO - '_': '/tools/buildbot/bin/python'} 02:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:35 INFO - Downloading/unpacking flake8 02:24:35 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 02:24:35 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 02:24:35 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 02:24:35 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 02:24:35 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 02:24:35 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 02:24:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:37 INFO - no previously-included directories found matching 'docs/_build' 02:24:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:37 INFO - Running setup.py install for pep8 02:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:37 INFO - no previously-included directories found matching 'docs/_build' 02:24:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:24:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:37 INFO - Cleaning up... 02:24:37 INFO - Return code: 0 02:24:37 INFO - Running post-action listener: _resource_record_post_action 02:24:37 INFO - Running post-action listener: _start_resource_monitoring 02:24:37 INFO - Starting resource monitoring. 02:24:37 INFO - ##### 02:24:37 INFO - ##### Running install step. 02:24:37 INFO - ##### 02:24:37 INFO - Running pre-action listener: _resource_record_pre_action 02:24:37 INFO - Running main action method: install 02:24:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:24:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:24:38 INFO - Reading from file tmpfile_stdout 02:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:24:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:24:38 INFO - Reading from file tmpfile_stdout 02:24:38 INFO - Output received: 02:24:38 INFO - Usage: mozinstall [options] installer 02:24:38 INFO - Options: 02:24:38 INFO - -h, --help show this help message and exit 02:24:38 INFO - -d DEST, --destination=DEST 02:24:38 INFO - Directory to install application into. [default: 02:24:38 INFO - "/builds/slave/test-pgo"] 02:24:38 INFO - --app=APP Application being installed. [default: firefox] 02:24:38 INFO - mkdir: /builds/slave/test-pgo/build/application 02:24:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:24:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:24:54 INFO - Reading from file tmpfile_stdout 02:24:54 INFO - Output received: 02:24:54 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:24:54 INFO - Running post-action listener: _resource_record_post_action 02:24:54 INFO - ##### 02:24:54 INFO - ##### Running run-tests step. 02:24:54 INFO - ##### 02:24:54 INFO - Running pre-action listener: _resource_record_pre_action 02:24:54 INFO - Running main action method: run_tests 02:24:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:24:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:24:54 INFO - Python 2.7.3 02:24:54 INFO - Return code: 0 02:24:54 INFO - grabbing minidump binary from tooltool 02:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:54 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 0x1b83920>, '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 0x1b84820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b84cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:24:54 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 02:24:54 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 02:24:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:54 INFO - Return code: 0 02:24:54 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:24:54 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:24:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:24:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:24:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:24:55 INFO - Return code: 0 02:24:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:24:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:24:55 INFO - Using env: {'DISPLAY': ':0', 02:24:55 INFO - 'HOME': '/home/cltbld', 02:24:55 INFO - 'LANG': 'en_US.UTF-8', 02:24:55 INFO - 'LANGUAGE': 'en_US:en', 02:24:55 INFO - 'LOGNAME': 'cltbld', 02:24:55 INFO - 'MAIL': '/var/mail/cltbld', 02:24:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:55 INFO - 'MOZ_NO_REMOTE': '1', 02:24:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:55 INFO - 'NO_EM_RESTART': '1', 02:24:55 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:55 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:55 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:24:55 INFO - 'SHELL': '/bin/bash', 02:24:55 INFO - 'SHLVL': '1', 02:24:55 INFO - 'TERM': 'linux', 02:24:55 INFO - 'TMOUT': '86400', 02:24:55 INFO - 'USER': 'cltbld', 02:24:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524', 02:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:55 INFO - '_': '/tools/buildbot/bin/python'} 02:24:55 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:24:55 INFO - mozversion application_buildid: 20160307110832 02:24:55 INFO - mozversion application_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 02:24:55 INFO - mozversion application_display_name: Nightly 02:24:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:55 INFO - mozversion application_name: Firefox 02:24:55 INFO - mozversion application_remotingname: firefox 02:24:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:55 INFO - mozversion application_vendor: Mozilla 02:24:55 INFO - mozversion application_version: 47.0a1 02:24:55 INFO - mozversion platform_buildid: 20160307110832 02:24:55 INFO - mozversion platform_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 02:24:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:55 INFO - mozversion platform_version: 47.0a1 02:24:55 INFO - using testdate: 1457432695 02:24:55 INFO - actual date: 1457432695 02:24:55 INFO - starting webserver on 'localhost:40125' 02:24:55 INFO - SUITE-START | Running 2 tests 02:24:55 INFO - TEST-START | dromaeo_css 02:24:55 INFO - operating with platform_type : linux_ 02:24:55 INFO - Initialising browser for dromaeo_css test... 02:24:55 INFO - TEST-INFO | started process 537 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXuqPCL/profile http://localhost:40125/getInfo.html) 02:24:59 INFO - PROCESS | 537 | __metrics Screen width/height:1600/1200 02:24:59 INFO - PROCESS | 537 | colorDepth:24 02:24:59 INFO - PROCESS | 537 | Browser inner width/height: 1024/697 02:24:59 INFO - PROCESS | 537 | __metrics 02:25:00 INFO - PROCESS | 537 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:01 INFO - TEST-INFO | 537: exit 0 02:25:01 INFO - Browser initialized. 02:25:01 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:01 INFO - TEST-INFO | started process 633 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXuqPCL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:13 INFO - PROCESS | 633 | RSS: Main: 152993792 02:25:13 INFO - PROCESS | 633 | 02:26:04 INFO - PROCESS | 633 | 1457432764603 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] 02:28:12 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40125/tests/dromaeo/cssquery-ext.html) 02:28:13 INFO - PROCESS | 633 | RSS: Main: 279351296 02:28:13 INFO - PROCESS | 633 | 02:31:16 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-ext.html (next: http://localhost:40125/tests/dromaeo/cssquery-jquery.html) 02:31:16 INFO - PROCESS | 633 | RSS: Main: 236433408 02:31:16 INFO - PROCESS | 633 | 02:34:18 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40125/tests/dromaeo/cssquery-mootools.html) 02:34:19 INFO - PROCESS | 633 | RSS: Main: 238100480 02:34:19 INFO - PROCESS | 633 | 02:37:20 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40125/tests/dromaeo/cssquery-prototype.html) 02:37:21 INFO - PROCESS | 633 | RSS: Main: 221052928 02:37:21 INFO - PROCESS | 633 | 02:40:23 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40125/tests/dromaeo/cssquery-yui.html) 02:40:24 INFO - PROCESS | 633 | RSS: Main: 220827648 02:40:24 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | Cycle 1(1): loaded http://localhost:40125/tests/dromaeo/cssquery-yui.html (next: http://localhost:40125/tests/dromaeo/cssquery-dojo.html) 02:43:27 INFO - PROCESS | 633 | RSS: Main: 289120256 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | __start_tp_report 02:43:27 INFO - PROCESS | 633 | _x_x_mozilla_page_load 02:43:27 INFO - PROCESS | 633 | _x_x_mozilla_page_load_details 02:43:27 INFO - PROCESS | 633 | |i|pagename|runs| 02:43:27 INFO - PROCESS | 633 | |0;dojo.html;3121.719045285924;3121.9687803121974;3129.624445066592;3136.592243008409;3154.9211269718253;5074.797008119675;5095.082885080684;5095.872603184922;5106.795728170873;5167.431582525919;5207.3490813648295;5212.817551385693;5228;5229.712365819878;5236.240745091959;4587.42657167854;4751.9287210691955;4805.495422980589;4880.560749532541;4898.7060776353355;4659.301104834285;4688.906221875561;4827.51724827518;4883.267509873512;4885.755712214375;4744.383230180089;4754.619630429592;4763.118823017753;4780.16347139251;4799.712017278939;4703.976480117578;4740.170470167707;4741.146593613148;4765.594924431392;4783.282507623884;4665.183592871234;4726.71639701619;4755.453122890843;4769.356136921506;4786.234202527614;5048.772805223737;5051.823186188502;5059.089363914494;5067.417247016567;5077.923831142536;5433.320834895638;5536.446355364472;5547.916781248285;5548.9722551386985;5562.9443705562835;5670.659760414388;5672.886542269172;5676.1769543416385;5679.318481782213;5680.971595142039;5286.656367336111;5292.100342941709;5292.973535132338;5293.814716484904;5298.36419629643;5512;5547.55619550435;5585.497305242467;5593.0491816390495;5664.461876121762;5280.735963201824;5337.973310133502;5340.385855626652;5356.946430535722;5387.730613469311;5394.568434525228;5400.486953739389;5436.320459942507;5449.5640348772795;5471.2887324647545;5550.611457197957;5608.943910560843;5612.326520817528;5631.577631677558;5632.718364081779;5559.944400555943;5561.833145005576;5562.276904002454;5568.49883510486;5571.916421253684;4207.810648520824;4224.640905523003;4259.531451540328;4268.018355778188;4297.419848320499;3833.1375440525658;3835;3855.5373355197557;3860.3051450738576;3882.6117388261514;5230.189320655304;5243.606729495303;5256.2115682647145;5256.2904007959205;5294.629375943647;5326.201069839555;5547.278853749068;5557.305336832896;5592.105263157875;5654.4062873398525;5192.1173400522;5221.086309895753;5238.869028274247;5242.239875218148;5268.078086334876;4688.390509233846;4692.131955588227;4696.7416792076765;4698.083873644607;4739.146953548395;5687.658740475502;5805.448482394166;5839.211706419664;5903.940960590339;5906.970465147732;5568.359638641608;5583.0787919992745;5586.832395028156;5590.972045139748;5598;5865.618734782225;5866.178734977192;5886.028805247086;5890.705464726832;5899.941000589939;5425.294711687456;5490.533304669148;5520.309961254843;5548;5582.665040097607;5610.943890561205;5613.775448981995;5615.213870058114;5632.098864181711;5634;5315.734213289397;5417.864553386197;5483.616146869681;5486.670799752028;5534.05920993424;5391.16436952273;5425.782968681208;5431.538319242909;5450.5367043801725;5489.478499542537;5264.131418315935;5309.33633295838;5333.7333133343955;5339.439358867263;5377.677339359651;5385.057614917452;5387.649802762808;5436.864078398072;5439.211314359317;5454.618176727591;5221.712805795718;5326.041312563776;5359.651622644516;5407.540359069523;5456.045192091288 02:43:27 INFO - PROCESS | 633 | |1;ext.html;521.6531006880423;526.7708546782148;546.8052305712017;549.2146230889829;604.6432604763189;30780.846095769517;31314.843425782867;36544.269114617724;36995.445068324;37148.44277335835;40130;40586.39120413196;40601.390979135336;40639;40677.38983915236;8573.699920502799;8789.033206347296;8789.560521973908;8793.604287807031;8795.076516965722;8586.527740974245;8693.913060869405;8711.520866352348;8717.956410217972;8720.738377848675;8916.910830891673;8987.505687187235;9003.819923601524;9013.098690131;9013.188813006827;8885.555722213863;8967.148120928501;8978.416402933854;8978.775530611721;8981.730548083568;8750.693725719633;8889.377743557954;8901;8909.688160914402;8909.910900890973;39291.21417571661;39744.20511589752;39825;39832.40251396231;39847.8007609963;3261.771675982682;3383.593968723744;3458.844352004166;3835.252125835463;4113.568075352105;29269.853650731824;29667.70332296671;30254;30507.69492305071;30530.84734576313;3892.124272038797;3918.74528155669;3956.8021598920227;3980.44273801668;4018.1561872006914;263648;299568;305287;305293;305343;59752;61559.38440615626;61655.38344616586;61823.38176618176;61854;64719;64816;65398.34601654018;65570.67214663896;65613;15873.12697801632;16060.43788467398;16062.518124456285;16065.518034458984;16073.758893616605;12314.199577027464;12350.135490515577;12357.38213089342;12364.752704945851;12366.319852408024;20590.485237869172;20850.374488765363;20851.687224691643;20891.059902304434;20900.790992090188;7648.273414025659;8420.747377578682;8438.831223375499;8464.788380290542;8465.280451161598;964.62379671928;965.8792650918635;1020.2756043209405;1027.465717826726;1029.7013865978931;27746.027946500573;28220;28838.27904302367;28902.855485722437;29006.274843128667;1051.2746205118444;1083.7453198498347;1100.3397961223202;1111.5331560744507;1133.9850833503967;14337.78493322601;14863.925680371529;14869.647251436276;15126;15161.620959476102;303753;305100;305180;307216;307339;51853.74073129686;52253.73873130686;52307.47692523026;52386;52390.47609523856;1128.2722643894806;1245.6574442028334;1361.5030513862368;1367.2548461088732;1384.1625816381145;27951.860240698665;29014;30760.692393075784;31335.529967050057;31404.52893206558;44682.3297650529;45144;45264.54735452603;45326;45352.09295813999;263021;270601;270725;271769;272703;31199.532007020367;32589.34821303608;32598.51102233516;32606;32676.183095421853;42177.36733948932;43363;43427.874351936516;44080;44533.33200001938;36328.45507317445;36527.45208821817;36772.44841327329;36912.44631330586;36945.44581831328;36050;36232;36286.63713362938;36331.45502817513;36528;35278.82360588181;35605.82197089102;35970;36196.45705314475;36294;31597.8420107898;32397;32798.836005819816;32913.50629740508;33016.33967320688;25153.622695659946;25521.48957020812;25865.482690346464;27170;28595.428091438473 02:43:27 INFO - PROCESS | 633 | |2;jquery.html;324.62181558484366;345.53352973485795;353.3445458674158;357.55484421894715;359.2975732443072;17248.913755431222;17730.302563363344;17820.376286829964;18280.17739201736;18288.7994600945;16910.06994615296;17262.82737172628;17665.293388264487;17684.82315176848;17688.46934591961;4697.882552936187;5359.517643412092;5503.477169668875;5511.421300763423;5546.251256080438;5430.75561599727;5442.156465747816;5445.53712934401;5449.945500545004;5452.372977107624;5319.909418569184;5374.516293533581;5436.809711660093;5490.917636235459;5493.148561972901;5395.136778115502;5404.270423492818;5431.511163995239;5440.863978400532;5449.972750136224;4832.9275060874115;4850.514948505156;4872.366592343008;4920.286558449005;4927.95072049282;20630.277940272168;20678.17287308506;20766.273180438762;21184.470388240417;21297.68053479199;2116.43914362694;2126.25581046634;2153.1172219389973;2247.078697733921;2349.553584818896;9408.43549387039;9745.658901938468;9794.559244833928;9913.206943444507;12678.175918565265;1851.8240767127102;1909.3412772593433;1915.4923945154544;1943.2615606069744;1971.6845304751314;56700;57542.42457575454;58307.70846145785;58384.41615583875;60458.697706511186;9428.669996550088;9553.665621703207;9654;9950.80098398028;9995.050965061742;12452.377381130907;12521.373931303398;13057.673558160932;13116.278604676834;13162.341882905816;7258.927410725931;7456.701731930771;7462.179160292472;7542.245775422414;7565;7173.4935663510205;7471.252874712594;7517.624118794039;7560.9621951889885;7570.5836179010685;4516.254817955;4593;4596.448426188878;4611.8847028823875;4649.488556258809;1735.453332200378;1825.2972605546695;1833.724941258795;1850.148931491502;1890.5935223926922;781.3514782730321;890.3633901760143;946.1815529566875;1030.07808011829;1056.709404913655;16782.664346712998;16797.244124014447;16860.57848553796;17000.57498562546;17486;927.4296307770672;946.9431834089977;989.7822479054596;1007.8437842134481;1045.2578669144991;9540.95229523848;9642.42145471274;9765.414075155371;9852.211823054138;9859.35914165577;338113;344721;346385;393153.3765642917;404304;74412.62793685996;76357.61821190859;76619.2338076612;77341.61329193319;78115;914.6295750221038;997.9251556133174;1025.6358992557684;1032.948352582368;1034.7930413917247;14417.13497190172;14822.703545928805;14830.258487075818;15015.624609384417;15250.694986099994;33698.32603347969;33759.83120084384;34439.65560344364;34638.13404664904;34753.65246347504;42483;42554.361684574134;42657.14685706331;42879.78560107305;43411;7948.602569871599;7957.323627491728;7973.561454120079;8034.799130021796;8138.267555919995;12176.208546444806;12567.497300107892;12569.434375452944;12655.93672031634;12899.677508062374;9803.215742740706;11038.337699738042;11205.327680339205;11233.269837460539;11335.546578136782;11060.723481913017;11079.279846809932;11120.666380008613;11210.439478025903;11223.71940701489;6588.703508342041;7292.598907060163;10886.891131088587;11104.944475277573;11357.432128393713;7856.057273127261;8251.463654862655;8354.248117669438;8400.957995209985;8447.493150410995;9857.753556161153;10926.672199834018;11198.83201751958;11280.661580152608;11538.307701537935 02:43:27 INFO - PROCESS | 633 | |3;mootools.html;1315.3751967815283;1489.0395694776869;1505.8042454480915;1688.6960347137517;1835.5411147213197;7409;7662.808429789258;7663.118741344754;7674.88487672684;7688.692452301915;7585.279398457138;7777.455578109534;7781.377489800817;7784.727534536292;7788.182240864712;1979.604079184169;2281.4752606900424;2337.5909215887236;2349.7650234976536;2362.9409264768433;2340.473393486469;2345.413646588353;2349.459624286415;2351.012574718614;2352.7059117610297;2229.487217939875;2308.088305119477;2317.640765681322;2317.687112239843;2320.907163713458;2277.8974946127464;2305.7463678995296;2323.14043803792;2331.4870728439714;2333.9533209335887;2295.988520057389;2315.479017221112;2315.9073637054667;2318.8260880434036;2353.1175809071597;7912.643931023118;7952.483088599281;7971.681132754741;7987.520748755035;7997.680092796281;4750.263709125091;4843.854684359475;4874.341963834872;4875.853724388274;4879.194932836078;3073.339232065117;3192.297694507228;3226.774125811194;3257.8371081445835;3290.9835450822834;1004;1887.9528011799814;1925.643755905162;1935.7677078750498;1952.7266182734286;10605.575776968912;10642.893571064345;10665.306755060974;10665.986731260518;10685.946570267099;4142.689298302639;4286.357046443059;4323.200207961537;4345.326474396474;4385.144896745104;8383.664653413916;8418.536980466133;8446.324294056461;8452.704155354657;8462.61918213682;4334.45819272591;4912.8771780705765;4913.164761990399;4945.530174633404;4949.381327334083;4357.825686972549;4433.977830110829;4446.866594002185;4461.219286624828;4465.620422264079;3355.8489867956;3423.127102588824;3438.2607739336163;3443.1220038889924;3457.1184347991602;1069.4118234970736;1079.7030816525362;1081.2539347849959;1087.1140020882956;1091.8744344400336;1321.1808678619318;1322.9470821167045;1362.6661467940419;1379.0208951644445;1386.9445222191;7488.632790468987;7510.248975102446;7527.3225409712295;7632.313091821763;7639.236076392427;522.2844702757171;526.276369991262;528.6299590286815;528.8624957511075;538.2330179494205;5918.674472903946;5924.585279030426;5984.521238301013;6023.066424704178;6037.45662890342;9428.340016198801;9592.328537002342;9756.365836220622;9794.167495762798;9802.607895684236;9424.528773561295;9576.042395760369;9598.42409455435;9683.564239609093;9700.90299097014;7568.4323675724545;7624.58064806441;7700;7717;7719.34385577221;7028.367446929801;7236.565806051653;7279.526830755984;7325.047743793273;7325.560466372035;8296.668133274843;8384.496930183965;8487.15128487171;8488.957555212184;8603.139686031347;8747.431416958132;8788.16512431318;8887.955560222157;8905;9001.144891235323;6134.6625935573975;6666.83332916681;6847.1783385994;6884.449244060564;6988.650567471708;7508.662110205163;7511.286427789351;7513.774586762406;7531.171571127062;7557.5465472071855;6627.701753421011;6788.321167883172;6858.931410686029;6899.793006209822;6981.406580440719;6805.625690586867;6806.897896531457;6876.140482439695;6924.376806087476;6932.861342773015;6970.442364610718;7072.752453664097;7088.184858741311;7131.643417828984;7132.500724949411;6436.131122298617;6480.57876238043;6488.351164883474;6490.545661803629;6492.123563318892;6576.079348891255;6642.103316052271;6667.19993600771;6679.198496180489;6692.130023096966 02:43:27 INFO - PROCESS | 633 | |4;prototype.html;326.8284150820819;326.8855900434848;332.8668532586965;336.85346874109763;337.6353538178767;5837.795677151301;5873.11903214518;5931.762729490815;5959.076343166811;5959.106134079891;5823.184754134425;5826.475617194452;5864.266966629171;5870.853228669274;5885.146653735216;4334.761588112652;4418.690691651585;4525.343825145352;4533.161365147442;4541.477730061036;4498.6176175025;4508.07584445188;4514.345419914111;4568.474625418086;4571.542845715435;4281.700280980317;4522.208613492642;4529.8641040768825;4535.7278563286145;4537.228671125917;4383.211022016036;4477.910441791162;4490.079533695617;4504.481984571784;4523.140603285398;3964.5440774311037;3973.443717879499;3974.324364857981;3976.76139431635;3981.144054028369;5614.522765564931;5614.775408983635;5616.691081990489;5620.1288800236025;5623.409541998113;5256.9737151314;5258.027264955957;5259.474052594748;5264.763085661116;5268.947310526884;6237.09562113491;6238.563300568962;6244.687765611701;6247.875042499125;6248.4064013918605;4133.441985331971;4265.189613973335;4271.124419493996;4279.465066866642;4409.955900440987;6423.068655045039;6494.9350506495275;6495.1556297681;6511.218653761579;6533.314002029813;4243.936340954826;4247.68142389322;4248.936265956013;4250.192463431938;4251.702380833374;4304.117655880537;4306.4832220133785;4308.5045219799495;4308.612224899774;4311.417958575552;5065.544101030925;5077.847664570068;5080.060188865072;5082.898342033139;5084.872878178001;6129.2032035835055;6252.437280644764;6279.686015699197;6286.622802631857;6294.339094395114;1488.2186851902838;1489.9404023838924;1497.7977972973727;1503.1131632336974;1515.4241388272385;948.9478078705599;998.0219385002738;1000.0799264676369;1010.8433192855119;1043.389617074005;5881;5927.644341339534;5934.584579079509;5936.28764548257;5943.197668314809;6350.428461438492;6362.459190968727;6362.713677884506;6365.14070600463;6367;5923.259592550931;5932;5940.782139661359;5942.70286485674;5943.791967281211;3404.4552871540436;3422.19578399076;3431.365197438482;3439.94840077399;3441.105312618687;6552.213734351908;6681.231658359351;6709.6980635871505;6729.25978142404;6732.629705366252;6475.870482590321;6489.091527186198;6520.967395163088;6524.412802847766;6527.11883895668;6636.469082473391;6679.5658282210525;6690.899636505456;6693.1298931138645;6713.865722685519;6320.1467801848;6332.081848131903;6341.619502829845;6341.841453963688;6342.90485642725;6110.358412366638;6290;6292.433680968735;6307.05394190875;6323.588966717149;6663.633500157344;6685.498587606046;6707.4969377297875;6709.4632429404555;6714.764983225564;4338.154059958278;4340.8697739067875;4341.8263269470135;4344.6089851913475;4345.500267469281;6353.047042943595;6362.395572420613;6364.331745166876;6370.140031095742;6372.267189273293;6135.233095863017;6183.319834818257;6183.783567575113;6186.566940314135;6188.319284878569;6030.713261272705;6110;6176.104464852661;6181;6182.350853160533;6030.216071910623;6050.697465126814;6061.393860613904;6068.696565171812;6075.665838378932;6196.690165491617;6208.968955155376;6212;6213.347598502092;6222.968885155546;5927.644341339534;6035.69821508914;6044.063170208625;6062.545309101747;6077.088436734525 02:43:27 INFO - PROCESS | 633 | |5;yui.html;819.9508029518225;833.1501868094543;834.2450082675178;838.450814716361;863.7754183912183;13874.236916969563;14007.789883151761;14030.438782448702;14050.156990580572;14054.367553460093;13256.403461844217;13326.400311985959;13333.266670333127;13342.199468031924;13362.465501379957;820.6553247635992;832.7376876283981;833.72487079264;834.4409245805294;834.5368320582074;657.562720790676;805.2068712318362;821.983560328793;830.9875351869727;835.2649668291895;847.5846835050811;851.3870013590205;856.5588721808242;857.1043259793499;857.1899554920602;851.6678495386805;851.8083431227986;851.8296340731847;851.833892390984;851.9616617252238;510.15059925224455;636.525788287724;637.7767781276563;645.880512105262;647.3009150117862;13827.170369777845;13832.930835345758;13834;13847.792283115761;13875.722485550232;12610.180338278074;12953.352332383438;12997.675058123623;13018.934905325508;13396.86603133966;10795.29830561011;10850.945745271301;11090.667279981613;11117.777644447147;11303.886961130447;3683.410654295327;3743.6630703236565;3752.8686495972784;3782.9621703782886;3866.2074274773886;50000;50304.74847625739;50433.495665043614;50494.24258636124;50595.22916697935;10402.167826573856;10505.369677819355;10561.683149505527;10694.679159625224;10735.194860385502;19235.4229373119;19311;19398.224071037283;19427.708584371245;19433.028348582513;7532.209118042636;7615;7709.575973321521;7760.18518055596;7873.409494287951;4236.9788151059665;4259.446271984622;4323.848665296699;4325.697201195886;4349.565043495689;3195.1532843796413;3198.648148703641;3208.7593430492807;3213.0360891732385;3214.373197226565;568.3009897825698;580.3152280309191;586.1676419484343;586.633354153654;593.6200831467864;637.974481020754;645.3772109913956;660.7720336483906;675.9019942108366;689.2039694153261;8150.470219435718;8162.347012239006;8224.794380140544;8314.958425207835;8368.874466883002;511.93600799900014;596.9492593129546;636.59576169132;651.1567520061532;654.450261780107;3835.6931445484292;3863.8068096595057;3896.12337224128;3962.7622342659533;4189.769562674082;54029.729851350494;55592.444075559535;55602.72198639062;55629;55742;49613.50386496089;49892;50620;50767.23849142266;50791.74604126956;44009.339859902124;44637.55362446334;44932.3260151098;45178.322325165806;45929.31106033412;7801.2198780121535;7903.3677305816545;8102.149274326347;8162;8166.224208700164;34956.30087398187;34998;35022.47466287957;35993.46009809907;36153.63846361608;41361.379579305736;44093.77953110214;44782.3282650767;44909.775451123845;45477;9879.407235565888;9964.651237206663;11180.273282236629;11523.654290371302;11902.40487975615;12209.328486933304;12306.261624302571;12440.937795310965;12700.555480558505;12700.618981430573;11422.485988130387;11451.656450306504;11586;11944.522219111486;12224.083193760682;10783.676489705322;11520.193586449202;11659.417029148679;11763.941180294043;12044.397780111134;11607.245529040585;11796.52813887435;11860.76278474443;11873.82189267179;11954.462049207632;9348.53257337144;9398.95300523493;9481.383710058824;9620.615175393186;9640.180584650383;9016.098390161194;9074.31942604294;9162.541872906462;9195.678151264674;9917.702468925943 02:43:27 INFO - PROCESS | 633 | __end_tp_report 02:43:27 INFO - PROCESS | 633 | __start_cc_report 02:43:27 INFO - PROCESS | 633 | _x_x_mozilla_cycle_collect,990 02:43:27 INFO - PROCESS | 633 | __end_cc_report 02:43:27 INFO - PROCESS | 633 | __startTimestamp1457433807525__endTimestamp 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | ------- Summary: start ------- 02:43:27 INFO - PROCESS | 633 | Number of tests: 6 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#0] dojo.html Cycles:165 Average:5170.31 Median:5333.73 stddev:571.56 (10.7%) stddev-sans-first:550.25 02:43:27 INFO - PROCESS | 633 | Values: 3121.7 3122.0 3129.6 3136.6 3154.9 5074.8 5095.1 5095.9 5106.8 5167.4 5207.3 5212.8 5228.0 5229.7 5236.2 4587.4 4751.9 4805.5 4880.6 4898.7 4659.3 4688.9 4827.5 4883.3 4885.8 4744.4 4754.6 4763.1 4780.2 4799.7 4704.0 4740.2 4741.1 4765.6 4783.3 4665.2 4726.7 4755.5 4769.4 4786.2 5048.8 5051.8 5059.1 5067.4 5077.9 5433.3 5536.4 5547.9 5549.0 5562.9 5670.7 5672.9 5676.2 5679.3 5681.0 5286.7 5292.1 5293.0 5293.8 5298.4 5512.0 5547.6 5585.5 5593.0 5664.5 5280.7 5338.0 5340.4 5356.9 5387.7 5394.6 5400.5 5436.3 5449.6 5471.3 5550.6 5608.9 5612.3 5631.6 5632.7 5559.9 5561.8 5562.3 5568.5 5571.9 4207.8 4224.6 4259.5 4268.0 4297.4 3833.1 3835.0 3855.5 3860.3 3882.6 5230.2 5243.6 5256.2 5256.3 5294.6 5326.2 5547.3 5557.3 5592.1 5654.4 5192.1 5221.1 5238.9 5242.2 5268.1 4688.4 4692.1 4696.7 4698.1 4739.1 5687.7 5805.4 5839.2 5903.9 5907.0 5568.4 5583.1 5586.8 5591.0 5598.0 5865.6 5866.2 5886.0 5890.7 5899.9 5425.3 5490.5 5520.3 5548.0 5582.7 5610.9 5613.8 5615.2 5632.1 5634.0 5315.7 5417.9 5483.6 5486.7 5534.1 5391.2 5425.8 5431.5 5450.5 5489.5 5264.1 5309.3 5333.7 5339.4 5377.7 5385.1 5387.6 5436.9 5439.2 5454.6 5221.7 5326.0 5359.7 5407.5 5456.0 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#1] ext.html Cycles:180 Average:46404.16 Median:36311.23 stddev:75957.03 (209.2%) stddev-sans-first:76091.99 02:43:27 INFO - PROCESS | 633 | Values: 521.7 526.8 546.8 549.2 604.6 30780.8 31314.8 36544.3 36995.4 37148.4 40130.0 40586.4 40601.4 40639.0 40677.4 8573.7 8789.0 8789.6 8793.6 8795.1 8586.5 8693.9 8711.5 8718.0 8720.7 8916.9 8987.5 9003.8 9013.1 9013.2 8885.6 8967.1 8978.4 8978.8 8981.7 8750.7 8889.4 8901.0 8909.7 8909.9 39291.2 39744.2 39825.0 39832.4 39847.8 3261.8 3383.6 3458.8 3835.3 4113.6 29269.9 29667.7 30254.0 30507.7 30530.8 3892.1 3918.7 3956.8 3980.4 4018.2 263648.0 299568.0 305287.0 305293.0 305343.0 59752.0 61559.4 61655.4 61823.4 61854.0 64719.0 64816.0 65398.3 65570.7 65613.0 15873.1 16060.4 16062.5 16065.5 16073.8 12314.2 12350.1 12357.4 12364.8 12366.3 20590.5 20850.4 20851.7 20891.1 20900.8 7648.3 8420.7 8438.8 8464.8 8465.3 964.6 965.9 1020.3 1027.5 1029.7 27746.0 28220.0 28838.3 28902.9 29006.3 1051.3 1083.7 1100.3 1111.5 1134.0 14337.8 14863.9 14869.6 15126.0 15161.6 303753.0 305100.0 305180.0 307216.0 307339.0 51853.7 52253.7 52307.5 52386.0 52390.5 1128.3 1245.7 1361.5 1367.3 1384.2 27951.9 29014.0 30760.7 31335.5 31404.5 44682.3 45144.0 45264.5 45326.0 45352.1 263021.0 270601.0 270725.0 271769.0 272703.0 31199.5 32589.3 32598.5 32606.0 32676.2 42177.4 43363.0 43427.9 44080.0 44533.3 36328.5 36527.5 36772.4 36912.4 36945.4 36050.0 36232.0 36286.6 36331.5 36528.0 35278.8 35605.8 35970.0 36196.5 36294.0 31597.8 32397.0 32798.8 32913.5 33016.3 25153.6 25521.5 25865.5 27170.0 28595.4 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#2] jquery.html Cycles:180 Average:23179.85 Median:42605.75 stddev:60312.94 (141.6%) stddev-sans-first:60457.72 02:43:27 INFO - PROCESS | 633 | Values: 324.6 345.5 353.3 357.6 359.3 17248.9 17730.3 17820.4 18280.2 18288.8 16910.1 17262.8 17665.3 17684.8 17688.5 4697.9 5359.5 5503.5 5511.4 5546.3 5430.8 5442.2 5445.5 5449.9 5452.4 5319.9 5374.5 5436.8 5490.9 5493.1 5395.1 5404.3 5431.5 5440.9 5450.0 4832.9 4850.5 4872.4 4920.3 4928.0 20630.3 20678.2 20766.3 21184.5 21297.7 2116.4 2126.3 2153.1 2247.1 2349.6 9408.4 9745.7 9794.6 9913.2 12678.2 1851.8 1909.3 1915.5 1943.3 1971.7 56700.0 57542.4 58307.7 58384.4 60458.7 9428.7 9553.7 9654.0 9950.8 9995.1 12452.4 12521.4 13057.7 13116.3 13162.3 7258.9 7456.7 7462.2 7542.2 7565.0 7173.5 7471.3 7517.6 7561.0 7570.6 4516.3 4593.0 4596.4 4611.9 4649.5 1735.5 1825.3 1833.7 1850.1 1890.6 781.4 890.4 946.2 1030.1 1056.7 16782.7 16797.2 16860.6 17000.6 17486.0 927.4 946.9 989.8 1007.8 1045.3 9541.0 9642.4 9765.4 9852.2 9859.4 338113.0 344721.0 346385.0 393153.4 404304.0 74412.6 76357.6 76619.2 77341.6 78115.0 914.6 997.9 1025.6 1032.9 1034.8 14417.1 14822.7 14830.3 15015.6 15250.7 33698.3 33759.8 34439.7 34638.1 34753.7 42483.0 42554.4 42657.1 42879.8 43411.0 7948.6 7957.3 7973.6 8034.8 8138.3 12176.2 12567.5 12569.4 12655.9 12899.7 9803.2 11038.3 11205.3 11233.3 11335.5 11060.7 11079.3 11120.7 11210.4 11223.7 6588.7 7292.6 10886.9 11104.9 11357.4 7856.1 8251.5 8354.2 8401.0 8447.5 9857.8 10926.7 11198.8 11280.7 11538.3 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#3] mootools.html Cycles:180 Average:5511.55 Median:6285.40 stddev:2829.58 (45.0%) stddev-sans-first:2819.93 02:43:27 INFO - PROCESS | 633 | Values: 1315.4 1489.0 1505.8 1688.7 1835.5 7409.0 7662.8 7663.1 7674.9 7688.7 7585.3 7777.5 7781.4 7784.7 7788.2 1979.6 2281.5 2337.6 2349.8 2362.9 2340.5 2345.4 2349.5 2351.0 2352.7 2229.5 2308.1 2317.6 2317.7 2320.9 2277.9 2305.7 2323.1 2331.5 2334.0 2296.0 2315.5 2315.9 2318.8 2353.1 7912.6 7952.5 7971.7 7987.5 7997.7 4750.3 4843.9 4874.3 4875.9 4879.2 3073.3 3192.3 3226.8 3257.8 3291.0 1004.0 1888.0 1925.6 1935.8 1952.7 10605.6 10642.9 10665.3 10666.0 10685.9 4142.7 4286.4 4323.2 4345.3 4385.1 8383.7 8418.5 8446.3 8452.7 8462.6 4334.5 4912.9 4913.2 4945.5 4949.4 4357.8 4434.0 4446.9 4461.2 4465.6 3355.8 3423.1 3438.3 3443.1 3457.1 1069.4 1079.7 1081.3 1087.1 1091.9 1321.2 1322.9 1362.7 1379.0 1386.9 7488.6 7510.2 7527.3 7632.3 7639.2 522.3 526.3 528.6 528.9 538.2 5918.7 5924.6 5984.5 6023.1 6037.5 9428.3 9592.3 9756.4 9794.2 9802.6 9424.5 9576.0 9598.4 9683.6 9700.9 7568.4 7624.6 7700.0 7717.0 7719.3 7028.4 7236.6 7279.5 7325.0 7325.6 8296.7 8384.5 8487.2 8489.0 8603.1 8747.4 8788.2 8888.0 8905.0 9001.1 6134.7 6666.8 6847.2 6884.4 6988.7 7508.7 7511.3 7513.8 7531.2 7557.5 6627.7 6788.3 6858.9 6899.8 6981.4 6805.6 6806.9 6876.1 6924.4 6932.9 6970.4 7072.8 7088.2 7131.6 7132.5 6436.1 6480.6 6488.4 6490.5 6492.1 6576.1 6642.1 6667.2 6679.2 6692.1 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#4] prototype.html Cycles:180 Average:5178.74 Median:5933.29 stddev:1575.17 (26.5%) stddev-sans-first:1536.91 02:43:27 INFO - PROCESS | 633 | Values: 326.8 326.9 332.9 336.9 337.6 5837.8 5873.1 5931.8 5959.1 5959.1 5823.2 5826.5 5864.3 5870.9 5885.1 4334.8 4418.7 4525.3 4533.2 4541.5 4498.6 4508.1 4514.3 4568.5 4571.5 4281.7 4522.2 4529.9 4535.7 4537.2 4383.2 4477.9 4490.1 4504.5 4523.1 3964.5 3973.4 3974.3 3976.8 3981.1 5614.5 5614.8 5616.7 5620.1 5623.4 5257.0 5258.0 5259.5 5264.8 5268.9 6237.1 6238.6 6244.7 6247.9 6248.4 4133.4 4265.2 4271.1 4279.5 4410.0 6423.1 6494.9 6495.2 6511.2 6533.3 4243.9 4247.7 4248.9 4250.2 4251.7 4304.1 4306.5 4308.5 4308.6 4311.4 5065.5 5077.8 5080.1 5082.9 5084.9 6129.2 6252.4 6279.7 6286.6 6294.3 1488.2 1489.9 1497.8 1503.1 1515.4 948.9 998.0 1000.1 1010.8 1043.4 5881.0 5927.6 5934.6 5936.3 5943.2 6350.4 6362.5 6362.7 6365.1 6367.0 5923.3 5932.0 5940.8 5942.7 5943.8 3404.5 3422.2 3431.4 3439.9 3441.1 6552.2 6681.2 6709.7 6729.3 6732.6 6475.9 6489.1 6521.0 6524.4 6527.1 6636.5 6679.6 6690.9 6693.1 6713.9 6320.1 6332.1 6341.6 6341.8 6342.9 6110.4 6290.0 6292.4 6307.1 6323.6 6663.6 6685.5 6707.5 6709.5 6714.8 4338.2 4340.9 4341.8 4344.6 4345.5 6353.0 6362.4 6364.3 6370.1 6372.3 6135.2 6183.3 6183.8 6186.6 6188.3 6030.7 6110.0 6176.1 6181.0 6182.4 6030.2 6050.7 6061.4 6068.7 6075.7 6196.7 6209.0 6212.0 6213.3 6223.0 5927.6 6035.7 6044.1 6062.5 6077.1 02:43:27 INFO - PROCESS | 633 | 02:43:27 INFO - PROCESS | 633 | [#5] yui.html Cycles:180 Average:13852.91 Median:45327.66 stddev:15773.48 (34.8%) stddev-sans-first:15787.36 02:43:27 INFO - PROCESS | 633 | Values: 820.0 833.2 834.2 838.5 863.8 13874.2 14007.8 14030.4 14050.2 14054.4 13256.4 13326.4 13333.3 13342.2 13362.5 820.7 832.7 833.7 834.4 834.5 657.6 805.2 822.0 831.0 835.3 847.6 851.4 856.6 857.1 857.2 851.7 851.8 851.8 851.8 852.0 510.2 636.5 637.8 645.9 647.3 13827.2 13832.9 13834.0 13847.8 13875.7 12610.2 12953.4 12997.7 13018.9 13396.9 10795.3 10850.9 11090.7 11117.8 11303.9 3683.4 3743.7 3752.9 3783.0 3866.2 50000.0 50304.7 50433.5 50494.2 50595.2 10402.2 10505.4 10561.7 10694.7 10735.2 19235.4 19311.0 19398.2 19427.7 19433.0 7532.2 7615.0 7709.6 7760.2 7873.4 4237.0 4259.4 4323.8 4325.7 4349.6 3195.2 3198.6 3208.8 3213.0 3214.4 568.3 580.3 586.2 586.6 593.6 638.0 645.4 660.8 675.9 689.2 8150.5 8162.3 8224.8 8315.0 8368.9 511.9 596.9 636.6 651.2 654.5 3835.7 3863.8 3896.1 3962.8 4189.8 54029.7 55592.4 55602.7 55629.0 55742.0 49613.5 49892.0 50620.0 50767.2 50791.7 44009.3 44637.6 44932.3 45178.3 45929.3 7801.2 7903.4 8102.1 8162.0 8166.2 34956.3 34998.0 35022.5 35993.5 36153.6 41361.4 44093.8 44782.3 44909.8 45477.0 9879.4 9964.7 11180.3 11523.7 11902.4 12209.3 12306.3 12440.9 12700.6 12700.6 11422.5 11451.7 11586.0 11944.5 12224.1 10783.7 11520.2 11659.4 11763.9 12044.4 11607.2 11796.5 11860.8 11873.8 11954.5 9348.5 9399.0 9481.4 9620.6 9640.2 9016.1 9074.3 9162.5 9195.7 9917.7 02:43:27 INFO - PROCESS | 633 | -------- Summary: end -------- 02:43:27 INFO - PROCESS | 633 | 02:43:28 INFO - TEST-INFO | 633: exit 0 02:43:28 INFO - TEST-OK | dromaeo_css | took 1112763ms 02:43:28 INFO - TEST-START | kraken 02:43:28 INFO - operating with platform_type : linux_ 02:43:28 INFO - Initialising browser for kraken test... 02:43:28 INFO - TEST-INFO | started process 821 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKd3yAK/profile http://localhost:40125/getInfo.html) 02:43:32 INFO - PROCESS | 821 | __metrics Screen width/height:1600/1200 02:43:32 INFO - PROCESS | 821 | colorDepth:24 02:43:32 INFO - PROCESS | 821 | Browser inner width/height: 1024/697 02:43:32 INFO - PROCESS | 821 | __metrics 02:43:32 INFO - PROCESS | 821 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:33 INFO - TEST-INFO | 821: exit 0 02:43:33 INFO - Browser initialized. 02:43:33 INFO - Running cycle 1/1 for kraken test... 02:43:33 INFO - TEST-INFO | started process 912 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKd3yAK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:45 INFO - PROCESS | 912 | RSS: Main: 153649152 02:43:45 INFO - PROCESS | 912 | 02:43:48 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40125/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:48 INFO - PROCESS | 912 | RSS: Main: 197103616 02:43:48 INFO - PROCESS | 912 | 02:43:51 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40125/tests/kraken/driver.html?testName=audio-dft) 02:43:51 INFO - PROCESS | 912 | RSS: Main: 187494400 02:43:51 INFO - PROCESS | 912 | 02:43:54 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40125/tests/kraken/driver.html?testName=audio-fft) 02:43:55 INFO - PROCESS | 912 | RSS: Main: 169951232 02:43:55 INFO - PROCESS | 912 | 02:43:57 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40125/tests/kraken/driver.html?testName=audio-oscillator) 02:43:58 INFO - PROCESS | 912 | RSS: Main: 173436928 02:43:58 INFO - PROCESS | 912 | 02:44:00 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40125/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:00 INFO - PROCESS | 912 | RSS: Main: 174370816 02:44:00 INFO - PROCESS | 912 | 02:44:03 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40125/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:04 INFO - PROCESS | 912 | RSS: Main: 175202304 02:44:04 INFO - PROCESS | 912 | 02:44:07 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40125/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:08 INFO - PROCESS | 912 | RSS: Main: 176328704 02:44:08 INFO - PROCESS | 912 | 02:44:11 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40125/tests/kraken/driver.html?testName=json-parse-financial) 02:44:11 INFO - PROCESS | 912 | RSS: Main: 176304128 02:44:11 INFO - PROCESS | 912 | 02:44:13 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40125/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:13 INFO - PROCESS | 912 | RSS: Main: 187707392 02:44:13 INFO - PROCESS | 912 | 02:44:15 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:16 INFO - PROCESS | 912 | RSS: Main: 184561664 02:44:16 INFO - PROCESS | 912 | 02:44:18 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:18 INFO - PROCESS | 912 | RSS: Main: 198029312 02:44:18 INFO - PROCESS | 912 | 02:44:21 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:21 INFO - PROCESS | 912 | RSS: Main: 201498624 02:44:21 INFO - PROCESS | 912 | 02:44:24 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:25 INFO - PROCESS | 912 | RSS: Main: 202760192 02:44:25 INFO - PROCESS | 912 | 02:44:26 INFO - PROCESS | 912 | Cycle 1(1): loaded http://localhost:40125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40125/tests/kraken/driver.html?testName=ai-astar) 02:44:27 INFO - PROCESS | 912 | RSS: Main: 263716864 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | __start_tp_report 02:44:27 INFO - PROCESS | 912 | _x_x_mozilla_page_load 02:44:27 INFO - PROCESS | 912 | _x_x_mozilla_page_load_details 02:44:27 INFO - PROCESS | 912 | |i|pagename|runs| 02:44:27 INFO - PROCESS | 912 | |0;ai-astar;109;111;106;110;110;110;101;110;110;110 02:44:27 INFO - PROCESS | 912 | |1;audio-beat-detection;152;132;148;170;131;156;161;137;180;130 02:44:27 INFO - PROCESS | 912 | |2;audio-dft;161;160;162;161;162;161;160;165;161;162 02:44:27 INFO - PROCESS | 912 | |3;audio-fft;73;72;102;105;73;75;75;109;97;73 02:44:27 INFO - PROCESS | 912 | |4;audio-oscillator;93;93;140;93;94;93;139;93;93;137 02:44:27 INFO - PROCESS | 912 | |5;imaging-gaussian-blur;116;118;116;117;116;116;116;116;117;117 02:44:27 INFO - PROCESS | 912 | |6;imaging-darkroom;146;145;146;145;145;146;146;145;146;145 02:44:27 INFO - PROCESS | 912 | |7;imaging-desaturate;95;96;96;96;95;96;96;95;96;96 02:44:27 INFO - PROCESS | 912 | |8;json-parse-financial;58;58;57;57;57;58;57;65;55;55 02:44:27 INFO - PROCESS | 912 | |9;json-stringify-tinderbox;67;68;67;68;67;67;67;67;73;68 02:44:27 INFO - PROCESS | 912 | |10;stanford-crypto-aes;82;82;85;83;83;82;89;82;83;81 02:44:27 INFO - PROCESS | 912 | |11;stanford-crypto-ccm;125;121;116;122;115;113;113;126;117;128 02:44:27 INFO - PROCESS | 912 | |12;stanford-crypto-pbkdf2;162;139;155;149;149;138;146;161;147;148 02:44:27 INFO - PROCESS | 912 | |13;stanford-crypto-sha256-iterative;68;68;70;70;69;69;67;70;72;69 02:44:27 INFO - PROCESS | 912 | __end_tp_report 02:44:27 INFO - PROCESS | 912 | __start_cc_report 02:44:27 INFO - PROCESS | 912 | _x_x_mozilla_cycle_collect,1091 02:44:27 INFO - PROCESS | 912 | __end_cc_report 02:44:27 INFO - PROCESS | 912 | __startTimestamp1457433867013__endTimestamp 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | ------- Summary: start ------- 02:44:27 INFO - PROCESS | 912 | Number of tests: 14 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.02 (2.7%) stddev-sans-first:3.20 02:44:27 INFO - PROCESS | 912 | Values: 109.0 111.0 106.0 110.0 110.0 110.0 101.0 110.0 110.0 110.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.00 stddev:17.38 (11.3%) stddev-sans-first:18.41 02:44:27 INFO - PROCESS | 912 | Values: 152.0 132.0 148.0 170.0 131.0 156.0 161.0 137.0 180.0 130.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 02:44:27 INFO - PROCESS | 912 | Values: 161.0 160.0 162.0 161.0 162.0 161.0 160.0 165.0 161.0 162.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.00 stddev:15.66 (21.5%) stddev-sans-first:15.96 02:44:27 INFO - PROCESS | 912 | Values: 73.0 72.0 102.0 105.0 73.0 75.0 75.0 109.0 97.0 73.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.00 (23.7%) stddev-sans-first:22.77 02:44:27 INFO - PROCESS | 912 | Values: 93.0 93.0 140.0 93.0 94.0 93.0 139.0 93.0 93.0 137.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 02:44:27 INFO - PROCESS | 912 | Values: 116.0 118.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:44:27 INFO - PROCESS | 912 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 02:44:27 INFO - PROCESS | 912 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.79 (4.9%) stddev-sans-first:2.96 02:44:27 INFO - PROCESS | 912 | Values: 58.0 58.0 57.0 57.0 57.0 58.0 57.0 65.0 55.0 55.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:1.85 (2.7%) stddev-sans-first:1.94 02:44:27 INFO - PROCESS | 912 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 73.0 68.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.30 (2.8%) stddev-sans-first:2.40 02:44:27 INFO - PROCESS | 912 | Values: 82.0 82.0 85.0 83.0 83.0 82.0 89.0 82.0 83.0 81.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:121.50 stddev:5.54 (4.6%) stddev-sans-first:5.52 02:44:27 INFO - PROCESS | 912 | Values: 125.0 121.0 116.0 122.0 115.0 113.0 113.0 126.0 117.0 128.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:149.00 stddev:8.04 (5.4%) stddev-sans-first:7.12 02:44:27 INFO - PROCESS | 912 | Values: 162.0 139.0 155.0 149.0 149.0 138.0 146.0 161.0 147.0 148.0 02:44:27 INFO - PROCESS | 912 | 02:44:27 INFO - PROCESS | 912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.41 02:44:27 INFO - PROCESS | 912 | Values: 68.0 68.0 70.0 70.0 69.0 69.0 67.0 70.0 72.0 69.0 02:44:27 INFO - PROCESS | 912 | -------- Summary: end -------- 02:44:27 INFO - PROCESS | 912 | 02:44:28 INFO - TEST-INFO | 912: exit 0 02:44:28 INFO - TEST-OK | kraken | took 59910ms 02:44:28 INFO - SUITE-END | took 1172s 02:44:28 INFO - Completed test suite (00:19:33) 02:44:28 INFO - javascript benchmark 02:44:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.719045285924, 3121.9687803121974, 3129.624445066592, 3136.592243008409, 3154.9211269718253, 5074.797008119675, 5095.082885080684, 5095.872603184922, 5106.795728170873, 5167.431582525919, 5207.3490813648295, 5212.817551385693, 5228.0, 5229.712365819878, 5236.240745091959, 4587.42657167854, 4751.9287210691955, 4805.495422980589, 4880.560749532541, 4898.7060776353355, 4659.301104834285, 4688.906221875561, 4827.51724827518, 4883.267509873512, 4885.755712214375, 4744.383230180089, 4754.619630429592, 4763.118823017753, 4780.16347139251, 4799.712017278939, 4703.976480117578, 4740.170470167707, 4741.146593613148, 4765.594924431392, 4783.282507623884, 4665.183592871234, 4726.71639701619, 4755.453122890843, 4769.356136921506, 4786.234202527614, 5048.772805223737, 5051.823186188502, 5059.089363914494, 5067.417247016567, 5077.923831142536, 5433.320834895638, 5536.446355364472, 5547.916781248285, 5548.9722551386985, 5562.9443705562835, 5670.659760414388, 5672.886542269172, 5676.1769543416385, 5679.318481782213, 5680.971595142039, 5286.656367336111, 5292.100342941709, 5292.973535132338, 5293.814716484904, 5298.36419629643, 5512.0, 5547.55619550435, 5585.497305242467, 5593.0491816390495, 5664.461876121762, 5280.735963201824, 5337.973310133502, 5340.385855626652, 5356.946430535722, 5387.730613469311, 5394.568434525228, 5400.486953739389, 5436.320459942507, 5449.5640348772795, 5471.2887324647545, 5550.611457197957, 5608.943910560843, 5612.326520817528, 5631.577631677558, 5632.718364081779, 5559.944400555943, 5561.833145005576, 5562.276904002454, 5568.49883510486, 5571.916421253684, 4207.810648520824, 4224.640905523003, 4259.531451540328, 4268.018355778188, 4297.419848320499, 3833.1375440525658, 3835.0, 3855.5373355197557, 3860.3051450738576, 3882.6117388261514, 5230.189320655304, 5243.606729495303, 5256.2115682647145, 5256.2904007959205, 5294.629375943647, 5326.201069839555, 5547.278853749068, 5557.305336832896, 5592.105263157875, 5654.4062873398525, 5192.1173400522, 5221.086309895753, 5238.869028274247, 5242.239875218148, 5268.078086334876, 4688.390509233846, 4692.131955588227, 4696.7416792076765, 4698.083873644607, 4739.146953548395, 5687.658740475502, 5805.448482394166, 5839.211706419664, 5903.940960590339, 5906.970465147732, 5568.359638641608, 5583.0787919992745, 5586.832395028156, 5590.972045139748, 5598.0, 5865.618734782225, 5866.178734977192, 5886.028805247086, 5890.705464726832, 5899.941000589939, 5425.294711687456, 5490.533304669148, 5520.309961254843, 5548.0, 5582.665040097607, 5610.943890561205, 5613.775448981995, 5615.213870058114, 5632.098864181711, 5634.0, 5315.734213289397, 5417.864553386197, 5483.616146869681, 5486.670799752028, 5534.05920993424, 5391.16436952273, 5425.782968681208, 5431.538319242909, 5450.5367043801725, 5489.478499542537, 5264.131418315935, 5309.33633295838, 5333.7333133343955, 5339.439358867263, 5377.677339359651, 5385.057614917452, 5387.649802762808, 5436.864078398072, 5439.211314359317, 5454.618176727591, 5221.712805795718, 5326.041312563776, 5359.651622644516, 5407.540359069523, 5456.045192091288], "unit": "score", "name": "dojo.html", "value": 5133.576011313954}, {"lowerIsBetter": false, "replicates": [521.6531006880423, 526.7708546782148, 546.8052305712017, 549.2146230889829, 604.6432604763189, 30780.846095769517, 31314.843425782867, 36544.269114617724, 36995.445068324, 37148.44277335835, 40130.0, 40586.39120413196, 40601.390979135336, 40639.0, 40677.38983915236, 8573.699920502799, 8789.033206347296, 8789.560521973908, 8793.604287807031, 8795.076516965722, 8586.527740974245, 8693.913060869405, 8711.520866352348, 8717.956410217972, 8720.738377848675, 8916.910830891673, 8987.505687187235, 9003.819923601524, 9013.098690131, 9013.188813006827, 8885.555722213863, 8967.148120928501, 8978.416402933854, 8978.775530611721, 8981.730548083568, 8750.693725719633, 8889.377743557954, 8901.0, 8909.688160914402, 8909.910900890973, 39291.21417571661, 39744.20511589752, 39825.0, 39832.40251396231, 39847.8007609963, 3261.771675982682, 3383.593968723744, 3458.844352004166, 3835.252125835463, 4113.568075352105, 29269.853650731824, 29667.70332296671, 30254.0, 30507.69492305071, 30530.84734576313, 3892.124272038797, 3918.74528155669, 3956.8021598920227, 3980.44273801668, 4018.1561872006914, 263648.0, 299568.0, 305287.0, 305293.0, 305343.0, 59752.0, 61559.38440615626, 61655.38344616586, 61823.38176618176, 61854.0, 64719.0, 64816.0, 65398.34601654018, 65570.67214663896, 65613.0, 15873.12697801632, 16060.43788467398, 16062.518124456285, 16065.518034458984, 16073.758893616605, 12314.199577027464, 12350.135490515577, 12357.38213089342, 12364.752704945851, 12366.319852408024, 20590.485237869172, 20850.374488765363, 20851.687224691643, 20891.059902304434, 20900.790992090188, 7648.273414025659, 8420.747377578682, 8438.831223375499, 8464.788380290542, 8465.280451161598, 964.62379671928, 965.8792650918635, 1020.2756043209405, 1027.465717826726, 1029.7013865978931, 27746.027946500573, 28220.0, 28838.27904302367, 28902.855485722437, 29006.274843128667, 1051.2746205118444, 1083.7453198498347, 1100.3397961223202, 1111.5331560744507, 1133.9850833503967, 14337.78493322601, 14863.925680371529, 14869.647251436276, 15126.0, 15161.620959476102, 303753.0, 305100.0, 305180.0, 307216.0, 307339.0, 51853.74073129686, 52253.73873130686, 52307.47692523026, 52386.0, 52390.47609523856, 1128.2722643894806, 1245.6574442028334, 1361.5030513862368, 1367.2548461088732, 1384.1625816381145, 27951.860240698665, 29014.0, 30760.692393075784, 31335.529967050057, 31404.52893206558, 44682.3297650529, 45144.0, 45264.54735452603, 45326.0, 45352.09295813999, 263021.0, 270601.0, 270725.0, 271769.0, 272703.0, 31199.532007020367, 32589.34821303608, 32598.51102233516, 32606.0, 32676.183095421853, 42177.36733948932, 43363.0, 43427.874351936516, 44080.0, 44533.33200001938, 36328.45507317445, 36527.45208821817, 36772.44841327329, 36912.44631330586, 36945.44581831328, 36050.0, 36232.0, 36286.63713362938, 36331.45502817513, 36528.0, 35278.82360588181, 35605.82197089102, 35970.0, 36196.45705314475, 36294.0, 31597.8420107898, 32397.0, 32798.836005819816, 32913.50629740508, 33016.33967320688, 25153.622695659946, 25521.48957020812, 25865.482690346464, 27170.0, 28595.428091438473], "unit": "score", "name": "ext.html", "value": 18683.13876537888}, {"lowerIsBetter": false, "replicates": [324.62181558484366, 345.53352973485795, 353.3445458674158, 357.55484421894715, 359.2975732443072, 17248.913755431222, 17730.302563363344, 17820.376286829964, 18280.17739201736, 18288.7994600945, 16910.06994615296, 17262.82737172628, 17665.293388264487, 17684.82315176848, 17688.46934591961, 4697.882552936187, 5359.517643412092, 5503.477169668875, 5511.421300763423, 5546.251256080438, 5430.75561599727, 5442.156465747816, 5445.53712934401, 5449.945500545004, 5452.372977107624, 5319.909418569184, 5374.516293533581, 5436.809711660093, 5490.917636235459, 5493.148561972901, 5395.136778115502, 5404.270423492818, 5431.511163995239, 5440.863978400532, 5449.972750136224, 4832.9275060874115, 4850.514948505156, 4872.366592343008, 4920.286558449005, 4927.95072049282, 20630.277940272168, 20678.17287308506, 20766.273180438762, 21184.470388240417, 21297.68053479199, 2116.43914362694, 2126.25581046634, 2153.1172219389973, 2247.078697733921, 2349.553584818896, 9408.43549387039, 9745.658901938468, 9794.559244833928, 9913.206943444507, 12678.175918565265, 1851.8240767127102, 1909.3412772593433, 1915.4923945154544, 1943.2615606069744, 1971.6845304751314, 56700.0, 57542.42457575454, 58307.70846145785, 58384.41615583875, 60458.697706511186, 9428.669996550088, 9553.665621703207, 9654.0, 9950.80098398028, 9995.050965061742, 12452.377381130907, 12521.373931303398, 13057.673558160932, 13116.278604676834, 13162.341882905816, 7258.927410725931, 7456.701731930771, 7462.179160292472, 7542.245775422414, 7565.0, 7173.4935663510205, 7471.252874712594, 7517.624118794039, 7560.9621951889885, 7570.5836179010685, 4516.254817955, 4593.0, 4596.448426188878, 4611.8847028823875, 4649.488556258809, 1735.453332200378, 1825.2972605546695, 1833.724941258795, 1850.148931491502, 1890.5935223926922, 781.3514782730321, 890.3633901760143, 946.1815529566875, 1030.07808011829, 1056.709404913655, 16782.664346712998, 16797.244124014447, 16860.57848553796, 17000.57498562546, 17486.0, 927.4296307770672, 946.9431834089977, 989.7822479054596, 1007.8437842134481, 1045.2578669144991, 9540.95229523848, 9642.42145471274, 9765.414075155371, 9852.211823054138, 9859.35914165577, 338113.0, 344721.0, 346385.0, 393153.3765642917, 404304.0, 74412.62793685996, 76357.61821190859, 76619.2338076612, 77341.61329193319, 78115.0, 914.6295750221038, 997.9251556133174, 1025.6358992557684, 1032.948352582368, 1034.7930413917247, 14417.13497190172, 14822.703545928805, 14830.258487075818, 15015.624609384417, 15250.694986099994, 33698.32603347969, 33759.83120084384, 34439.65560344364, 34638.13404664904, 34753.65246347504, 42483.0, 42554.361684574134, 42657.14685706331, 42879.78560107305, 43411.0, 7948.602569871599, 7957.323627491728, 7973.561454120079, 8034.799130021796, 8138.267555919995, 12176.208546444806, 12567.497300107892, 12569.434375452944, 12655.93672031634, 12899.677508062374, 9803.215742740706, 11038.337699738042, 11205.327680339205, 11233.269837460539, 11335.546578136782, 11060.723481913017, 11079.279846809932, 11120.666380008613, 11210.439478025903, 11223.71940701489, 6588.703508342041, 7292.598907060163, 10886.891131088587, 11104.944475277573, 11357.432128393713, 7856.057273127261, 8251.463654862655, 8354.248117669438, 8400.957995209985, 8447.493150410995, 9857.753556161153, 10926.672199834018, 11198.83201751958, 11280.661580152608, 11538.307701537935], "unit": "score", "name": "jquery.html", "value": 8327.287834465884}, {"lowerIsBetter": false, "replicates": [1315.3751967815283, 1489.0395694776869, 1505.8042454480915, 1688.6960347137517, 1835.5411147213197, 7409.0, 7662.808429789258, 7663.118741344754, 7674.88487672684, 7688.692452301915, 7585.279398457138, 7777.455578109534, 7781.377489800817, 7784.727534536292, 7788.182240864712, 1979.604079184169, 2281.4752606900424, 2337.5909215887236, 2349.7650234976536, 2362.9409264768433, 2340.473393486469, 2345.413646588353, 2349.459624286415, 2351.012574718614, 2352.7059117610297, 2229.487217939875, 2308.088305119477, 2317.640765681322, 2317.687112239843, 2320.907163713458, 2277.8974946127464, 2305.7463678995296, 2323.14043803792, 2331.4870728439714, 2333.9533209335887, 2295.988520057389, 2315.479017221112, 2315.9073637054667, 2318.8260880434036, 2353.1175809071597, 7912.643931023118, 7952.483088599281, 7971.681132754741, 7987.520748755035, 7997.680092796281, 4750.263709125091, 4843.854684359475, 4874.341963834872, 4875.853724388274, 4879.194932836078, 3073.339232065117, 3192.297694507228, 3226.774125811194, 3257.8371081445835, 3290.9835450822834, 1004.0, 1887.9528011799814, 1925.643755905162, 1935.7677078750498, 1952.7266182734286, 10605.575776968912, 10642.893571064345, 10665.306755060974, 10665.986731260518, 10685.946570267099, 4142.689298302639, 4286.357046443059, 4323.200207961537, 4345.326474396474, 4385.144896745104, 8383.664653413916, 8418.536980466133, 8446.324294056461, 8452.704155354657, 8462.61918213682, 4334.45819272591, 4912.8771780705765, 4913.164761990399, 4945.530174633404, 4949.381327334083, 4357.825686972549, 4433.977830110829, 4446.866594002185, 4461.219286624828, 4465.620422264079, 3355.8489867956, 3423.127102588824, 3438.2607739336163, 3443.1220038889924, 3457.1184347991602, 1069.4118234970736, 1079.7030816525362, 1081.2539347849959, 1087.1140020882956, 1091.8744344400336, 1321.1808678619318, 1322.9470821167045, 1362.6661467940419, 1379.0208951644445, 1386.9445222191, 7488.632790468987, 7510.248975102446, 7527.3225409712295, 7632.313091821763, 7639.236076392427, 522.2844702757171, 526.276369991262, 528.6299590286815, 528.8624957511075, 538.2330179494205, 5918.674472903946, 5924.585279030426, 5984.521238301013, 6023.066424704178, 6037.45662890342, 9428.340016198801, 9592.328537002342, 9756.365836220622, 9794.167495762798, 9802.607895684236, 9424.528773561295, 9576.042395760369, 9598.42409455435, 9683.564239609093, 9700.90299097014, 7568.4323675724545, 7624.58064806441, 7700.0, 7717.0, 7719.34385577221, 7028.367446929801, 7236.565806051653, 7279.526830755984, 7325.047743793273, 7325.560466372035, 8296.668133274843, 8384.496930183965, 8487.15128487171, 8488.957555212184, 8603.139686031347, 8747.431416958132, 8788.16512431318, 8887.955560222157, 8905.0, 9001.144891235323, 6134.6625935573975, 6666.83332916681, 6847.1783385994, 6884.449244060564, 6988.650567471708, 7508.662110205163, 7511.286427789351, 7513.774586762406, 7531.171571127062, 7557.5465472071855, 6627.701753421011, 6788.321167883172, 6858.931410686029, 6899.793006209822, 6981.406580440719, 6805.625690586867, 6806.897896531457, 6876.140482439695, 6924.376806087476, 6932.861342773015, 6970.442364610718, 7072.752453664097, 7088.184858741311, 7131.643417828984, 7132.500724949411, 6436.131122298617, 6480.57876238043, 6488.351164883474, 6490.545661803629, 6492.123563318892, 6576.079348891255, 6642.103316052271, 6667.19993600771, 6679.198496180489, 6692.130023096966], "unit": "score", "name": "mootools.html", "value": 4511.8995935973435}, {"lowerIsBetter": false, "replicates": [326.8284150820819, 326.8855900434848, 332.8668532586965, 336.85346874109763, 337.6353538178767, 5837.795677151301, 5873.11903214518, 5931.762729490815, 5959.076343166811, 5959.106134079891, 5823.184754134425, 5826.475617194452, 5864.266966629171, 5870.853228669274, 5885.146653735216, 4334.761588112652, 4418.690691651585, 4525.343825145352, 4533.161365147442, 4541.477730061036, 4498.6176175025, 4508.07584445188, 4514.345419914111, 4568.474625418086, 4571.542845715435, 4281.700280980317, 4522.208613492642, 4529.8641040768825, 4535.7278563286145, 4537.228671125917, 4383.211022016036, 4477.910441791162, 4490.079533695617, 4504.481984571784, 4523.140603285398, 3964.5440774311037, 3973.443717879499, 3974.324364857981, 3976.76139431635, 3981.144054028369, 5614.522765564931, 5614.775408983635, 5616.691081990489, 5620.1288800236025, 5623.409541998113, 5256.9737151314, 5258.027264955957, 5259.474052594748, 5264.763085661116, 5268.947310526884, 6237.09562113491, 6238.563300568962, 6244.687765611701, 6247.875042499125, 6248.4064013918605, 4133.441985331971, 4265.189613973335, 4271.124419493996, 4279.465066866642, 4409.955900440987, 6423.068655045039, 6494.9350506495275, 6495.1556297681, 6511.218653761579, 6533.314002029813, 4243.936340954826, 4247.68142389322, 4248.936265956013, 4250.192463431938, 4251.702380833374, 4304.117655880537, 4306.4832220133785, 4308.5045219799495, 4308.612224899774, 4311.417958575552, 5065.544101030925, 5077.847664570068, 5080.060188865072, 5082.898342033139, 5084.872878178001, 6129.2032035835055, 6252.437280644764, 6279.686015699197, 6286.622802631857, 6294.339094395114, 1488.2186851902838, 1489.9404023838924, 1497.7977972973727, 1503.1131632336974, 1515.4241388272385, 948.9478078705599, 998.0219385002738, 1000.0799264676369, 1010.8433192855119, 1043.389617074005, 5881.0, 5927.644341339534, 5934.584579079509, 5936.28764548257, 5943.197668314809, 6350.428461438492, 6362.459190968727, 6362.713677884506, 6365.14070600463, 6367.0, 5923.259592550931, 5932.0, 5940.782139661359, 5942.70286485674, 5943.791967281211, 3404.4552871540436, 3422.19578399076, 3431.365197438482, 3439.94840077399, 3441.105312618687, 6552.213734351908, 6681.231658359351, 6709.6980635871505, 6729.25978142404, 6732.629705366252, 6475.870482590321, 6489.091527186198, 6520.967395163088, 6524.412802847766, 6527.11883895668, 6636.469082473391, 6679.5658282210525, 6690.899636505456, 6693.1298931138645, 6713.865722685519, 6320.1467801848, 6332.081848131903, 6341.619502829845, 6341.841453963688, 6342.90485642725, 6110.358412366638, 6290.0, 6292.433680968735, 6307.05394190875, 6323.588966717149, 6663.633500157344, 6685.498587606046, 6707.4969377297875, 6709.4632429404555, 6714.764983225564, 4338.154059958278, 4340.8697739067875, 4341.8263269470135, 4344.6089851913475, 4345.500267469281, 6353.047042943595, 6362.395572420613, 6364.331745166876, 6370.140031095742, 6372.267189273293, 6135.233095863017, 6183.319834818257, 6183.783567575113, 6186.566940314135, 6188.319284878569, 6030.713261272705, 6110.0, 6176.104464852661, 6181.0, 6182.350853160533, 6030.216071910623, 6050.697465126814, 6061.393860613904, 6068.696565171812, 6075.665838378932, 6196.690165491617, 6208.968955155376, 6212.0, 6213.347598502092, 6222.968885155546, 5927.644341339534, 6035.69821508914, 6044.063170208625, 6062.545309101747, 6077.088436734525], "unit": "score", "name": "prototype.html", "value": 4661.615999314764}, {"lowerIsBetter": false, "replicates": [819.9508029518225, 833.1501868094543, 834.2450082675178, 838.450814716361, 863.7754183912183, 13874.236916969563, 14007.789883151761, 14030.438782448702, 14050.156990580572, 14054.367553460093, 13256.403461844217, 13326.400311985959, 13333.266670333127, 13342.199468031924, 13362.465501379957, 820.6553247635992, 832.7376876283981, 833.72487079264, 834.4409245805294, 834.5368320582074, 657.562720790676, 805.2068712318362, 821.983560328793, 830.9875351869727, 835.2649668291895, 847.5846835050811, 851.3870013590205, 856.5588721808242, 857.1043259793499, 857.1899554920602, 851.6678495386805, 851.8083431227986, 851.8296340731847, 851.833892390984, 851.9616617252238, 510.15059925224455, 636.525788287724, 637.7767781276563, 645.880512105262, 647.3009150117862, 13827.170369777845, 13832.930835345758, 13834.0, 13847.792283115761, 13875.722485550232, 12610.180338278074, 12953.352332383438, 12997.675058123623, 13018.934905325508, 13396.86603133966, 10795.29830561011, 10850.945745271301, 11090.667279981613, 11117.777644447147, 11303.886961130447, 3683.410654295327, 3743.6630703236565, 3752.8686495972784, 3782.9621703782886, 3866.2074274773886, 50000.0, 50304.74847625739, 50433.495665043614, 50494.24258636124, 50595.22916697935, 10402.167826573856, 10505.369677819355, 10561.683149505527, 10694.679159625224, 10735.194860385502, 19235.4229373119, 19311.0, 19398.224071037283, 19427.708584371245, 19433.028348582513, 7532.209118042636, 7615.0, 7709.575973321521, 7760.18518055596, 7873.409494287951, 4236.9788151059665, 4259.446271984622, 4323.848665296699, 4325.697201195886, 4349.565043495689, 3195.1532843796413, 3198.648148703641, 3208.7593430492807, 3213.0360891732385, 3214.373197226565, 568.3009897825698, 580.3152280309191, 586.1676419484343, 586.633354153654, 593.6200831467864, 637.974481020754, 645.3772109913956, 660.7720336483906, 675.9019942108366, 689.2039694153261, 8150.470219435718, 8162.347012239006, 8224.794380140544, 8314.958425207835, 8368.874466883002, 511.93600799900014, 596.9492593129546, 636.59576169132, 651.1567520061532, 654.450261780107, 3835.6931445484292, 3863.8068096595057, 3896.12337224128, 3962.7622342659533, 4189.769562674082, 54029.729851350494, 55592.444075559535, 55602.72198639062, 55629.0, 55742.0, 49613.50386496089, 49892.0, 50620.0, 50767.23849142266, 50791.74604126956, 44009.339859902124, 44637.55362446334, 44932.3260151098, 45178.322325165806, 45929.31106033412, 7801.2198780121535, 7903.3677305816545, 8102.149274326347, 8162.0, 8166.224208700164, 34956.30087398187, 34998.0, 35022.47466287957, 35993.46009809907, 36153.63846361608, 41361.379579305736, 44093.77953110214, 44782.3282650767, 44909.775451123845, 45477.0, 9879.407235565888, 9964.651237206663, 11180.273282236629, 11523.654290371302, 11902.40487975615, 12209.328486933304, 12306.261624302571, 12440.937795310965, 12700.555480558505, 12700.618981430573, 11422.485988130387, 11451.656450306504, 11586.0, 11944.522219111486, 12224.083193760682, 10783.676489705322, 11520.193586449202, 11659.417029148679, 11763.941180294043, 12044.397780111134, 11607.245529040585, 11796.52813887435, 11860.76278474443, 11873.82189267179, 11954.462049207632, 9348.53257337144, 9398.95300523493, 9481.383710058824, 9620.615175393186, 9640.180584650383, 9016.098390161194, 9074.31942604294, 9162.541872906462, 9195.678151264674, 9917.702468925943], "unit": "score", "name": "yui.html", "value": 6367.273242881914}], "name": "dromaeo_css", "value": 6889.85960011778}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 110.0, 110.0, 110.0, 101.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 148.0, 170.0, 131.0, 156.0, 161.0, 137.0, 180.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 102.0, 105.0, 73.0, 75.0, 75.0, 109.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 93.0, 94.0, 93.0, 139.0, 93.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 73.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 83.0, 83.0, 82.0, 89.0, 82.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [125.0, 121.0, 116.0, 122.0, 115.0, 113.0, 113.0, 126.0, 117.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [162.0, 139.0, 155.0, 149.0, 149.0, 138.0, 146.0, 161.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 70.0, 69.0, 69.0, 67.0, 70.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1516.8000000000002}]} 02:44:28 INFO - Return code: 0 02:44:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:28 INFO - # TBPL SUCCESS # 02:44:28 INFO - Running post-action listener: _resource_record_post_action 02:44:28 INFO - Running post-run listener: _resource_record_post_run 02:44:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 543141888; Read time: 0; Write time: 628340 02:44:29 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 252358656; Read time: 0; Write time: 373008 02:44:29 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290721792; Read time: 0; Write time: 255332 02:44:29 INFO - Running post-run listener: _upload_blobber_files 02:44:29 INFO - Blob upload gear active. 02:44:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:44:29 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:44:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:44:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:31 INFO - (blobuploader) - INFO - Done attempting. 02:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:31 INFO - (blobuploader) - INFO - Done attempting. 02:44:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:31 INFO - Return code: 0 02:44:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:44:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3369fcc4107a32bfc21d997b35336df340aa918f33305d2c299449e4593affe35d33bb50023bc2261306fecd01775ca06b3d4cbabf00d13d5655d3227d7ca65c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6010f7440029663cbe5fe1ed8fe78bb0bec3f06a955e688c26a6efcff3658c2a125844e37545715b0f0c3795ab59ba04e7a0752da5b056a693fda052e3d586b0"} 02:44:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:44:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:44:31 INFO - Contents: 02:44:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3369fcc4107a32bfc21d997b35336df340aa918f33305d2c299449e4593affe35d33bb50023bc2261306fecd01775ca06b3d4cbabf00d13d5655d3227d7ca65c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6010f7440029663cbe5fe1ed8fe78bb0bec3f06a955e688c26a6efcff3658c2a125844e37545715b0f0c3795ab59ba04e7a0752da5b056a693fda052e3d586b0"} 02:44:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:31 INFO - Copying logs to upload dir... 02:44:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:44:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.845027 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-08 02:44:32.142380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:32.156658) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3369fcc4107a32bfc21d997b35336df340aa918f33305d2c299449e4593affe35d33bb50023bc2261306fecd01775ca06b3d4cbabf00d13d5655d3227d7ca65c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6010f7440029663cbe5fe1ed8fe78bb0bec3f06a955e688c26a6efcff3658c2a125844e37545715b0f0c3795ab59ba04e7a0752da5b056a693fda052e3d586b0"} build_url:https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009774 build_url: 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3369fcc4107a32bfc21d997b35336df340aa918f33305d2c299449e4593affe35d33bb50023bc2261306fecd01775ca06b3d4cbabf00d13d5655d3227d7ca65c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6010f7440029663cbe5fe1ed8fe78bb0bec3f06a955e688c26a6efcff3658c2a125844e37545715b0f0c3795ab59ba04e7a0752da5b056a693fda052e3d586b0"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:32.862874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:32.867275) ========= 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=6d15e502d8e29d5d2676d664000001c3-1457432638.64282-107225524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:32.884726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:44:32.885115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:44:32.903027) ========= ========= Total master_lag: 1.20 =========