builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1468477371.27 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.265754) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.266187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.266460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.280807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.281080) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:22:51-- 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% 45.8M=0s 2016-07-13 23:22:51 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.390100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.390424) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:51.439529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:51.439873) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:22:51,776 truncating revision to first 12 chars 2016-07-13 23:22:51,776 Setting DEBUG logging. 2016-07-13 23:22:51,776 attempt 1/10 2016-07-13 23:22:51,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:22:53,184 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=1.736157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:53.186374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:53.186745) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:53.187185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:53.187449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:53.194308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 23:22:53.194599) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:53 INFO - MultiFileLogger online at 20160713 23:22:53 in /builds/slave/test 23:22:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:22:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:53 INFO - {'append_to_log': False, 23:22:53 INFO - 'base_work_dir': '/builds/slave/test', 23:22:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:22:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:53 INFO - 'branch': 'Mozilla-Aurora', 23:22:53 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:53 INFO - 'config_files': ('talos/linux_config.py',), 23:22:53 INFO - 'default_actions': ('clobber', 23:22:53 INFO - 'read-buildbot-config', 23:22:53 INFO - 'download-and-extract', 23:22:53 INFO - 'populate-webroot', 23:22:53 INFO - 'create-virtualenv', 23:22:53 INFO - 'install', 23:22:53 INFO - 'run-tests'), 23:22:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:53 INFO - 'download_minidump_stackwalk': True, 23:22:53 INFO - 'download_symbols': 'ondemand', 23:22:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:53 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:53 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:53 INFO - 'installer_path': 'installer.exe', 23:22:53 INFO - 'log_level': 'info', 23:22:53 INFO - 'log_name': 'talos', 23:22:53 INFO - 'log_to_console': True, 23:22:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:53 INFO - 'opt_config_files': (), 23:22:53 INFO - 'pip_index': False, 23:22:53 INFO - 'sps_profile': False, 23:22:53 INFO - 'sps_profile_interval': 0, 23:22:53 INFO - 'suite': 'dromaeojs-e10s', 23:22:53 INFO - 'system_bits': '32', 23:22:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:53 INFO - 'title': 'talos-linux64-ix-064', 23:22:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:53 INFO - 'use_talos_json': True, 23:22:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:53 INFO - 'work_dir': 'build'} 23:22:53 INFO - ##### 23:22:53 INFO - ##### Running clobber step. 23:22:53 INFO - ##### 23:22:53 INFO - Running pre-action listener: _resource_record_pre_action 23:22:53 INFO - Running main action method: clobber 23:22:53 INFO - rmtree: /builds/slave/test/build 23:22:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:54 INFO - Running post-action listener: _resource_record_post_action 23:22:54 INFO - ##### 23:22:54 INFO - ##### Finished clobber step (success) 23:22:54 INFO - ##### 23:22:54 INFO - ##### 23:22:54 INFO - ##### Running read-buildbot-config step. 23:22:54 INFO - ##### 23:22:54 INFO - Running pre-action listener: _resource_record_pre_action 23:22:54 INFO - Running main action method: read_buildbot_config 23:22:54 INFO - Using buildbot properties: 23:22:54 INFO - { 23:22:54 INFO - "project": "", 23:22:54 INFO - "product": "firefox", 23:22:54 INFO - "script_repo_revision": "production", 23:22:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:22:54 INFO - "repository": "", 23:22:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:22:54 INFO - "buildid": "20160713152443", 23:22:54 INFO - "pgo_build": "True", 23:22:54 INFO - "basedir": "/builds/slave/test", 23:22:54 INFO - "buildnumber": 418, 23:22:54 INFO - "slavename": "talos-linux64-ix-064", 23:22:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:22:54 INFO - "platform": "ubuntu64_hw", 23:22:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:22:54 INFO - "branch": "mozilla-aurora", 23:22:54 INFO - "repo_path": "releases/mozilla-aurora", 23:22:54 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 23:22:54 INFO - "stage_platform": "linux64-pgo", 23:22:54 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 23:22:54 INFO - "slavebuilddir": "test" 23:22:54 INFO - } 23:22:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:22:54 INFO - Running post-action listener: _resource_record_post_action 23:22:54 INFO - ##### 23:22:54 INFO - ##### Finished read-buildbot-config step (success) 23:22:54 INFO - ##### 23:22:54 INFO - ##### 23:22:54 INFO - ##### Running download-and-extract step. 23:22:54 INFO - ##### 23:22:54 INFO - Running pre-action listener: _resource_record_pre_action 23:22:54 INFO - Running main action method: download_and_extract 23:22:54 INFO - mkdir: /builds/slave/test/build/tests 23:22: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')]} 23:22:54 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:22:54 INFO - Downloaded 1361 bytes. 23:22:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:54 INFO - Using the following test package requirements: 23:22:54 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:54 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:54 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:22:54 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'jsshell-linux-x86_64.zip'], 23:22:54 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:54 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:54 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:22:54 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:22:54 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:54 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:54 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:54 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22: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')]} 23:22:54 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:55 INFO - Downloaded 24491003 bytes. 23:22:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:22:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:22:57 INFO - Return code: 0 23:22:57 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:57 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:58 INFO - Downloaded 24491003 bytes. 23:22:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:22:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:22:59 INFO - Return code: 0 23:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:59 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:23:00 INFO - Downloaded 10833369 bytes. 23:23:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:23:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:23:00 INFO - Return code: 0 23:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:00 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:23:02 INFO - Downloaded 63642548 bytes. 23:23:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:02 INFO - mkdir: /builds/slave/test/properties 23:23:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:23:02 INFO - Writing to file /builds/slave/test/properties/build_url 23:23:02 INFO - Contents: 23:23:02 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:02 INFO - Running post-action listener: _resource_record_post_action 23:23:02 INFO - Running post-action listener: set_extra_try_arguments 23:23:02 INFO - ##### 23:23:02 INFO - ##### Finished download-and-extract step (success) 23:23:02 INFO - ##### 23:23:02 INFO - ##### 23:23:02 INFO - ##### Running populate-webroot step. 23:23:02 INFO - ##### 23:23:02 INFO - Running pre-action listener: _resource_record_pre_action 23:23:02 INFO - Running main action method: populate_webroot 23:23:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:23:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:23:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:23:02 INFO - '--tppagecycles', 23:23:02 INFO - '7'], 23:23:02 INFO - 'tests': ['tsvgm']}}, 23:23:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:23:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:23:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:23:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:23:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['damp', 'tps']}, 23:23:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'tests': ['damp', 'tps']}, 23:23:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['dromaeo_dom']}, 23:23:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:23:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'other-e10s': {'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['a11yr', 23:23:02 INFO - 'ts_paint', 23:23:02 INFO - 'tpaint', 23:23:02 INFO - 'sessionrestore', 23:23:02 INFO - 'sessionrestore_no_auto_restore', 23:23:02 INFO - 'tabpaint']}, 23:23:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['tsvgx', 23:23:02 INFO - 'tsvgr_opacity', 23:23:02 INFO - 'tart', 23:23:02 INFO - 'tscrollx', 23:23:02 INFO - 'cart']}, 23:23:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:23:02 INFO - 'tsvgr_opacity', 23:23:02 INFO - 'tart', 23:23:02 INFO - 'tscrollx', 23:23:02 INFO - 'cart']}, 23:23:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'talos_options': ['--disable-e10s'], 23:23:02 INFO - 'tests': ['tp5o']}, 23:23:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'tests': ['tp5o']}, 23:23:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'talos_options': ['--disable-e10s', 23:23:02 INFO - '--xperf_path', 23:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:02 INFO - 'tests': ['tp5n']}, 23:23:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:02 INFO - 'talos_options': ['--xperf_path', 23:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:02 INFO - 'tests': ['tp5n']}}, 23:23:02 INFO - 'talos.zip': {'path': '', 23:23:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:23:02 INFO - Running post-action listener: _resource_record_post_action 23:23:02 INFO - ##### 23:23:02 INFO - ##### Finished populate-webroot step (success) 23:23:02 INFO - ##### 23:23:02 INFO - ##### 23:23:02 INFO - ##### Running create-virtualenv step. 23:23:02 INFO - ##### 23:23:02 INFO - Running pre-action listener: _resource_record_pre_action 23:23:02 INFO - Running main action method: create_virtualenv 23:23:02 INFO - Creating virtualenv /builds/slave/test/build/venv 23:23:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:23:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:23:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:23:03 INFO - Using real prefix '/usr' 23:23:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:23:03 INFO - Installing distribute.............................................................................................................................................................................................done. 23:23:05 INFO - Installing pip.................done. 23:23:05 INFO - Return code: 0 23:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:05 INFO - Running command: ['/builds/slave/test/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/build 23:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:23:05 INFO - Using env: {'DISPLAY': ':0', 23:23:05 INFO - 'HOME': '/home/cltbld', 23:23:05 INFO - 'LANG': 'en_US.UTF-8', 23:23:05 INFO - 'LANGUAGE': 'en_US:en', 23:23:05 INFO - 'LOGNAME': 'cltbld', 23:23:05 INFO - 'MAIL': '/var/mail/cltbld', 23:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:05 INFO - 'MOZ_NO_REMOTE': '1', 23:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:05 INFO - 'NO_EM_RESTART': '1', 23:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:05 INFO - 'PWD': '/builds/slave/test', 23:23:05 INFO - 'SHELL': '/bin/bash', 23:23:05 INFO - 'SHLVL': '1', 23:23:05 INFO - 'TERM': 'linux', 23:23:05 INFO - 'TMOUT': '86400', 23:23:05 INFO - 'USER': 'cltbld', 23:23:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:05 INFO - '_': '/tools/buildbot/bin/python'} 23:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:23:05 INFO - Cleaning up... 23:23:05 INFO - Return code: 0 23:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:05 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 23:23:05 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 23:23:05 INFO - Using env: {'DISPLAY': ':0', 23:23:05 INFO - 'HOME': '/home/cltbld', 23:23:05 INFO - 'LANG': 'en_US.UTF-8', 23:23:05 INFO - 'LANGUAGE': 'en_US:en', 23:23:05 INFO - 'LOGNAME': 'cltbld', 23:23:05 INFO - 'MAIL': '/var/mail/cltbld', 23:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:05 INFO - 'MOZ_NO_REMOTE': '1', 23:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:05 INFO - 'NO_EM_RESTART': '1', 23:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:05 INFO - 'PWD': '/builds/slave/test', 23:23:05 INFO - 'SHELL': '/bin/bash', 23:23:05 INFO - 'SHLVL': '1', 23:23:05 INFO - 'TERM': 'linux', 23:23:05 INFO - 'TMOUT': '86400', 23:23:05 INFO - 'USER': 'cltbld', 23:23:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:05 INFO - '_': '/tools/buildbot/bin/python'} 23:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:06 INFO - Downloading/unpacking psutil>=3.1.1 23:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:08 INFO - Installing collected packages: psutil 23:23:08 INFO - Running setup.py install for psutil 23:23:08 INFO - building 'psutil._psutil_linux' extension 23:23:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:23:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:23:08 INFO - building 'psutil._psutil_posix' extension 23:23:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:23:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:08 INFO - Successfully installed psutil 23:23:08 INFO - Cleaning up... 23:23:08 INFO - Return code: 0 23:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:08 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 23:23:08 INFO - Copy/paste: /builds/slave/test/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.3 23:23:08 INFO - Using env: {'DISPLAY': ':0', 23:23:08 INFO - 'HOME': '/home/cltbld', 23:23:08 INFO - 'LANG': 'en_US.UTF-8', 23:23:08 INFO - 'LANGUAGE': 'en_US:en', 23:23:08 INFO - 'LOGNAME': 'cltbld', 23:23:08 INFO - 'MAIL': '/var/mail/cltbld', 23:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:08 INFO - 'MOZ_NO_REMOTE': '1', 23:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:08 INFO - 'NO_EM_RESTART': '1', 23:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:08 INFO - 'PWD': '/builds/slave/test', 23:23:08 INFO - 'SHELL': '/bin/bash', 23:23:08 INFO - 'SHLVL': '1', 23:23:08 INFO - 'TERM': 'linux', 23:23:08 INFO - 'TMOUT': '86400', 23:23:08 INFO - 'USER': 'cltbld', 23:23:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:08 INFO - '_': '/tools/buildbot/bin/python'} 23:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:23:10 INFO - Installing collected packages: mozsystemmonitor 23:23:10 INFO - Running setup.py install for mozsystemmonitor 23:23:10 INFO - Successfully installed mozsystemmonitor 23:23:10 INFO - Cleaning up... 23:23:10 INFO - Return code: 0 23:23:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:10 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 23:23:10 INFO - Copy/paste: /builds/slave/test/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==2.5.1 23:23:10 INFO - Using env: {'DISPLAY': ':0', 23:23:10 INFO - 'HOME': '/home/cltbld', 23:23:10 INFO - 'LANG': 'en_US.UTF-8', 23:23:10 INFO - 'LANGUAGE': 'en_US:en', 23:23:10 INFO - 'LOGNAME': 'cltbld', 23:23:10 INFO - 'MAIL': '/var/mail/cltbld', 23:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:10 INFO - 'MOZ_NO_REMOTE': '1', 23:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:10 INFO - 'NO_EM_RESTART': '1', 23:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:10 INFO - 'PWD': '/builds/slave/test', 23:23:10 INFO - 'SHELL': '/bin/bash', 23:23:10 INFO - 'SHLVL': '1', 23:23:10 INFO - 'TERM': 'linux', 23:23:10 INFO - 'TMOUT': '86400', 23:23:10 INFO - 'USER': 'cltbld', 23:23:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:10 INFO - '_': '/tools/buildbot/bin/python'} 23:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:11 INFO - Downloading/unpacking jsonschema==2.5.1 23:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:23:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - Downloading functools32-3.2.3-2.tar.gz 23:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:23:13 INFO - warning: no files found matching '*.txt' 23:23:13 INFO - no previously-included directories found matching 'build' 23:23:13 INFO - no previously-included directories found matching 'dist' 23:23:13 INFO - no previously-included directories found matching '.git*' 23:23:13 INFO - Installing collected packages: jsonschema, functools32 23:23:13 INFO - Running setup.py install for functools32 23:23:13 INFO - warning: no files found matching '*.txt' 23:23:13 INFO - no previously-included directories found matching 'build' 23:23:13 INFO - no previously-included directories found matching 'dist' 23:23:13 INFO - no previously-included directories found matching '.git*' 23:23:13 INFO - Successfully installed jsonschema functools32 23:23:13 INFO - Cleaning up... 23:23:13 INFO - Return code: 0 23:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:13 INFO - Running command: ['/builds/slave/test/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/build 23:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:23:13 INFO - Using env: {'DISPLAY': ':0', 23:23:13 INFO - 'HOME': '/home/cltbld', 23:23:13 INFO - 'LANG': 'en_US.UTF-8', 23:23:13 INFO - 'LANGUAGE': 'en_US:en', 23:23:13 INFO - 'LOGNAME': 'cltbld', 23:23:13 INFO - 'MAIL': '/var/mail/cltbld', 23:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:13 INFO - 'MOZ_NO_REMOTE': '1', 23:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:13 INFO - 'NO_EM_RESTART': '1', 23:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:13 INFO - 'PWD': '/builds/slave/test', 23:23:13 INFO - 'SHELL': '/bin/bash', 23:23:13 INFO - 'SHLVL': '1', 23:23:13 INFO - 'TERM': 'linux', 23:23:13 INFO - 'TMOUT': '86400', 23:23:13 INFO - 'USER': 'cltbld', 23:23:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:13 INFO - '_': '/tools/buildbot/bin/python'} 23:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - Downloading docopt-0.6.1.tar.gz 23:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:16 INFO - Running setup.py install for blobuploader 23:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:16 INFO - Running setup.py install for requests 23:23:16 INFO - Running setup.py install for docopt 23:23:16 INFO - Successfully installed blobuploader requests docopt 23:23:16 INFO - Cleaning up... 23:23:17 INFO - Return code: 0 23:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 23:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:17 INFO - Using env: {'DISPLAY': ':0', 23:23:17 INFO - 'HOME': '/home/cltbld', 23:23:17 INFO - 'LANG': 'en_US.UTF-8', 23:23:17 INFO - 'LANGUAGE': 'en_US:en', 23:23:17 INFO - 'LOGNAME': 'cltbld', 23:23:17 INFO - 'MAIL': '/var/mail/cltbld', 23:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:17 INFO - 'MOZ_NO_REMOTE': '1', 23:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:17 INFO - 'NO_EM_RESTART': '1', 23:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:17 INFO - 'PWD': '/builds/slave/test', 23:23:17 INFO - 'SHELL': '/bin/bash', 23:23:17 INFO - 'SHLVL': '1', 23:23:17 INFO - 'TERM': 'linux', 23:23:17 INFO - 'TMOUT': '86400', 23:23:17 INFO - 'USER': 'cltbld', 23:23:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:17 INFO - '_': '/tools/buildbot/bin/python'} 23:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:17 INFO - Running setup.py (path:/tmp/pip-ZOHc4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:17 INFO - Running setup.py (path:/tmp/pip-Cu5nNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:17 INFO - Running setup.py (path:/tmp/pip-pWT5cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:17 INFO - Running setup.py (path:/tmp/pip-ilS_sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:17 INFO - Running setup.py (path:/tmp/pip-pnfpNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:17 INFO - Running setup.py (path:/tmp/pip-rIWpny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:17 INFO - Running setup.py (path:/tmp/pip-6bH1wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:17 INFO - Running setup.py (path:/tmp/pip-yFatkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:17 INFO - Running setup.py (path:/tmp/pip-oaHbu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:17 INFO - Running setup.py (path:/tmp/pip-oYvUoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:17 INFO - Running setup.py (path:/tmp/pip-xuv5qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:18 INFO - Running setup.py (path:/tmp/pip-yRQoqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:18 INFO - Running setup.py (path:/tmp/pip-lK_VI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:18 INFO - Running setup.py (path:/tmp/pip-KPoGE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:18 INFO - Running setup.py (path:/tmp/pip-D0Y22g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:18 INFO - Running setup.py (path:/tmp/pip-dHVYUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:18 INFO - Running setup.py (path:/tmp/pip-odhDxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:18 INFO - Running setup.py install for manifestparser 23:23:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:18 INFO - Running setup.py install for mozcrash 23:23:18 INFO - Running setup.py install for mozdebug 23:23:18 INFO - Running setup.py install for mozdevice 23:23:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:18 INFO - Running setup.py install for mozfile 23:23:18 INFO - Running setup.py install for mozhttpd 23:23:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozinfo 23:23:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozInstall 23:23:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozleak 23:23:19 INFO - Running setup.py install for mozlog 23:23:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for moznetwork 23:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozprocess 23:23:19 INFO - Running setup.py install for mozprofile 23:23:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozrunner 23:23:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:19 INFO - Running setup.py install for mozscreenshot 23:23:20 INFO - Running setup.py install for moztest 23:23:20 INFO - Running setup.py install for mozversion 23:23:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:20 INFO - Cleaning up... 23:23:20 INFO - Return code: 0 23:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 23:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:20 INFO - Using env: {'DISPLAY': ':0', 23:23:20 INFO - 'HOME': '/home/cltbld', 23:23:20 INFO - 'LANG': 'en_US.UTF-8', 23:23:20 INFO - 'LANGUAGE': 'en_US:en', 23:23:20 INFO - 'LOGNAME': 'cltbld', 23:23:20 INFO - 'MAIL': '/var/mail/cltbld', 23:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:20 INFO - 'MOZ_NO_REMOTE': '1', 23:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:20 INFO - 'NO_EM_RESTART': '1', 23:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:20 INFO - 'PWD': '/builds/slave/test', 23:23:20 INFO - 'SHELL': '/bin/bash', 23:23:20 INFO - 'SHLVL': '1', 23:23:20 INFO - 'TERM': 'linux', 23:23:20 INFO - 'TMOUT': '86400', 23:23:20 INFO - 'USER': 'cltbld', 23:23:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:20 INFO - '_': '/tools/buildbot/bin/python'} 23:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:20 INFO - Running setup.py (path:/tmp/pip-YCmx58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:20 INFO - Running setup.py (path:/tmp/pip-7p4n_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:20 INFO - Running setup.py (path:/tmp/pip-QtNAZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:20 INFO - Running setup.py (path:/tmp/pip-CMeCZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:20 INFO - Running setup.py (path:/tmp/pip-beabTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:20 INFO - Running setup.py (path:/tmp/pip-ffZcKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:20 INFO - Running setup.py (path:/tmp/pip-mPT8cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:20 INFO - Running setup.py (path:/tmp/pip-x5SLZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:21 INFO - Running setup.py (path:/tmp/pip-DY4rIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:21 INFO - Running setup.py (path:/tmp/pip-o0Bb6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:21 INFO - Running setup.py (path:/tmp/pip-lnwiuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:21 INFO - Running setup.py (path:/tmp/pip-N3n9gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:21 INFO - Running setup.py (path:/tmp/pip-Ty5Ykk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:21 INFO - Running setup.py (path:/tmp/pip-0zuCFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:21 INFO - Running setup.py (path:/tmp/pip-ba8lTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:21 INFO - Running setup.py (path:/tmp/pip-FxQRTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:21 INFO - Running setup.py (path:/tmp/pip-653lLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:23 INFO - Downloading blessings-1.6.tar.gz 23:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:23 INFO - Installing collected packages: blessings 23:23:23 INFO - Running setup.py install for blessings 23:23:23 INFO - Successfully installed blessings 23:23:23 INFO - Cleaning up... 23:23:23 INFO - Return code: 0 23:23:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:24 INFO - Reading from file tmpfile_stdout 23:23:24 INFO - Current package versions: 23:23:24 INFO - argparse == 1.2.1 23:23:24 INFO - blessings == 1.6 23:23:24 INFO - blobuploader == 1.2.4 23:23:24 INFO - docopt == 0.6.1 23:23:24 INFO - functools32 == 3.2.3-2 23:23:24 INFO - jsonschema == 2.5.1 23:23:24 INFO - manifestparser == 1.1 23:23:24 INFO - mozInstall == 1.12 23:23:24 INFO - mozcrash == 0.17 23:23:24 INFO - mozdebug == 0.1 23:23:24 INFO - mozdevice == 0.48 23:23:24 INFO - mozfile == 1.2 23:23:24 INFO - mozhttpd == 0.7 23:23:24 INFO - mozinfo == 0.9 23:23:24 INFO - mozleak == 0.1 23:23:24 INFO - mozlog == 3.2 23:23:24 INFO - moznetwork == 0.27 23:23:24 INFO - mozprocess == 0.23 23:23:24 INFO - mozprofile == 0.28 23:23:24 INFO - mozrunner == 6.12 23:23:24 INFO - mozscreenshot == 0.1 23:23:24 INFO - mozsystemmonitor == 0.3 23:23:24 INFO - moztest == 0.7 23:23:24 INFO - mozversion == 1.4 23:23:24 INFO - psutil == 3.1.1 23:23:24 INFO - requests == 1.2.3 23:23:24 INFO - wsgiref == 0.1.2 23:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 23:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:24 INFO - Using env: {'DISPLAY': ':0', 23:23:24 INFO - 'HOME': '/home/cltbld', 23:23:24 INFO - 'LANG': 'en_US.UTF-8', 23:23:24 INFO - 'LANGUAGE': 'en_US:en', 23:23:24 INFO - 'LOGNAME': 'cltbld', 23:23:24 INFO - 'MAIL': '/var/mail/cltbld', 23:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:24 INFO - 'MOZ_NO_REMOTE': '1', 23:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:24 INFO - 'NO_EM_RESTART': '1', 23:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:24 INFO - 'PWD': '/builds/slave/test', 23:23:24 INFO - 'SHELL': '/bin/bash', 23:23:24 INFO - 'SHLVL': '1', 23:23:24 INFO - 'TERM': 'linux', 23:23:24 INFO - 'TMOUT': '86400', 23:23:24 INFO - 'USER': 'cltbld', 23:23:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:24 INFO - '_': '/tools/buildbot/bin/python'} 23:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:23:24 INFO - Cleaning up... 23:23:24 INFO - Return code: 0 23:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:24 INFO - Running command: ['/builds/slave/test/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/build 23:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:23:24 INFO - Using env: {'DISPLAY': ':0', 23:23:24 INFO - 'HOME': '/home/cltbld', 23:23:24 INFO - 'LANG': 'en_US.UTF-8', 23:23:24 INFO - 'LANGUAGE': 'en_US:en', 23:23:24 INFO - 'LOGNAME': 'cltbld', 23:23:24 INFO - 'MAIL': '/var/mail/cltbld', 23:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:24 INFO - 'MOZ_NO_REMOTE': '1', 23:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:24 INFO - 'NO_EM_RESTART': '1', 23:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:24 INFO - 'PWD': '/builds/slave/test', 23:23:24 INFO - 'SHELL': '/bin/bash', 23:23:24 INFO - 'SHLVL': '1', 23:23:24 INFO - 'TERM': 'linux', 23:23:24 INFO - 'TMOUT': '86400', 23:23:24 INFO - 'USER': 'cltbld', 23:23:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:24 INFO - '_': '/tools/buildbot/bin/python'} 23:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:23:24 INFO - Cleaning up... 23:23:24 INFO - Return code: 0 23:23:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fb5ced6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:23:24 INFO - Running command: ['/builds/slave/test/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/build 23:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:23:24 INFO - Using env: {'DISPLAY': ':0', 23:23:24 INFO - 'HOME': '/home/cltbld', 23:23:24 INFO - 'LANG': 'en_US.UTF-8', 23:23:24 INFO - 'LANGUAGE': 'en_US:en', 23:23:24 INFO - 'LOGNAME': 'cltbld', 23:23:24 INFO - 'MAIL': '/var/mail/cltbld', 23:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:24 INFO - 'MOZ_NO_REMOTE': '1', 23:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:24 INFO - 'NO_EM_RESTART': '1', 23:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:24 INFO - 'PWD': '/builds/slave/test', 23:23:24 INFO - 'SHELL': '/bin/bash', 23:23:24 INFO - 'SHLVL': '1', 23:23:24 INFO - 'TERM': 'linux', 23:23:24 INFO - 'TMOUT': '86400', 23:23:24 INFO - 'USER': 'cltbld', 23:23:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:24 INFO - '_': '/tools/buildbot/bin/python'} 23:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:24 INFO - Downloading/unpacking flake8 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:23:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:23:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:27 INFO - no previously-included directories found matching 'docs/_build' 23:23:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:23:27 INFO - Running setup.py install for pep8 23:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:27 INFO - no previously-included directories found matching 'docs/_build' 23:23:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:23:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:23:27 INFO - Cleaning up... 23:23:27 INFO - Return code: 0 23:23:27 INFO - Running post-action listener: _resource_record_post_action 23:23:27 INFO - Running post-action listener: _start_resource_monitoring 23:23:27 INFO - Starting resource monitoring. 23:23:27 INFO - ##### 23:23:27 INFO - ##### Finished create-virtualenv step (success) 23:23:27 INFO - ##### 23:23:27 INFO - ##### 23:23:27 INFO - ##### Running install step. 23:23:27 INFO - ##### 23:23:27 INFO - Running pre-action listener: _resource_record_pre_action 23:23:27 INFO - Running main action method: install 23:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:27 INFO - Reading from file tmpfile_stdout 23:23:27 INFO - Detecting whether we're running mozinstall >=1.0... 23:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:23:27 INFO - Reading from file tmpfile_stdout 23:23:27 INFO - Output received: 23:23:27 INFO - Usage: mozinstall [options] installer 23:23:27 INFO - Options: 23:23:27 INFO - -h, --help show this help message and exit 23:23:27 INFO - -d DEST, --destination=DEST 23:23:27 INFO - Directory to install application into. [default: 23:23:27 INFO - "/builds/slave/test"] 23:23:27 INFO - --app=APP Application being installed. [default: firefox] 23:23:27 INFO - mkdir: /builds/slave/test/build/application 23:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:23:43 INFO - Reading from file tmpfile_stdout 23:23:43 INFO - Output received: 23:23:43 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:43 INFO - Running post-action listener: _resource_record_post_action 23:23:43 INFO - ##### 23:23:43 INFO - ##### Finished install step (success) 23:23:43 INFO - ##### 23:23:43 INFO - ##### 23:23:43 INFO - ##### Running run-tests step. 23:23:43 INFO - ##### 23:23:43 INFO - Running pre-action listener: _resource_record_pre_action 23:23:43 INFO - Running main action method: run_tests 23:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:43 INFO - Python 2.7.3 23:23:43 INFO - Return code: 0 23:23:43 INFO - grabbing minidump binary from tooltool 23:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:43 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f1c0>, '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 0x1f800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f80550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:23:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:23:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:23:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:43 INFO - Return code: 0 23:23:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:23:44 INFO - Return code: 0 23:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:23:44 INFO - Using env: {'DISPLAY': ':0', 23:23:44 INFO - 'HOME': '/home/cltbld', 23:23:44 INFO - 'LANG': 'en_US.UTF-8', 23:23:44 INFO - 'LANGUAGE': 'en_US:en', 23:23:44 INFO - 'LOGNAME': 'cltbld', 23:23:44 INFO - 'MAIL': '/var/mail/cltbld', 23:23:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:44 INFO - 'MOZ_NO_REMOTE': '1', 23:23:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:44 INFO - 'NO_EM_RESTART': '1', 23:23:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:44 INFO - 'PWD': '/builds/slave/test', 23:23:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:44 INFO - 'SHELL': '/bin/bash', 23:23:44 INFO - 'SHLVL': '1', 23:23:44 INFO - 'TERM': 'linux', 23:23:44 INFO - 'TMOUT': '86400', 23:23:44 INFO - 'USER': 'cltbld', 23:23:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869', 23:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:44 INFO - '_': '/tools/buildbot/bin/python'} 23:23:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:23:44 INFO - mozversion application_buildid: 20160713152443 23:23:44 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:23:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:44 INFO - mozversion application_name: Firefox 23:23:44 INFO - mozversion application_remotingname: firefox-dev 23:23:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:44 INFO - mozversion application_vendor: Mozilla 23:23:44 INFO - mozversion application_version: 49.0a2 23:23:44 INFO - mozversion platform_buildid: 20160713152443 23:23:44 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:44 INFO - mozversion platform_version: 49.0a2 23:23:44 INFO - using testdate: 1468477424 23:23:44 INFO - actual date: 1468477424 23:23:44 INFO - starting webserver on 'localhost:46335' 23:23:44 INFO - SUITE-START | Running 2 tests 23:23:44 INFO - TEST-START | dromaeo_css 23:23:44 INFO - operating with platform_type : linux_ 23:23:44 INFO - Initialising browser for dromaeo_css test... 23:23:44 INFO - TEST-INFO | started process 21051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiar0LH/profile http://localhost:46335/getInfo.html) 23:23:50 INFO - PROCESS | 21051 | __metrics Screen width/height:1600/1200 23:23:50 INFO - PROCESS | 21051 | colorDepth:24 23:23:50 INFO - PROCESS | 21051 | Browser inner width/height: 1024/697 23:23:50 INFO - PROCESS | 21051 | __metrics 23:23:50 ERROR - PROCESS | 21051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:23:51 INFO - TEST-INFO | 21051: exit 0 23:23:51 INFO - Browser initialized. 23:23:51 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:51 INFO - TEST-INFO | started process 21186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiar0LH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:03 INFO - PROCESS | 21186 | RSS: Main: 156049408 23:24:03 INFO - PROCESS | 21186 | 23:24:53 INFO - PROCESS | 21186 | 1468477493204 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:27:01 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46335/tests/dromaeo/cssquery-ext.html) 23:27:02 INFO - PROCESS | 21186 | RSS: Main: 159621120 23:27:02 INFO - PROCESS | 21186 | 23:30:04 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-ext.html (next: http://localhost:46335/tests/dromaeo/cssquery-jquery.html) 23:30:04 INFO - PROCESS | 21186 | RSS: Main: 157691904 23:30:04 INFO - PROCESS | 21186 | 23:33:06 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46335/tests/dromaeo/cssquery-mootools.html) 23:33:07 INFO - PROCESS | 21186 | RSS: Main: 157556736 23:33:07 INFO - PROCESS | 21186 | 23:36:09 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46335/tests/dromaeo/cssquery-prototype.html) 23:36:09 INFO - PROCESS | 21186 | RSS: Main: 156598272 23:36:09 INFO - PROCESS | 21186 | 23:39:12 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46335/tests/dromaeo/cssquery-yui.html) 23:39:12 INFO - PROCESS | 21186 | RSS: Main: 158883840 23:39:12 INFO - PROCESS | 21186 | 23:42:14 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:46335/tests/dromaeo/cssquery-yui.html (next: http://localhost:46335/tests/dromaeo/cssquery-dojo.html) 23:42:15 INFO - PROCESS | 21186 | RSS: Main: 159387648 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | __start_tp_report 23:42:15 INFO - PROCESS | 21186 | _x_x_mozilla_page_load 23:42:15 INFO - PROCESS | 21186 | _x_x_mozilla_page_load_details 23:42:15 INFO - PROCESS | 21186 | |i|pagename|runs| 23:42:15 INFO - PROCESS | 21186 | |0;dojo.html;3330.200751819564;3331.850066746996;3351.614564325102;3366.444536651453;3376.139084533442;5573.637713548622;5578.358488773787;5596.076647353182;5596.132599447087;5599.580031497633;5575.107982722765;5622.212890195376;5634.295713035871;5640.04119299719;5647.8588035299135;5066.97466512667;5133.948660513403;5168.069747445458;5189.766460509286;5220.530152286294;5014.072396606622;5087.872803179913;5196.402413722413;5233.633645644806;5278.577713782907;5166.8708282293055;5168.173092305232;5168.664036837612;5188.92216616751;5199.038177937075;5147.330846989905;5156.58747300217;5242.55438287746;5253.106971814801;5258.39528454225;5096.286519887219;5148.716820574867;5230.3985041719925;5232.555232805216;5251.159814429711;5380.946190538084;5414.83755487336;5425.701586412746;5431.592630552725;5528.032594295983;5973.940260597382;6013.51891848651;6019.337872833985;6023.939760602381;6025.487833534155;5848.883022339572;6039.245094363205;6051.152838602599;6052.455279024909;6076.361981991916;5589;5623.775048998035;5627.043402621564;5675.772969081232;5709.05800542914;6147.200863887666;6174.043023331391;6179.28938172107;6207.472364849038;6224.315325314212;5832.883342333214;5893;5949.196858424144;5976.312724036705;5976.581639285295;5994.6403215807195;6106.023036314168;6110.083487476914;6110.572259941761;6138.754449821957;6036.396360364016;6049;6072.089186621954;6078.969605151946;6089.939100609025;5817.88364232713;5928.614640048383;5933.110033494924;6066.66633335162;6071.7571297147615;4626.21354369758;4639.048994956026;4645.140648979882;4669.463011753692;4674.69614475058;4125.628693417607;4138.089620283533;4155.231282212801;4174.3947127666925;4199.118185181085;5737.5983681141915;5765.769369225268;5773.942260577424;5839.386864379264;5850.795222167204;5910.763569457174;5986.461218490357;6026.578139530191;6028.3971602839365;6130.816075517741;5850.912236316459;5859.531237501075;5862.677552734641;5863.179154918314;5863.970680146572;5064.544191022752;5135.845924622267;5172.9741351293005;5177.534021938043;5216.817411390583;6331.398517140864;6357.268914074848;6359.7456101755415;6366.77716279928;6386.10594516768;5907.556933229939;6132.2947860996555;6142.262928448615;6144.754209831557;6147.293061297829;6164.506839452923;6187.566870319034;6203.689815509297;6318.273398559225;6322.083297921868;5987.550933679904;5997.820065398045;6003.849903752266;6032.8793424132145;6038.909416358671;5919.852003699942;6000.759969601167;6079.452849243589;6092.969535152296;6093.360197179232;5866.765329386777;5978.133170690313;5982.521398288213;5987.34139244674;6014.428629280212;5931.584789064724;5944.0489521678055;5954.225950626391;5974.342822289458;5986.042233242661;5654.236678048411;5695.288088988877;5705.429457054427;5857.502112320501;5909.6158749681135;5812.21535092757;5914.526837853047;5921.5558833086825;5923.940760592339;5932.406759324033;5766.048601980626;5788.450097240755;5803.129530570448;5803.448672376117;5804.303483581997 23:42:15 INFO - PROCESS | 21186 | |1;ext.html;587.5798803855246;623.1960770605918;626.9123071471;635.6662752055171;645.2869579115077;34086.31827363451;37748.62251377489;45744.31383529246;46603.533964660346;46738.76630616851;47718.28422573664;48065;48287.27569086466;48546.27180592294;48660;9040.773980650487;9234.492102934337;9249.213816825579;9255.305852061123;9275.721728348126;9123.406978546407;9218.308626852979;9234.86147707785;9234.907650923473;9235.861462078074;9229.03095175007;9280.628774848998;9304.209142222886;9322.62709491623;9349.906500934972;9203.585838637277;9235.722928312127;9268.536573171348;9271.490068046254;9289.674861379854;9161.862572061424;9185.12741289583;9188.448693078437;9236.076392360777;9239.029901860342;43717.34423983643;44169.55830441687;44233;44450;44545.55454445446;3800.1449673823445;4356.281213599752;4453.777311134463;4538.29656403258;4596.03483268514;33759.6624033759;33823.661763382544;34125.65874341274;35130.82434587836;35365;4389.209942210401;4455.398521199661;4462.59836614703;4563.133004729091;4696.107739529479;384391;385276;386670;387746;389196.05401973095;37876.62123378786;63710.68144659247;63972;64191;64268;38930.610693893264;40200.195996080496;41008.1798364037;41287.793561032006;41382.58617413847;15138;15366.846331536764;15381.077135371914;15382.3077961492;15401.229938503255;12336.321502317458;12476.500939962481;12534.81197782034;12535.185212961129;12554.246745195134;9245.260379169651;9286.95356523213;9326.160645541933;9378.5779639915;9390.248780097576;3491.5984661764223;3508.929821403609;3530.8411121499594;3549.4853246279145;3616.439451884962;1017.623479312659;1059.7191744187796;1106.8616422947132;1177.105399896068;1181.580538908675;30573.723237182745;32068.83965580204;32332;32739.67260327414;32821;1123.584273818676;1139.6751925701135;1150.4017910686396;1189.4944648524342;1302.2577131035218;16696.66606667884;16829.939733637413;16925;16958.491245262663;17067.40264090751;500518;551797;557097;557113;565128;59598.40401596015;60246.39753602495;60267.69866150641;60326.69836650789;60600.39399606036;1467.882569394446;1468.8971771976073;1476.217604669527;1480.9629759256104;1484.599158227294;33722.83138584292;34179.82910085434;34268.48597270993;34445.82777086098;34460.82769586136;57436;58418.70790646019;58493;58559.121613176685;58633.12050319163;491258;492581;496107;498471;499689;31614;32008.199795005312;32180;32182.517262240617;32232.516512252805;51565.48434515607;52598;52637;53092.734536328615;53467;43141.784291078344;43776.343354849065;44241.230350785605;44661.77669111764;45327;42727.145457091305;42835;43560;44673.55326446694;44962.77518612386;42405.57594424016;43804.123917522105;43978.780106099264;44162.55837441584;44436.555634444536;38333.42499862448;38668.41997370098;44642.10715785731;48776.75611622061;50325.74837125791;33657.495137573445;35632;36155;36203.27593448169;36556 23:42:15 INFO - PROCESS | 21186 | |2;jquery.html;415.2442554550719;421.28171467647655;425.81902691356174;427.1584977594138;440.14611653392416;18511.629767404662;19812.40562783117;20465.590688186247;21497.355079347646;21516.246931357404;16748.413805516808;17120.229589668463;17138.485845424628;17226;17284;5571.749271282782;5699.059655156904;5723.284589426322;5733;5814.534837213034;5656.2364080849175;5673.744681489343;5696.8860622787515;5707.686077265748;5711.343195532525;5458.727063646822;5762.135679648065;5766.0486019806685;5769.076947688371;5776.018076926933;5523.6685798851795;5703.914441283384;5709.71451427429;5721.170430287606;5733.168690539869;5648;5648.096304591246;5704.800331988402;5716.914246286309;5719.227904232958;15280.235988200657;15282.31229594671;15287.38850445992;15296.541103766906;17424.12879356027;2268.3421807675754;2382.321038504018;2397.29279862441;2446.9600419821504;2548.095426123718;10111.898881011242;10141.695749127539;10467;10505.054545090901;10591.25861189717;1980.4949737816764;2058;2085.0721428964116;2102.516421223112;2149.5163588192686;83662.16337836605;85113.14886851114;87258.12741872563;87395;88028;11422.714432139262;11657.941710291394;11795.29228246308;11798.410079496163;11893.40532973348;15944.2825072872;16472.670546589;16498.34006639745;16510.17449127563;16630.58423539397;8261;8267.875981860278;8284.751457456287;8314.501129932223;8464;7853.175416581291;7875.488093274033;7880.172581878935;7909.446338756347;8004.239597238369;4933.062718083553;5092.465291144451;5108.259302401206;5174;5208.921866172011;1914.4735197820432;1948.6102779443884;1960.7058941158941;1985.6525108106023;1988.443235893952;958.5494817435793;1015.9644412445529;1057.2757661002238;1078.1428764132534;1088.363307465126;19220.03899805004;19751.703724444145;19791.257086259375;19821.207151714058;19984.700229496568;1057.2282233969092;1059.51262419288;1071.2875937501474;1072.7747173093583;1075.704181350135;10881.619143329945;11164.274322169033;11207.943960280309;11219.382933938712;11476.311421314747;443314;445413;446588;446886;470419;96037.5198124005;100264.49867750614;102176;103774.48112759538;103924;1012.4380968562518;1026.7997740440692;1030.124394264869;1031.8761748590218;1061.6708820265742;17496.650066998332;17706.822931771032;17753.289868405118;17778.644427111645;18080.457586272434;39913;40038;42348.36477452779;43233.78383108064;44667.776661116484;54244.72877635586;54455;56985;61282.69358653178;61453.38546614655;8895.066018068268;8903.821923561622;8952.792470635186;9099.135582119688;9271.860922086309;13287;13304.467821287428;13987.93006035004;14113.506027288995;14356.138631682132;11750.882491174978;11979;12217.511299548274;12491.93754031224;12517.436715347649;12287.75424491523;12354.135210535536;12405.131640785059;12465.002799775815;12743;12375.195612285173;12662.556810511587;13074.542391016268;13103.60689179326;13257.337133143112;7883.7240696575345;8316.916830831615;9253.768655783659;9404.95297523508;9510;11762.76474470523;11933.940330298294;12170.817437738619;12293.508259669514;12492.125551211328 23:42:15 INFO - PROCESS | 21186 | |3;mootools.html;1576.9921150394246;1598.3526671697962;1810.8189181081893;1895.9431217063475;1929.3247363422804;8595.269402100814;9312.208462280705;9428.10433008863;10030.097291243796;10031.197504199665;9590.85613715793;9628.711138665834;9659.661911833087;9722.611095556169;9747.707568772948;2511.8995240190416;2550.961735573959;2550.9744902551015;2552.157787929988;2554.7062087859854;2489.8132640052067;2596.506663733894;2597.6493173421536;2597.766201041906;2604.2447690169924;2474.084588702183;2482.168473561359;2532.6074458458875;2536.0616571868436;2542.8092893033004;2438.5001074779716;2454.877256137186;2467.7655622715815;2484.24230609664;2494.550980823451;2393.5811233034324;2429.344077099191;2433.0875921529428;2444.083468699238;2473.2580225932147;9781.608735650636;9833.065858743408;9884.703458896245;9885.90114098857;9889.505524723734;5502.119660854244;5628.212050312959;5635.295588051494;5667.291588551431;5671.319441666985;3749.1939233065023;3827.234553089393;3864.516935383077;3891.241207964448;3902.843886244547;1257.1828311597535;1285.7749893768553;1287.2276634019606;1296.7212049409422;1310.7902735562263;14060.71878562423;14111.506097286545;14119.78820317696;14124.152550846982;14161.29193540319;5062.594992400599;5184.14461613837;5211.452797456288;5236.92144617831;5250.868728281824;11594.362310072858;11599.536018559163;11699.356535390465;11724.648260552027;11725;5496.395396506381;5575.498205161555;5594.636348637326;5595.944040559623;5644.379118296984;4501.459824821042;4847.103285892122;4924.3105965164905;4975.850724478271;5039.924401133986;4435.246008178618;4464.15181115587;4470.396496472935;4502.527234640315;4540.954590454053;1420.7158568286384;1423.7579611466076;1450.9709805804036;1468.148473885144;1469.3461409672807;981.6907674082642;1095.9726006849892;1104.320842681745;1109.140416177469;1125.3023125662141;6523.804285871432;6743;6763.492738044666;6804.693788779517;6855.211650660138;479.88242880494505;480.60830423204976;487.1839668555156;488.7800489779542;493.01397205588825;4590.540945905383;4594.793234304464;4607.9308810367875;4623.42207224097;4644.86065418038;11754.29474231549;12208.938955305166;12256.203346782431;12279.938600306941;12285.324307163191;11224.326540407601;11616.419179041015;11626.53493860253;11905.166638335406;11955.701107472383;8555.27280181179;8684.6526138955;8793.692220772242;8798.29613630908;8802.339824513187;6382.521310901608;6546.083548303146;6574.342565743387;6681.665916704243;6720.227173875067;10855.29440586391;11145.2198346115;11386.373749443861;11426.428678566204;11490.253133546294;11262.718432039264;11393.430328483377;11417.200795944203;11530.538778448768;11788.823167652663;7727.652255648397;8479.19447652472;8612.78468038304;8695.652173913226;8731;9267.304952128483;9271.721848344561;9276.536173191449;9297.116773906468;9313.022132676242;8319.625616847135;8627.094155113622;8655.91344086551;8722.25860801839;8804.427712198687;8323.375746819134;8366.707165249187;8579.957100214458;8621.482711037357;8694.391392602458;7997.320227780471;8041.597920104088;8064.233897779702;8079.111297757359;8127.674893004214;5696.515796157373;5755.136729490442;5890.116482527484;5893.675847828411;5977.910331344946;5654.180143879033;5736.282964629421;5751.884962300815;5843.766249349978;5998.280206375263 23:42:15 INFO - PROCESS | 21186 | |4;prototype.html;346.1622872648191;356.3798989757821;357.0039589545169;357.2943436712492;357.649503486583;5580.302462192226;5661.433856614337;5760.7407666655;5796.855078623036;5835.183074369592;5653.265075540174;5700;5715.657060576368;5726.455986681259;5734.598578099534;4505.819767209307;4505.909881802362;4553.521880202564;4565.680402371835;4581.496035436099;4457.375967364555;4532.682712210147;4537.546245375453;4537.795799189028;4551.544845515455;4460.197164510387;4464.5981861632445;4480.6191473724775;4505.932411013838;4507.752073635965;4237.792229214659;4457.84096135004;4472.508024117345;4485.9102817943785;4486.3046227834575;3828.1386687995255;3835.3096442640312;3844.788536630484;3852.903677408059;3876.9224615507815;5437.34751829783;5459.153831156177;5468.425815289377;5489.533389661844;5516.641418307838;4904.166291730415;5041.395032596112;5067.366579177603;5067.923981140286;5093.821716239914;5928.6739229342365;5936.5250779937505;5945.910811337833;5960.4635582797755;5982.401759824026;4285.528591854893;4290.313549832012;4302.440682711259;4313.309870420718;4336.985794872565;5908;6199.473044791153;6213.502919766408;6253.624782513064;6306.779262725782;4323.2434323993175;4337.436133302651;4349.3041113421705;4355.1942890564715;4360.49854266757;4427.800748966304;4440.111977604492;4468.195724769573;4477.552244775561;4480.820767169277;4941.604671626261;5037.496250375007;5079.542841144241;5085.694858308513;5090.287359769635;5836.854078648068;5991.760329586855;5998.040313549811;6008.759649614054;6016.458518733335;1514.258013573363;1529.3483038318589;1534;1540.1683091130888;1555.4711398124691;924.9075092490697;933.1881263300836;940.6660635474308;972.8471760963281;983.1397527163732;5274.3143391359645;5277.604179686539;5288.01699362739;5291.703532634452;5291.894162116736;5447.945520544823;5454.390954668383;5478.8358598353425;5485.75314110858;5489.560835133179;5035.62232832539;5133.383993920679;5253.290805741252;5309.256704061435;5350.705711185844;2903.245156259388;2922.0357282096857;2944.5435957426635;2951.6900725423952;2951.8524073796225;5667.914981275284;5691.373948865621;5742.483176514133;5754.74103665336;5776.393478684761;5132.999065182254;5496.31296087989;5539.335279766454;5564.27664403633;5579.409868187547;5621.550275977912;5647.237622920935;5671.553753792757;5676.971615141981;5716.799912002977;5094.7962081516325;5425.531383220704;5474.178873169057;5525.419830917695;5532.557395408438;5388;5388.275751759556;5411.134218525017;5413.485718856702;5417.370361857486;5545.085060965057;5681.432196447588;5697.401772813795;5724.427557244242;5737.827865164052;4044.6764258859807;4070.8371665134246;4080.938785918273;4398.604125628709;4409.316555933835;5918.260217472816;6014.969925150346;6136.386361363828;6148.877022459436;6166.581686212286;5974.970125149346;5981.641101533922;5987.730552125252;6014.428629280212;6044.274687037584;5887.264091988502;5913.438223368773;5948.643081415129;5951.28584569837;6038.826022631762;5706.572007099568;5908.581940334375;5936.525077993837;5939.663575695434;5950.523958083257;6001.129836173817;6032.9487974089025;6038.879222415615;6049.818505444844;6055.394460553909;5644.689542075061;5841.532677385884;5879.147523609138;5904.557158213065;5930.466258036798 23:42:15 INFO - PROCESS | 21186 | |5;yui.html;802.2018091998463;819.4837252530905;820.6635279535392;879.0769691823583;904.4030939579878;15436.228188590581;16114.516564503068;17322.393716219936;17470.563235919108;17517.56206094845;13786;13802.723945521084;13850.168989860591;13852.722945541083;13888.930555347235;808.2281421242728;856.2165618459103;861.1173547114196;862.7498025572577;863.7926897544606;869.76516340588;870.6082262981652;872.8603423452249;875.129246399833;875.129246399833;905.7961958559338;907.314977192219;908.2733812949647;909.1363204955286;911.421247507834;898.2679116520048;898.7393655839766;901.1529162587148;901.6889173235223;902.2150728865929;661.9569727967666;665.3878431842717;665.6106177885943;665.9234188068385;667.0994157886862;15908.363665453368;15921.681566368723;15948.521544353687;15974.440894568634;16027.91986040074;13288.800667989988;13326.267055311953;13357;13363.53227637028;13403.128796628285;12751.42618582166;12830.87169128306;12865.16376435538;13049.347532623331;13331.666708332272;3979.4030895365636;4079.8572049978106;4110.753354798721;4117.21772863158;4168.7707176105305;81111.18888811037;81885.18114818835;82863;83111.584442078;83167.16832831655;12145.453454594564;12169.2698438094;12357.567485137977;12370.13409061357;12455.439505222286;22571.43571410728;22622.981965811578;22942.770572294397;22956.196533121594;23113.7688623115;8591.484510929364;8599.95700021496;8607.61265743043;8686.78283042929;8691.652333906573;4971.527704868032;5015.771136071686;5039.370078740158;5047.646664733434;5104.795808167632;3878.650921417086;4003.8798836034966;4019.8593049243136;4022.6178513041214;4024.0744628735556;656.9113169722121;667.7996601019674;680.2143524229523;687.4878215729314;690.2234985641154;714.5962531169872;751.751921865783;756.7502724101033;774.763697072387;784.5449639209245;10385.169186465217;10706.571737130427;10730.463476826128;10826.512806923707;10917.672469825919;775.337086790797;779.9025121859768;782.2685788787502;783.310686595792;789.7946533901227;4738.5261473853025;4884.7313397762755;4919.1883339248625;4984.601231901512;5002.1496345621335;73147.26852731511;113272;115301.423492882;118733.40633296779;118899.40550297193;84230;86398.13601864026;92963.99999999865;99591.50204248933;102725;84410.57794710986;84543;85055.574722126;88785.9999999987;88898.55550722204;9522.14300712939;10173.491325433846;10510.369377837354;10702.357858528514;10771.676849694522;50032.499675002786;52853.471465284856;53209;53699.73150134224;56637.15044274257;77961;78853.60573197326;78996;79428.20571794208;80810.59594701989;12538;12818.743625127632;12836.294003829506;12837;13172;13399.933000334935;13543.119697219649;13545.932270338586;13648.385822637807;14255.287235638383;13632.454701811816;13682;14024.78962815579;14137.858621414065;14164.93762967761;12639.1784534005;12801.0399220057;12896.48414063427;13460.05779595419;13627.863721362659;12657.746845063231;12993.415296311878;13221.603351899459;13239.669008274484;13632.386542605806;10529.469930782345;10852.837207442053;10932.508037138188;11147.108231341635;11163.944180279046;10956.506957186786;11024.169019395991;11373.43132843338;11484.425778711198;11512.42437878086 23:42:15 INFO - PROCESS | 21186 | __end_tp_report 23:42:15 INFO - PROCESS | 21186 | __start_cc_report 23:42:15 INFO - PROCESS | 21186 | _x_x_mozilla_cycle_collect,340 23:42:15 INFO - PROCESS | 21186 | __end_cc_report 23:42:15 INFO - PROCESS | 21186 | __startTimestamp1468478535202__endTimestamp 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | ------- Summary: start ------- 23:42:15 INFO - PROCESS | 21186 | Number of tests: 6 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#0] dojo.html Cycles:165 Average:5623.09 Median:5850.91 stddev:626.93 (10.7%) stddev-sans-first:602.49 23:42:15 INFO - PROCESS | 21186 | Values: 3330.2 3331.9 3351.6 3366.4 3376.1 5573.6 5578.4 5596.1 5596.1 5599.6 5575.1 5622.2 5634.3 5640.0 5647.9 5067.0 5133.9 5168.1 5189.8 5220.5 5014.1 5087.9 5196.4 5233.6 5278.6 5166.9 5168.2 5168.7 5188.9 5199.0 5147.3 5156.6 5242.6 5253.1 5258.4 5096.3 5148.7 5230.4 5232.6 5251.2 5380.9 5414.8 5425.7 5431.6 5528.0 5973.9 6013.5 6019.3 6023.9 6025.5 5848.9 6039.2 6051.2 6052.5 6076.4 5589.0 5623.8 5627.0 5675.8 5709.1 6147.2 6174.0 6179.3 6207.5 6224.3 5832.9 5893.0 5949.2 5976.3 5976.6 5994.6 6106.0 6110.1 6110.6 6138.8 6036.4 6049.0 6072.1 6079.0 6089.9 5817.9 5928.6 5933.1 6066.7 6071.8 4626.2 4639.0 4645.1 4669.5 4674.7 4125.6 4138.1 4155.2 4174.4 4199.1 5737.6 5765.8 5773.9 5839.4 5850.8 5910.8 5986.5 6026.6 6028.4 6130.8 5850.9 5859.5 5862.7 5863.2 5864.0 5064.5 5135.8 5173.0 5177.5 5216.8 6331.4 6357.3 6359.7 6366.8 6386.1 5907.6 6132.3 6142.3 6144.8 6147.3 6164.5 6187.6 6203.7 6318.3 6322.1 5987.6 5997.8 6003.8 6032.9 6038.9 5919.9 6000.8 6079.5 6093.0 6093.4 5866.8 5978.1 5982.5 5987.3 6014.4 5931.6 5944.0 5954.2 5974.3 5986.0 5654.2 5695.3 5705.4 5857.5 5909.6 5812.2 5914.5 5921.6 5923.9 5932.4 5766.0 5788.5 5803.1 5803.4 5804.3 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#1] ext.html Cycles:180 Average:63754.63 Median:44338.89 stddev:127683.41 (288.0%) stddev-sans-first:127953.51 23:42:15 INFO - PROCESS | 21186 | Values: 587.6 623.2 626.9 635.7 645.3 34086.3 37748.6 45744.3 46603.5 46738.8 47718.3 48065.0 48287.3 48546.3 48660.0 9040.8 9234.5 9249.2 9255.3 9275.7 9123.4 9218.3 9234.9 9234.9 9235.9 9229.0 9280.6 9304.2 9322.6 9349.9 9203.6 9235.7 9268.5 9271.5 9289.7 9161.9 9185.1 9188.4 9236.1 9239.0 43717.3 44169.6 44233.0 44450.0 44545.6 3800.1 4356.3 4453.8 4538.3 4596.0 33759.7 33823.7 34125.7 35130.8 35365.0 4389.2 4455.4 4462.6 4563.1 4696.1 384391.0 385276.0 386670.0 387746.0 389196.1 37876.6 63710.7 63972.0 64191.0 64268.0 38930.6 40200.2 41008.2 41287.8 41382.6 15138.0 15366.8 15381.1 15382.3 15401.2 12336.3 12476.5 12534.8 12535.2 12554.2 9245.3 9287.0 9326.2 9378.6 9390.2 3491.6 3508.9 3530.8 3549.5 3616.4 1017.6 1059.7 1106.9 1177.1 1181.6 30573.7 32068.8 32332.0 32739.7 32821.0 1123.6 1139.7 1150.4 1189.5 1302.3 16696.7 16829.9 16925.0 16958.5 17067.4 500518.0 551797.0 557097.0 557113.0 565128.0 59598.4 60246.4 60267.7 60326.7 60600.4 1467.9 1468.9 1476.2 1481.0 1484.6 33722.8 34179.8 34268.5 34445.8 34460.8 57436.0 58418.7 58493.0 58559.1 58633.1 491258.0 492581.0 496107.0 498471.0 499689.0 31614.0 32008.2 32180.0 32182.5 32232.5 51565.5 52598.0 52637.0 53092.7 53467.0 43141.8 43776.3 44241.2 44661.8 45327.0 42727.1 42835.0 43560.0 44673.6 44962.8 42405.6 43804.1 43978.8 44162.6 44436.6 38333.4 38668.4 44642.1 48776.8 50325.7 33657.5 35632.0 36155.0 36203.3 36556.0 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#2] jquery.html Cycles:180 Average:28313.57 Median:20225.15 stddev:74861.64 (370.1%) stddev-sans-first:75042.34 23:42:15 INFO - PROCESS | 21186 | Values: 415.2 421.3 425.8 427.2 440.1 18511.6 19812.4 20465.6 21497.4 21516.2 16748.4 17120.2 17138.5 17226.0 17284.0 5571.7 5699.1 5723.3 5733.0 5814.5 5656.2 5673.7 5696.9 5707.7 5711.3 5458.7 5762.1 5766.0 5769.1 5776.0 5523.7 5703.9 5709.7 5721.2 5733.2 5648.0 5648.1 5704.8 5716.9 5719.2 15280.2 15282.3 15287.4 15296.5 17424.1 2268.3 2382.3 2397.3 2447.0 2548.1 10111.9 10141.7 10467.0 10505.1 10591.3 1980.5 2058.0 2085.1 2102.5 2149.5 83662.2 85113.1 87258.1 87395.0 88028.0 11422.7 11657.9 11795.3 11798.4 11893.4 15944.3 16472.7 16498.3 16510.2 16630.6 8261.0 8267.9 8284.8 8314.5 8464.0 7853.2 7875.5 7880.2 7909.4 8004.2 4933.1 5092.5 5108.3 5174.0 5208.9 1914.5 1948.6 1960.7 1985.7 1988.4 958.5 1016.0 1057.3 1078.1 1088.4 19220.0 19751.7 19791.3 19821.2 19984.7 1057.2 1059.5 1071.3 1072.8 1075.7 10881.6 11164.3 11207.9 11219.4 11476.3 443314.0 445413.0 446588.0 446886.0 470419.0 96037.5 100264.5 102176.0 103774.5 103924.0 1012.4 1026.8 1030.1 1031.9 1061.7 17496.7 17706.8 17753.3 17778.6 18080.5 39913.0 40038.0 42348.4 43233.8 44667.8 54244.7 54455.0 56985.0 61282.7 61453.4 8895.1 8903.8 8952.8 9099.1 9271.9 13287.0 13304.5 13987.9 14113.5 14356.1 11750.9 11979.0 12217.5 12491.9 12517.4 12287.8 12354.1 12405.1 12465.0 12743.0 12375.2 12662.6 13074.5 13103.6 13257.3 7883.7 8316.9 9253.8 9405.0 9510.0 11762.8 11933.9 12170.8 12293.5 12492.1 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#3] mootools.html Cycles:180 Average:6410.26 Median:4634.14 stddev:3704.02 (79.9%) stddev-sans-first:3696.60 23:42:15 INFO - PROCESS | 21186 | Values: 1577.0 1598.4 1810.8 1895.9 1929.3 8595.3 9312.2 9428.1 10030.1 10031.2 9590.9 9628.7 9659.7 9722.6 9747.7 2511.9 2551.0 2551.0 2552.2 2554.7 2489.8 2596.5 2597.6 2597.8 2604.2 2474.1 2482.2 2532.6 2536.1 2542.8 2438.5 2454.9 2467.8 2484.2 2494.6 2393.6 2429.3 2433.1 2444.1 2473.3 9781.6 9833.1 9884.7 9885.9 9889.5 5502.1 5628.2 5635.3 5667.3 5671.3 3749.2 3827.2 3864.5 3891.2 3902.8 1257.2 1285.8 1287.2 1296.7 1310.8 14060.7 14111.5 14119.8 14124.2 14161.3 5062.6 5184.1 5211.5 5236.9 5250.9 11594.4 11599.5 11699.4 11724.6 11725.0 5496.4 5575.5 5594.6 5595.9 5644.4 4501.5 4847.1 4924.3 4975.9 5039.9 4435.2 4464.2 4470.4 4502.5 4541.0 1420.7 1423.8 1451.0 1468.1 1469.3 981.7 1096.0 1104.3 1109.1 1125.3 6523.8 6743.0 6763.5 6804.7 6855.2 479.9 480.6 487.2 488.8 493.0 4590.5 4594.8 4607.9 4623.4 4644.9 11754.3 12208.9 12256.2 12279.9 12285.3 11224.3 11616.4 11626.5 11905.2 11955.7 8555.3 8684.7 8793.7 8798.3 8802.3 6382.5 6546.1 6574.3 6681.7 6720.2 10855.3 11145.2 11386.4 11426.4 11490.3 11262.7 11393.4 11417.2 11530.5 11788.8 7727.7 8479.2 8612.8 8695.7 8731.0 9267.3 9271.7 9276.5 9297.1 9313.0 8319.6 8627.1 8655.9 8722.3 8804.4 8323.4 8366.7 8580.0 8621.5 8694.4 7997.3 8041.6 8064.2 8079.1 8127.7 5696.5 5755.1 5890.1 5893.7 5977.9 5654.2 5736.3 5751.9 5843.8 5998.3 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#4] prototype.html Cycles:180 Average:4864.08 Median:5456.77 stddev:1402.42 (25.7%) stddev-sans-first:1364.74 23:42:15 INFO - PROCESS | 21186 | Values: 346.2 356.4 357.0 357.3 357.6 5580.3 5661.4 5760.7 5796.9 5835.2 5653.3 5700.0 5715.7 5726.5 5734.6 4505.8 4505.9 4553.5 4565.7 4581.5 4457.4 4532.7 4537.5 4537.8 4551.5 4460.2 4464.6 4480.6 4505.9 4507.8 4237.8 4457.8 4472.5 4485.9 4486.3 3828.1 3835.3 3844.8 3852.9 3876.9 5437.3 5459.2 5468.4 5489.5 5516.6 4904.2 5041.4 5067.4 5067.9 5093.8 5928.7 5936.5 5945.9 5960.5 5982.4 4285.5 4290.3 4302.4 4313.3 4337.0 5908.0 6199.5 6213.5 6253.6 6306.8 4323.2 4337.4 4349.3 4355.2 4360.5 4427.8 4440.1 4468.2 4477.6 4480.8 4941.6 5037.5 5079.5 5085.7 5090.3 5836.9 5991.8 5998.0 6008.8 6016.5 1514.3 1529.3 1534.0 1540.2 1555.5 924.9 933.2 940.7 972.8 983.1 5274.3 5277.6 5288.0 5291.7 5291.9 5447.9 5454.4 5478.8 5485.8 5489.6 5035.6 5133.4 5253.3 5309.3 5350.7 2903.2 2922.0 2944.5 2951.7 2951.9 5667.9 5691.4 5742.5 5754.7 5776.4 5133.0 5496.3 5539.3 5564.3 5579.4 5621.6 5647.2 5671.6 5677.0 5716.8 5094.8 5425.5 5474.2 5525.4 5532.6 5388.0 5388.3 5411.1 5413.5 5417.4 5545.1 5681.4 5697.4 5724.4 5737.8 4044.7 4070.8 4080.9 4398.6 4409.3 5918.3 6015.0 6136.4 6148.9 6166.6 5975.0 5981.6 5987.7 6014.4 6044.3 5887.3 5913.4 5948.6 5951.3 6038.8 5706.6 5908.6 5936.5 5939.7 5950.5 6001.1 6032.9 6038.9 6049.8 6055.4 5644.7 5841.5 5879.1 5904.6 5930.5 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - PROCESS | 21186 | [#5] yui.html Cycles:180 Average:20949.32 Median:4095.31 stddev:29671.61 (724.5%) stddev-sans-first:29716.29 23:42:15 INFO - PROCESS | 21186 | Values: 802.2 819.5 820.7 879.1 904.4 15436.2 16114.5 17322.4 17470.6 17517.6 13786.0 13802.7 13850.2 13852.7 13888.9 808.2 856.2 861.1 862.7 863.8 869.8 870.6 872.9 875.1 875.1 905.8 907.3 908.3 909.1 911.4 898.3 898.7 901.2 901.7 902.2 662.0 665.4 665.6 665.9 667.1 15908.4 15921.7 15948.5 15974.4 16027.9 13288.8 13326.3 13357.0 13363.5 13403.1 12751.4 12830.9 12865.2 13049.3 13331.7 3979.4 4079.9 4110.8 4117.2 4168.8 81111.2 81885.2 82863.0 83111.6 83167.2 12145.5 12169.3 12357.6 12370.1 12455.4 22571.4 22623.0 22942.8 22956.2 23113.8 8591.5 8600.0 8607.6 8686.8 8691.7 4971.5 5015.8 5039.4 5047.6 5104.8 3878.7 4003.9 4019.9 4022.6 4024.1 656.9 667.8 680.2 687.5 690.2 714.6 751.8 756.8 774.8 784.5 10385.2 10706.6 10730.5 10826.5 10917.7 775.3 779.9 782.3 783.3 789.8 4738.5 4884.7 4919.2 4984.6 5002.1 73147.3 113272.0 115301.4 118733.4 118899.4 84230.0 86398.1 92964.0 99591.5 102725.0 84410.6 84543.0 85055.6 88786.0 88898.6 9522.1 10173.5 10510.4 10702.4 10771.7 50032.5 52853.5 53209.0 53699.7 56637.2 77961.0 78853.6 78996.0 79428.2 80810.6 12538.0 12818.7 12836.3 12837.0 13172.0 13399.9 13543.1 13545.9 13648.4 14255.3 13632.5 13682.0 14024.8 14137.9 14164.9 12639.2 12801.0 12896.5 13460.1 13627.9 12657.7 12993.4 13221.6 13239.7 13632.4 10529.5 10852.8 10932.5 11147.1 11163.9 10956.5 11024.2 11373.4 11484.4 11512.4 23:42:15 INFO - PROCESS | 21186 | -------- Summary: end -------- 23:42:15 INFO - PROCESS | 21186 | 23:42:15 INFO - TEST-INFO | 21186: exit 0 23:42:15 INFO - TEST-OK | dromaeo_css | took 1110981ms 23:42:15 INFO - TEST-START | kraken 23:42:15 INFO - operating with platform_type : linux_ 23:42:15 INFO - Initialising browser for kraken test... 23:42:15 INFO - TEST-INFO | started process 21431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPv832/profile http://localhost:46335/getInfo.html) 23:42:20 INFO - PROCESS | 21431 | __metrics Screen width/height:1600/1200 23:42:20 INFO - PROCESS | 21431 | colorDepth:24 23:42:20 INFO - PROCESS | 21431 | Browser inner width/height: 1024/697 23:42:20 INFO - PROCESS | 21431 | __metrics 23:42:21 ERROR - PROCESS | 21431 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:42:22 INFO - TEST-INFO | 21431: exit 0 23:42:22 INFO - Browser initialized. 23:42:22 INFO - Running cycle 1/1 for kraken test... 23:42:22 INFO - TEST-INFO | started process 21557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPv832/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:34 INFO - PROCESS | 21557 | RSS: Main: 156188672 23:42:34 INFO - PROCESS | 21557 | 23:42:36 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46335/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:37 INFO - PROCESS | 21557 | RSS: Main: 161812480 23:42:37 INFO - PROCESS | 21557 | 23:42:40 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46335/tests/kraken/driver.html?testName=audio-dft) 23:42:40 INFO - PROCESS | 21557 | RSS: Main: 160358400 23:42:40 INFO - PROCESS | 21557 | 23:42:43 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46335/tests/kraken/driver.html?testName=audio-fft) 23:42:44 INFO - PROCESS | 21557 | RSS: Main: 161083392 23:42:44 INFO - PROCESS | 21557 | 23:42:46 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46335/tests/kraken/driver.html?testName=audio-oscillator) 23:42:47 INFO - PROCESS | 21557 | RSS: Main: 160894976 23:42:47 INFO - PROCESS | 21557 | 23:42:49 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:50 INFO - PROCESS | 21557 | RSS: Main: 160862208 23:42:50 INFO - PROCESS | 21557 | 23:42:53 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46335/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:53 INFO - PROCESS | 21557 | RSS: Main: 160714752 23:42:53 INFO - PROCESS | 21557 | 23:42:57 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46335/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:57 INFO - PROCESS | 21557 | RSS: Main: 161316864 23:42:57 INFO - PROCESS | 21557 | 23:43:00 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46335/tests/kraken/driver.html?testName=json-parse-financial) 23:43:01 INFO - PROCESS | 21557 | RSS: Main: 160899072 23:43:01 INFO - PROCESS | 21557 | 23:43:02 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:43:03 INFO - PROCESS | 21557 | RSS: Main: 160940032 23:43:03 INFO - PROCESS | 21557 | 23:43:05 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:43:05 INFO - PROCESS | 21557 | RSS: Main: 161058816 23:43:05 INFO - PROCESS | 21557 | 23:43:07 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:43:08 INFO - PROCESS | 21557 | RSS: Main: 161009664 23:43:08 INFO - PROCESS | 21557 | 23:43:10 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:43:11 INFO - PROCESS | 21557 | RSS: Main: 161861632 23:43:11 INFO - PROCESS | 21557 | 23:43:14 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:43:14 INFO - PROCESS | 21557 | RSS: Main: 161357824 23:43:14 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | Cycle 1(1): loaded http://localhost:46335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46335/tests/kraken/driver.html?testName=ai-astar) 23:43:16 INFO - PROCESS | 21557 | RSS: Main: 162304000 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | __start_tp_report 23:43:16 INFO - PROCESS | 21557 | _x_x_mozilla_page_load 23:43:16 INFO - PROCESS | 21557 | _x_x_mozilla_page_load_details 23:43:16 INFO - PROCESS | 21557 | |i|pagename|runs| 23:43:16 INFO - PROCESS | 21557 | |0;ai-astar;111;104;111;110;111;111;109;110;110;112 23:43:16 INFO - PROCESS | 21557 | |1;audio-beat-detection;155;126;154;174;127;151;160;131;179;125 23:43:16 INFO - PROCESS | 21557 | |2;audio-dft;168;161;162;162;164;169;163;161;162;159 23:43:16 INFO - PROCESS | 21557 | |3;audio-fft;77;76;75;171;76;75;75;76;167;75 23:43:16 INFO - PROCESS | 21557 | |4;audio-oscillator;85;85;150;85;85;86;140;85;86;149 23:43:16 INFO - PROCESS | 21557 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;118;118;117 23:43:16 INFO - PROCESS | 21557 | |6;imaging-darkroom;146;148;148;147;148;147;148;146;146;147 23:43:16 INFO - PROCESS | 21557 | |7;imaging-desaturate;95;95;97;95;95;95;95;95;96;94 23:43:16 INFO - PROCESS | 21557 | |8;json-parse-financial;54;55;53;53;55;53;53;54;53;54 23:43:16 INFO - PROCESS | 21557 | |9;json-stringify-tinderbox;60;59;59;60;60;59;59;60;60;59 23:43:16 INFO - PROCESS | 21557 | |10;stanford-crypto-aes;76;76;76;75;77;78;77;77;111;76 23:43:16 INFO - PROCESS | 21557 | |11;stanford-crypto-ccm;124;118;118;128;121;131;118;118;132;120 23:43:16 INFO - PROCESS | 21557 | |12;stanford-crypto-pbkdf2;160;159;157;156;158;161;154;153;154;153 23:43:16 INFO - PROCESS | 21557 | |13;stanford-crypto-sha256-iterative;71;68;68;62;62;61;62;66;61;64 23:43:16 INFO - PROCESS | 21557 | __end_tp_report 23:43:16 INFO - PROCESS | 21557 | __start_cc_report 23:43:16 INFO - PROCESS | 21557 | _x_x_mozilla_cycle_collect,883 23:43:16 INFO - PROCESS | 21557 | __end_cc_report 23:43:16 INFO - PROCESS | 21557 | __startTimestamp1468478596714__endTimestamp 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | ------- Summary: start ------- 23:43:16 INFO - PROCESS | 21557 | Number of tests: 14 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:2.33 23:43:16 INFO - PROCESS | 21557 | Values: 111.0 104.0 111.0 110.0 111.0 111.0 109.0 110.0 110.0 112.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.50 stddev:20.05 (13.0%) stddev-sans-first:21.11 23:43:16 INFO - PROCESS | 21557 | Values: 155.0 126.0 154.0 174.0 127.0 151.0 160.0 131.0 179.0 125.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:3.14 (1.9%) stddev-sans-first:2.79 23:43:16 INFO - PROCESS | 21557 | Values: 168.0 161.0 162.0 162.0 164.0 169.0 163.0 161.0 162.0 159.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.39 (52.2%) stddev-sans-first:41.28 23:43:16 INFO - PROCESS | 21557 | Values: 77.0 76.0 75.0 171.0 76.0 75.0 75.0 76.0 167.0 75.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.61 (34.8%) stddev-sans-first:30.63 23:43:16 INFO - PROCESS | 21557 | Values: 85.0 85.0 150.0 85.0 85.0 86.0 140.0 85.0 86.0 149.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:43:16 INFO - PROCESS | 21557 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 23:43:16 INFO - PROCESS | 21557 | Values: 146.0 148.0 148.0 147.0 148.0 147.0 148.0 146.0 146.0 147.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 23:43:16 INFO - PROCESS | 21557 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 23:43:16 INFO - PROCESS | 21557 | Values: 54.0 55.0 53.0 53.0 55.0 53.0 53.0 54.0 53.0 54.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:43:16 INFO - PROCESS | 21557 | Values: 60.0 59.0 59.0 60.0 60.0 59.0 59.0 60.0 60.0 59.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:76.50 stddev:10.96 (14.3%) stddev-sans-first:11.53 23:43:16 INFO - PROCESS | 21557 | Values: 76.0 76.0 76.0 75.0 77.0 78.0 77.0 77.0 111.0 76.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:122.50 stddev:5.61 (4.6%) stddev-sans-first:5.94 23:43:16 INFO - PROCESS | 21557 | Values: 124.0 118.0 118.0 128.0 121.0 131.0 118.0 118.0 132.0 120.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.50 stddev:2.95 (1.9%) stddev-sans-first:2.85 23:43:16 INFO - PROCESS | 21557 | Values: 160.0 159.0 157.0 156.0 158.0 161.0 154.0 153.0 154.0 153.0 23:43:16 INFO - PROCESS | 21557 | 23:43:16 INFO - PROCESS | 21557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:3.54 (5.4%) stddev-sans-first:2.86 23:43:16 INFO - PROCESS | 21557 | Values: 71.0 68.0 68.0 62.0 62.0 61.0 62.0 66.0 61.0 64.0 23:43:16 INFO - PROCESS | 21557 | -------- Summary: end -------- 23:43:16 INFO - PROCESS | 21557 | 23:43:17 INFO - TEST-INFO | 21557: exit 0 23:43:17 INFO - TEST-OK | kraken | took 61681ms 23:43:17 INFO - SUITE-END | took 1172s 23:43:17 INFO - Completed test suite (00:19:32) 23:43:17 INFO - javascript benchmark 23:43:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7547.912566396727, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.200751819564, 3331.850066746996, 3351.614564325102, 3366.444536651453, 3376.139084533442, 5573.637713548622, 5578.358488773787, 5596.076647353182, 5596.132599447087, 5599.580031497633, 5575.107982722765, 5622.212890195376, 5634.295713035871, 5640.04119299719, 5647.8588035299135, 5066.97466512667, 5133.948660513403, 5168.069747445458, 5189.766460509286, 5220.530152286294, 5014.072396606622, 5087.872803179913, 5196.402413722413, 5233.633645644806, 5278.577713782907, 5166.8708282293055, 5168.173092305232, 5168.664036837612, 5188.92216616751, 5199.038177937075, 5147.330846989905, 5156.58747300217, 5242.55438287746, 5253.106971814801, 5258.39528454225, 5096.286519887219, 5148.716820574867, 5230.3985041719925, 5232.555232805216, 5251.159814429711, 5380.946190538084, 5414.83755487336, 5425.701586412746, 5431.592630552725, 5528.032594295983, 5973.940260597382, 6013.51891848651, 6019.337872833985, 6023.939760602381, 6025.487833534155, 5848.883022339572, 6039.245094363205, 6051.152838602599, 6052.455279024909, 6076.361981991916, 5589.0, 5623.775048998035, 5627.043402621564, 5675.772969081232, 5709.05800542914, 6147.200863887666, 6174.043023331391, 6179.28938172107, 6207.472364849038, 6224.315325314212, 5832.883342333214, 5893.0, 5949.196858424144, 5976.312724036705, 5976.581639285295, 5994.6403215807195, 6106.023036314168, 6110.083487476914, 6110.572259941761, 6138.754449821957, 6036.396360364016, 6049.0, 6072.089186621954, 6078.969605151946, 6089.939100609025, 5817.88364232713, 5928.614640048383, 5933.110033494924, 6066.66633335162, 6071.7571297147615, 4626.21354369758, 4639.048994956026, 4645.140648979882, 4669.463011753692, 4674.69614475058, 4125.628693417607, 4138.089620283533, 4155.231282212801, 4174.3947127666925, 4199.118185181085, 5737.5983681141915, 5765.769369225268, 5773.942260577424, 5839.386864379264, 5850.795222167204, 5910.763569457174, 5986.461218490357, 6026.578139530191, 6028.3971602839365, 6130.816075517741, 5850.912236316459, 5859.531237501075, 5862.677552734641, 5863.179154918314, 5863.970680146572, 5064.544191022752, 5135.845924622267, 5172.9741351293005, 5177.534021938043, 5216.817411390583, 6331.398517140864, 6357.268914074848, 6359.7456101755415, 6366.77716279928, 6386.10594516768, 5907.556933229939, 6132.2947860996555, 6142.262928448615, 6144.754209831557, 6147.293061297829, 6164.506839452923, 6187.566870319034, 6203.689815509297, 6318.273398559225, 6322.083297921868, 5987.550933679904, 5997.820065398045, 6003.849903752266, 6032.8793424132145, 6038.909416358671, 5919.852003699942, 6000.759969601167, 6079.452849243589, 6092.969535152296, 6093.360197179232, 5866.765329386777, 5978.133170690313, 5982.521398288213, 5987.34139244674, 6014.428629280212, 5931.584789064724, 5944.0489521678055, 5954.225950626391, 5974.342822289458, 5986.042233242661, 5654.236678048411, 5695.288088988877, 5705.429457054427, 5857.502112320501, 5909.6158749681135, 5812.21535092757, 5914.526837853047, 5921.5558833086825, 5923.940760592339, 5932.406759324033, 5766.048601980626, 5788.450097240755, 5803.129530570448, 5803.448672376117, 5804.303483581997], "value": 5582.021363974679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5798803855246, 623.1960770605918, 626.9123071471, 635.6662752055171, 645.2869579115077, 34086.31827363451, 37748.62251377489, 45744.31383529246, 46603.533964660346, 46738.76630616851, 47718.28422573664, 48065.0, 48287.27569086466, 48546.27180592294, 48660.0, 9040.773980650487, 9234.492102934337, 9249.213816825579, 9255.305852061123, 9275.721728348126, 9123.406978546407, 9218.308626852979, 9234.86147707785, 9234.907650923473, 9235.861462078074, 9229.03095175007, 9280.628774848998, 9304.209142222886, 9322.62709491623, 9349.906500934972, 9203.585838637277, 9235.722928312127, 9268.536573171348, 9271.490068046254, 9289.674861379854, 9161.862572061424, 9185.12741289583, 9188.448693078437, 9236.076392360777, 9239.029901860342, 43717.34423983643, 44169.55830441687, 44233.0, 44450.0, 44545.55454445446, 3800.1449673823445, 4356.281213599752, 4453.777311134463, 4538.29656403258, 4596.03483268514, 33759.6624033759, 33823.661763382544, 34125.65874341274, 35130.82434587836, 35365.0, 4389.209942210401, 4455.398521199661, 4462.59836614703, 4563.133004729091, 4696.107739529479, 384391.0, 385276.0, 386670.0, 387746.0, 389196.05401973095, 37876.62123378786, 63710.68144659247, 63972.0, 64191.0, 64268.0, 38930.610693893264, 40200.195996080496, 41008.1798364037, 41287.793561032006, 41382.58617413847, 15138.0, 15366.846331536764, 15381.077135371914, 15382.3077961492, 15401.229938503255, 12336.321502317458, 12476.500939962481, 12534.81197782034, 12535.185212961129, 12554.246745195134, 9245.260379169651, 9286.95356523213, 9326.160645541933, 9378.5779639915, 9390.248780097576, 3491.5984661764223, 3508.929821403609, 3530.8411121499594, 3549.4853246279145, 3616.439451884962, 1017.623479312659, 1059.7191744187796, 1106.8616422947132, 1177.105399896068, 1181.580538908675, 30573.723237182745, 32068.83965580204, 32332.0, 32739.67260327414, 32821.0, 1123.584273818676, 1139.6751925701135, 1150.4017910686396, 1189.4944648524342, 1302.2577131035218, 16696.66606667884, 16829.939733637413, 16925.0, 16958.491245262663, 17067.40264090751, 500518.0, 551797.0, 557097.0, 557113.0, 565128.0, 59598.40401596015, 60246.39753602495, 60267.69866150641, 60326.69836650789, 60600.39399606036, 1467.882569394446, 1468.8971771976073, 1476.217604669527, 1480.9629759256104, 1484.599158227294, 33722.83138584292, 34179.82910085434, 34268.48597270993, 34445.82777086098, 34460.82769586136, 57436.0, 58418.70790646019, 58493.0, 58559.121613176685, 58633.12050319163, 491258.0, 492581.0, 496107.0, 498471.0, 499689.0, 31614.0, 32008.199795005312, 32180.0, 32182.517262240617, 32232.516512252805, 51565.48434515607, 52598.0, 52637.0, 53092.734536328615, 53467.0, 43141.784291078344, 43776.343354849065, 44241.230350785605, 44661.77669111764, 45327.0, 42727.145457091305, 42835.0, 43560.0, 44673.55326446694, 44962.77518612386, 42405.57594424016, 43804.123917522105, 43978.780106099264, 44162.55837441584, 44436.555634444536, 38333.42499862448, 38668.41997370098, 44642.10715785731, 48776.75611622061, 50325.74837125791, 33657.495137573445, 35632.0, 36155.0, 36203.27593448169, 36556.0], "value": 20285.133254700002, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.2442554550719, 421.28171467647655, 425.81902691356174, 427.1584977594138, 440.14611653392416, 18511.629767404662, 19812.40562783117, 20465.590688186247, 21497.355079347646, 21516.246931357404, 16748.413805516808, 17120.229589668463, 17138.485845424628, 17226.0, 17284.0, 5571.749271282782, 5699.059655156904, 5723.284589426322, 5733.0, 5814.534837213034, 5656.2364080849175, 5673.744681489343, 5696.8860622787515, 5707.686077265748, 5711.343195532525, 5458.727063646822, 5762.135679648065, 5766.0486019806685, 5769.076947688371, 5776.018076926933, 5523.6685798851795, 5703.914441283384, 5709.71451427429, 5721.170430287606, 5733.168690539869, 5648.0, 5648.096304591246, 5704.800331988402, 5716.914246286309, 5719.227904232958, 15280.235988200657, 15282.31229594671, 15287.38850445992, 15296.541103766906, 17424.12879356027, 2268.3421807675754, 2382.321038504018, 2397.29279862441, 2446.9600419821504, 2548.095426123718, 10111.898881011242, 10141.695749127539, 10467.0, 10505.054545090901, 10591.25861189717, 1980.4949737816764, 2058.0, 2085.0721428964116, 2102.516421223112, 2149.5163588192686, 83662.16337836605, 85113.14886851114, 87258.12741872563, 87395.0, 88028.0, 11422.714432139262, 11657.941710291394, 11795.29228246308, 11798.410079496163, 11893.40532973348, 15944.2825072872, 16472.670546589, 16498.34006639745, 16510.17449127563, 16630.58423539397, 8261.0, 8267.875981860278, 8284.751457456287, 8314.501129932223, 8464.0, 7853.175416581291, 7875.488093274033, 7880.172581878935, 7909.446338756347, 8004.239597238369, 4933.062718083553, 5092.465291144451, 5108.259302401206, 5174.0, 5208.921866172011, 1914.4735197820432, 1948.6102779443884, 1960.7058941158941, 1985.6525108106023, 1988.443235893952, 958.5494817435793, 1015.9644412445529, 1057.2757661002238, 1078.1428764132534, 1088.363307465126, 19220.03899805004, 19751.703724444145, 19791.257086259375, 19821.207151714058, 19984.700229496568, 1057.2282233969092, 1059.51262419288, 1071.2875937501474, 1072.7747173093583, 1075.704181350135, 10881.619143329945, 11164.274322169033, 11207.943960280309, 11219.382933938712, 11476.311421314747, 443314.0, 445413.0, 446588.0, 446886.0, 470419.0, 96037.5198124005, 100264.49867750614, 102176.0, 103774.48112759538, 103924.0, 1012.4380968562518, 1026.7997740440692, 1030.124394264869, 1031.8761748590218, 1061.6708820265742, 17496.650066998332, 17706.822931771032, 17753.289868405118, 17778.644427111645, 18080.457586272434, 39913.0, 40038.0, 42348.36477452779, 43233.78383108064, 44667.776661116484, 54244.72877635586, 54455.0, 56985.0, 61282.69358653178, 61453.38546614655, 8895.066018068268, 8903.821923561622, 8952.792470635186, 9099.135582119688, 9271.860922086309, 13287.0, 13304.467821287428, 13987.93006035004, 14113.506027288995, 14356.138631682132, 11750.882491174978, 11979.0, 12217.511299548274, 12491.93754031224, 12517.436715347649, 12287.75424491523, 12354.135210535536, 12405.131640785059, 12465.002799775815, 12743.0, 12375.195612285173, 12662.556810511587, 13074.542391016268, 13103.60689179326, 13257.337133143112, 7883.7240696575345, 8316.916830831615, 9253.768655783659, 9404.95297523508, 9510.0, 11762.76474470523, 11933.940330298294, 12170.817437738619, 12293.508259669514, 12492.125551211328], "value": 9388.946444723138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.9921150394246, 1598.3526671697962, 1810.8189181081893, 1895.9431217063475, 1929.3247363422804, 8595.269402100814, 9312.208462280705, 9428.10433008863, 10030.097291243796, 10031.197504199665, 9590.85613715793, 9628.711138665834, 9659.661911833087, 9722.611095556169, 9747.707568772948, 2511.8995240190416, 2550.961735573959, 2550.9744902551015, 2552.157787929988, 2554.7062087859854, 2489.8132640052067, 2596.506663733894, 2597.6493173421536, 2597.766201041906, 2604.2447690169924, 2474.084588702183, 2482.168473561359, 2532.6074458458875, 2536.0616571868436, 2542.8092893033004, 2438.5001074779716, 2454.877256137186, 2467.7655622715815, 2484.24230609664, 2494.550980823451, 2393.5811233034324, 2429.344077099191, 2433.0875921529428, 2444.083468699238, 2473.2580225932147, 9781.608735650636, 9833.065858743408, 9884.703458896245, 9885.90114098857, 9889.505524723734, 5502.119660854244, 5628.212050312959, 5635.295588051494, 5667.291588551431, 5671.319441666985, 3749.1939233065023, 3827.234553089393, 3864.516935383077, 3891.241207964448, 3902.843886244547, 1257.1828311597535, 1285.7749893768553, 1287.2276634019606, 1296.7212049409422, 1310.7902735562263, 14060.71878562423, 14111.506097286545, 14119.78820317696, 14124.152550846982, 14161.29193540319, 5062.594992400599, 5184.14461613837, 5211.452797456288, 5236.92144617831, 5250.868728281824, 11594.362310072858, 11599.536018559163, 11699.356535390465, 11724.648260552027, 11725.0, 5496.395396506381, 5575.498205161555, 5594.636348637326, 5595.944040559623, 5644.379118296984, 4501.459824821042, 4847.103285892122, 4924.3105965164905, 4975.850724478271, 5039.924401133986, 4435.246008178618, 4464.15181115587, 4470.396496472935, 4502.527234640315, 4540.954590454053, 1420.7158568286384, 1423.7579611466076, 1450.9709805804036, 1468.148473885144, 1469.3461409672807, 981.6907674082642, 1095.9726006849892, 1104.320842681745, 1109.140416177469, 1125.3023125662141, 6523.804285871432, 6743.0, 6763.492738044666, 6804.693788779517, 6855.211650660138, 479.88242880494505, 480.60830423204976, 487.1839668555156, 488.7800489779542, 493.01397205588825, 4590.540945905383, 4594.793234304464, 4607.9308810367875, 4623.42207224097, 4644.86065418038, 11754.29474231549, 12208.938955305166, 12256.203346782431, 12279.938600306941, 12285.324307163191, 11224.326540407601, 11616.419179041015, 11626.53493860253, 11905.166638335406, 11955.701107472383, 8555.27280181179, 8684.6526138955, 8793.692220772242, 8798.29613630908, 8802.339824513187, 6382.521310901608, 6546.083548303146, 6574.342565743387, 6681.665916704243, 6720.227173875067, 10855.29440586391, 11145.2198346115, 11386.373749443861, 11426.428678566204, 11490.253133546294, 11262.718432039264, 11393.430328483377, 11417.200795944203, 11530.538778448768, 11788.823167652663, 7727.652255648397, 8479.19447652472, 8612.78468038304, 8695.652173913226, 8731.0, 9267.304952128483, 9271.721848344561, 9276.536173191449, 9297.116773906468, 9313.022132676242, 8319.625616847135, 8627.094155113622, 8655.91344086551, 8722.25860801839, 8804.427712198687, 8323.375746819134, 8366.707165249187, 8579.957100214458, 8621.482711037357, 8694.391392602458, 7997.320227780471, 8041.597920104088, 8064.233897779702, 8079.111297757359, 8127.674893004214, 5696.515796157373, 5755.136729490442, 5890.116482527484, 5893.675847828411, 5977.910331344946, 5654.180143879033, 5736.282964629421, 5751.884962300815, 5843.766249349978, 5998.280206375263], "value": 5029.138531701469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1622872648191, 356.3798989757821, 357.0039589545169, 357.2943436712492, 357.649503486583, 5580.302462192226, 5661.433856614337, 5760.7407666655, 5796.855078623036, 5835.183074369592, 5653.265075540174, 5700.0, 5715.657060576368, 5726.455986681259, 5734.598578099534, 4505.819767209307, 4505.909881802362, 4553.521880202564, 4565.680402371835, 4581.496035436099, 4457.375967364555, 4532.682712210147, 4537.546245375453, 4537.795799189028, 4551.544845515455, 4460.197164510387, 4464.5981861632445, 4480.6191473724775, 4505.932411013838, 4507.752073635965, 4237.792229214659, 4457.84096135004, 4472.508024117345, 4485.9102817943785, 4486.3046227834575, 3828.1386687995255, 3835.3096442640312, 3844.788536630484, 3852.903677408059, 3876.9224615507815, 5437.34751829783, 5459.153831156177, 5468.425815289377, 5489.533389661844, 5516.641418307838, 4904.166291730415, 5041.395032596112, 5067.366579177603, 5067.923981140286, 5093.821716239914, 5928.6739229342365, 5936.5250779937505, 5945.910811337833, 5960.4635582797755, 5982.401759824026, 4285.528591854893, 4290.313549832012, 4302.440682711259, 4313.309870420718, 4336.985794872565, 5908.0, 6199.473044791153, 6213.502919766408, 6253.624782513064, 6306.779262725782, 4323.2434323993175, 4337.436133302651, 4349.3041113421705, 4355.1942890564715, 4360.49854266757, 4427.800748966304, 4440.111977604492, 4468.195724769573, 4477.552244775561, 4480.820767169277, 4941.604671626261, 5037.496250375007, 5079.542841144241, 5085.694858308513, 5090.287359769635, 5836.854078648068, 5991.760329586855, 5998.040313549811, 6008.759649614054, 6016.458518733335, 1514.258013573363, 1529.3483038318589, 1534.0, 1540.1683091130888, 1555.4711398124691, 924.9075092490697, 933.1881263300836, 940.6660635474308, 972.8471760963281, 983.1397527163732, 5274.3143391359645, 5277.604179686539, 5288.01699362739, 5291.703532634452, 5291.894162116736, 5447.945520544823, 5454.390954668383, 5478.8358598353425, 5485.75314110858, 5489.560835133179, 5035.62232832539, 5133.383993920679, 5253.290805741252, 5309.256704061435, 5350.705711185844, 2903.245156259388, 2922.0357282096857, 2944.5435957426635, 2951.6900725423952, 2951.8524073796225, 5667.914981275284, 5691.373948865621, 5742.483176514133, 5754.74103665336, 5776.393478684761, 5132.999065182254, 5496.31296087989, 5539.335279766454, 5564.27664403633, 5579.409868187547, 5621.550275977912, 5647.237622920935, 5671.553753792757, 5676.971615141981, 5716.799912002977, 5094.7962081516325, 5425.531383220704, 5474.178873169057, 5525.419830917695, 5532.557395408438, 5388.0, 5388.275751759556, 5411.134218525017, 5413.485718856702, 5417.370361857486, 5545.085060965057, 5681.432196447588, 5697.401772813795, 5724.427557244242, 5737.827865164052, 4044.6764258859807, 4070.8371665134246, 4080.938785918273, 4398.604125628709, 4409.316555933835, 5918.260217472816, 6014.969925150346, 6136.386361363828, 6148.877022459436, 6166.581686212286, 5974.970125149346, 5981.641101533922, 5987.730552125252, 6014.428629280212, 6044.274687037584, 5887.264091988502, 5913.438223368773, 5948.643081415129, 5951.28584569837, 6038.826022631762, 5706.572007099568, 5908.581940334375, 5936.525077993837, 5939.663575695434, 5950.523958083257, 6001.129836173817, 6032.9487974089025, 6038.879222415615, 6049.818505444844, 6055.394460553909, 5644.689542075061, 5841.532677385884, 5879.147523609138, 5904.557158213065, 5930.466258036798], "value": 4416.538608066075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.2018091998463, 819.4837252530905, 820.6635279535392, 879.0769691823583, 904.4030939579878, 15436.228188590581, 16114.516564503068, 17322.393716219936, 17470.563235919108, 17517.56206094845, 13786.0, 13802.723945521084, 13850.168989860591, 13852.722945541083, 13888.930555347235, 808.2281421242728, 856.2165618459103, 861.1173547114196, 862.7498025572577, 863.7926897544606, 869.76516340588, 870.6082262981652, 872.8603423452249, 875.129246399833, 875.129246399833, 905.7961958559338, 907.314977192219, 908.2733812949647, 909.1363204955286, 911.421247507834, 898.2679116520048, 898.7393655839766, 901.1529162587148, 901.6889173235223, 902.2150728865929, 661.9569727967666, 665.3878431842717, 665.6106177885943, 665.9234188068385, 667.0994157886862, 15908.363665453368, 15921.681566368723, 15948.521544353687, 15974.440894568634, 16027.91986040074, 13288.800667989988, 13326.267055311953, 13357.0, 13363.53227637028, 13403.128796628285, 12751.42618582166, 12830.87169128306, 12865.16376435538, 13049.347532623331, 13331.666708332272, 3979.4030895365636, 4079.8572049978106, 4110.753354798721, 4117.21772863158, 4168.7707176105305, 81111.18888811037, 81885.18114818835, 82863.0, 83111.584442078, 83167.16832831655, 12145.453454594564, 12169.2698438094, 12357.567485137977, 12370.13409061357, 12455.439505222286, 22571.43571410728, 22622.981965811578, 22942.770572294397, 22956.196533121594, 23113.7688623115, 8591.484510929364, 8599.95700021496, 8607.61265743043, 8686.78283042929, 8691.652333906573, 4971.527704868032, 5015.771136071686, 5039.370078740158, 5047.646664733434, 5104.795808167632, 3878.650921417086, 4003.8798836034966, 4019.8593049243136, 4022.6178513041214, 4024.0744628735556, 656.9113169722121, 667.7996601019674, 680.2143524229523, 687.4878215729314, 690.2234985641154, 714.5962531169872, 751.751921865783, 756.7502724101033, 774.763697072387, 784.5449639209245, 10385.169186465217, 10706.571737130427, 10730.463476826128, 10826.512806923707, 10917.672469825919, 775.337086790797, 779.9025121859768, 782.2685788787502, 783.310686595792, 789.7946533901227, 4738.5261473853025, 4884.7313397762755, 4919.1883339248625, 4984.601231901512, 5002.1496345621335, 73147.26852731511, 113272.0, 115301.423492882, 118733.40633296779, 118899.40550297193, 84230.0, 86398.13601864026, 92963.99999999865, 99591.50204248933, 102725.0, 84410.57794710986, 84543.0, 85055.574722126, 88785.9999999987, 88898.55550722204, 9522.14300712939, 10173.491325433846, 10510.369377837354, 10702.357858528514, 10771.676849694522, 50032.499675002786, 52853.471465284856, 53209.0, 53699.73150134224, 56637.15044274257, 77961.0, 78853.60573197326, 78996.0, 79428.20571794208, 80810.59594701989, 12538.0, 12818.743625127632, 12836.294003829506, 12837.0, 13172.0, 13399.933000334935, 13543.119697219649, 13545.932270338586, 13648.385822637807, 14255.287235638383, 13632.454701811816, 13682.0, 14024.78962815579, 14137.858621414065, 14164.93762967761, 12639.1784534005, 12801.0399220057, 12896.48414063427, 13460.05779595419, 13627.863721362659, 12657.746845063231, 12993.415296311878, 13221.603351899459, 13239.669008274484, 13632.386542605806, 10529.469930782345, 10852.837207442053, 10932.508037138188, 11147.108231341635, 11163.944180279046, 10956.506957186786, 11024.169019395991, 11373.43132843338, 11484.425778711198, 11512.42437878086], "value": 7829.94895519265, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 154.0, 174.0, 127.0, 151.0, 160.0, 131.0, 179.0, 125.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 162.0, 162.0, 164.0, 169.0, 163.0, 161.0, 162.0, 159.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 171.0, 76.0, 75.0, 75.0, 76.0, 167.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 150.0, 85.0, 85.0, 86.0, 140.0, 85.0, 86.0, 149.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 146.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 53.0, 55.0, 53.0, 53.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 77.0, 78.0, 77.0, 77.0, 111.0, 76.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 118.0, 128.0, 121.0, 131.0, 118.0, 118.0, 132.0, 120.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 157.0, 156.0, 158.0, 161.0, 154.0, 153.0, 154.0, 153.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 62.0, 62.0, 61.0, 62.0, 66.0, 61.0, 64.0], "value": 64.5, "unit": "score"}]}]} 23:43:17 INFO - Return code: 0 23:43:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:43:18 ERROR - # TBPL SUCCESS # 23:43:18 INFO - Running post-action listener: _resource_record_post_action 23:43:18 INFO - ##### 23:43:18 INFO - ##### Finished run-tests step (success) 23:43:18 INFO - ##### 23:43:18 INFO - Running post-run listener: _resource_record_post_run 23:43:18 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 503439360; Read time: 24; Write time: 398552 23:43:18 INFO - TinderboxPrint: CPU usage
13.5% 23:43:18 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 23:43:18 INFO - TinderboxPrint: I/O write bytes / time
503,439,360 / 398,552 23:43:18 INFO - TinderboxPrint: CPU idle
8,217.4 (86.5%) 23:43:18 INFO - TinderboxPrint: CPU user
1,218.0 (12.8%) 23:43:18 INFO - TinderboxPrint: Swap in / out
0 / 0 23:43:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259162112; Read time: 0; Write time: 248668 23:43:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244277248; Read time: 24; Write time: 149884 23:43:18 INFO - Running post-run listener: _upload_blobber_files 23:43:18 INFO - Blob upload gear active. 23:43:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:43:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:43:19 INFO - (blobuploader) - INFO - Open directory for files ... 23:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:19 INFO - (blobuploader) - INFO - Done attempting. 23:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:23 INFO - (blobuploader) - INFO - Done attempting. 23:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:24 INFO - (blobuploader) - INFO - Done attempting. 23:43:24 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:24 INFO - Return code: 0 23:43:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b35647284766440ce4e7df6394b0e6a93304c697139127475ff2702494fc0cdf18ce9cdcba3af880c6464ae17983e701b5ede0e768aa8eb0ae933e3ffe870ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e5b015d8bd4c9c39ba013991ebf176b247c7060875a2e49b622ca38958a091c0727893d1d779a9922c6545db8861dd69f78d11af8700c9d07cab49ab11a5cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a59eced3c4925475e87b10442c2e6725e659fd720c68d67b53e8dca1787d1f874ae7f7cf8620f707d2a8ac58e20c5c7f868267c795c9f69010a0cde11fd34a5"} 23:43:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:24 INFO - Contents: 23:43:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b35647284766440ce4e7df6394b0e6a93304c697139127475ff2702494fc0cdf18ce9cdcba3af880c6464ae17983e701b5ede0e768aa8eb0ae933e3ffe870ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e5b015d8bd4c9c39ba013991ebf176b247c7060875a2e49b622ca38958a091c0727893d1d779a9922c6545db8861dd69f78d11af8700c9d07cab49ab11a5cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a59eced3c4925475e87b10442c2e6725e659fd720c68d67b53e8dca1787d1f874ae7f7cf8620f707d2a8ac58e20c5c7f868267c795c9f69010a0cde11fd34a5"} 23:43:24 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:24 INFO - Copying logs to upload dir... 23:43:24 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.805014 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 23:43:23.992673) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:23.995957) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b35647284766440ce4e7df6394b0e6a93304c697139127475ff2702494fc0cdf18ce9cdcba3af880c6464ae17983e701b5ede0e768aa8eb0ae933e3ffe870ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e5b015d8bd4c9c39ba013991ebf176b247c7060875a2e49b622ca38958a091c0727893d1d779a9922c6545db8861dd69f78d11af8700c9d07cab49ab11a5cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a59eced3c4925475e87b10442c2e6725e659fd720c68d67b53e8dca1787d1f874ae7f7cf8620f707d2a8ac58e20c5c7f868267c795c9f69010a0cde11fd34a5"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b35647284766440ce4e7df6394b0e6a93304c697139127475ff2702494fc0cdf18ce9cdcba3af880c6464ae17983e701b5ede0e768aa8eb0ae933e3ffe870ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e5b015d8bd4c9c39ba013991ebf176b247c7060875a2e49b622ca38958a091c0727893d1d779a9922c6545db8861dd69f78d11af8700c9d07cab49ab11a5cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a59eced3c4925475e87b10442c2e6725e659fd720c68d67b53e8dca1787d1f874ae7f7cf8620f707d2a8ac58e20c5c7f868267c795c9f69010a0cde11fd34a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:24.021358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:24.021713) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468477370.838223-1217378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:24.103495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:24.103835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:24.104133) ========= ========= Total master_lag: 0.14 =========