builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1465635724.78 results: success (0) buildid: 20160611012127 builduid: ef41b84e1a0c4c7ba24f189e26f04393 revision: ec173d9293abdd10fafbcf0ee543c74ca21902f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.779377) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.779893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.780216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.825055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.825442) ========= 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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 02:02:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.6M=0s 2016-06-11 02:02:05 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088209 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.930657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.931173) ========= 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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014221 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.999166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:04.999739) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ec173d9293abdd10fafbcf0ee543c74ca21902f1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ec173d9293abdd10fafbcf0ee543c74ca21902f1 --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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 02:02:05,453 truncating revision to first 12 chars 2016-06-11 02:02:05,453 Setting DEBUG logging. 2016-06-11 02:02:05,453 attempt 1/10 2016-06-11 02:02:05,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ec173d9293ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 02:02:05,940 unpacking tar archive at: fx-team-ec173d9293ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:05.831413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:05.831767) ========= script_repo_revision: ec173d9293abdd10fafbcf0ee543c74ca21902f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:05.832220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:05.832557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:02:05.843378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-11 02:02:05.843728) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:06 INFO - MultiFileLogger online at 20160611 02:02:06 in /builds/slave/test 02:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:06 INFO - {'append_to_log': False, 02:02:06 INFO - 'base_work_dir': '/builds/slave/test', 02:02:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:06 INFO - 'branch': 'Fx-Team-Non-PGO', 02:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:06 INFO - 'config_files': ('talos/linux_config.py',), 02:02:06 INFO - 'default_actions': ('clobber', 02:02:06 INFO - 'read-buildbot-config', 02:02:06 INFO - 'download-and-extract', 02:02:06 INFO - 'populate-webroot', 02:02:06 INFO - 'create-virtualenv', 02:02:06 INFO - 'install', 02:02:06 INFO - 'run-tests'), 02:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:06 INFO - 'download_minidump_stackwalk': True, 02:02:06 INFO - 'download_symbols': 'ondemand', 02:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:06 INFO - 'installer_path': 'installer.exe', 02:02:06 INFO - 'log_level': 'info', 02:02:06 INFO - 'log_name': 'talos', 02:02:06 INFO - 'log_to_console': True, 02:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:06 INFO - 'opt_config_files': (), 02:02:06 INFO - 'pip_index': False, 02:02:06 INFO - 'sps_profile': False, 02:02:06 INFO - 'sps_profile_interval': 0, 02:02:06 INFO - 'suite': 'dromaeojs-e10s', 02:02:06 INFO - 'system_bits': '32', 02:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:06 INFO - 'title': 'talos-linux64-ix-016', 02:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:06 INFO - 'use_talos_json': True, 02:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:06 INFO - 'work_dir': 'build'} 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running clobber step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: clobber 02:02:06 INFO - rmtree: /builds/slave/test/build 02:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - ##### 02:02:06 INFO - ##### Finished clobber step (success) 02:02:06 INFO - ##### 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running read-buildbot-config step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: read_buildbot_config 02:02:06 INFO - Using buildbot properties: 02:02:06 INFO - { 02:02:06 INFO - "project": "", 02:02:06 INFO - "product": "firefox", 02:02:06 INFO - "script_repo_revision": "production", 02:02:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:02:06 INFO - "repository": "", 02:02:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:02:06 INFO - "buildid": "20160611012127", 02:02:06 INFO - "pgo_build": "False", 02:02:06 INFO - "basedir": "/builds/slave/test", 02:02:06 INFO - "buildnumber": 1404, 02:02:06 INFO - "slavename": "talos-linux64-ix-016", 02:02:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:02:06 INFO - "platform": "ubuntu64_hw", 02:02:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:02:06 INFO - "branch": "fx-team", 02:02:06 INFO - "repo_path": "integration/fx-team", 02:02:06 INFO - "revision": "ec173d9293abdd10fafbcf0ee543c74ca21902f1", 02:02:06 INFO - "stage_platform": "linux64", 02:02:06 INFO - "builduid": "ef41b84e1a0c4c7ba24f189e26f04393", 02:02:06 INFO - "slavebuilddir": "test" 02:02:06 INFO - } 02:02:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - ##### 02:02:06 INFO - ##### Finished read-buildbot-config step (success) 02:02:06 INFO - ##### 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running download-and-extract step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: download_and_extract 02:02:06 INFO - mkdir: /builds/slave/test/build/tests 02:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:06 INFO - https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:02:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:02:09 INFO - Downloaded 1361 bytes. 02:02:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:09 INFO - Using the following test package requirements: 02:02:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'jsshell-linux-x86_64.zip'], 02:02:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:09 INFO - https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:10 INFO - Downloaded 22891347 bytes. 02:02:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:11 INFO - Return code: 0 02:02:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:11 INFO - https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:22 INFO - Downloaded 22891347 bytes. 02:02:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:23 INFO - Return code: 0 02:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:23 INFO - https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:02:24 INFO - Downloaded 10833377 bytes. 02:02:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:02:24 INFO - Return code: 0 02:02: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')]} 02:02:24 INFO - https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:02:25 INFO - Downloaded 55400506 bytes. 02:02:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:25 INFO - mkdir: /builds/slave/test/properties 02:02:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:25 INFO - Contents: 02:02:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:26 INFO - Running post-action listener: _resource_record_post_action 02:02:26 INFO - Running post-action listener: set_extra_try_arguments 02:02:26 INFO - ##### 02:02:26 INFO - ##### Finished download-and-extract step (success) 02:02:26 INFO - ##### 02:02:26 INFO - ##### 02:02:26 INFO - ##### Running populate-webroot step. 02:02:26 INFO - ##### 02:02:26 INFO - Running pre-action listener: _resource_record_pre_action 02:02:26 INFO - Running main action method: populate_webroot 02:02:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:26 INFO - '--tppagecycles', 02:02:26 INFO - '7'], 02:02:26 INFO - 'tests': ['tsvgm']}}, 02:02:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['damp', 'tps']}, 02:02:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['damp', 'tps']}, 02:02:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['dromaeo_dom']}, 02:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tsvgx', 02:02:26 INFO - 'tsvgr_opacity', 02:02:26 INFO - 'tart', 02:02:26 INFO - 'tscrollx', 02:02:26 INFO - 'cart']}, 02:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:26 INFO - 'tsvgr_opacity', 02:02:26 INFO - 'tart', 02:02:26 INFO - 'tscrollx', 02:02:26 INFO - 'cart']}, 02:02:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tp5o']}, 02:02:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['tp5o']}, 02:02:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s', 02:02:26 INFO - '--xperf_path', 02:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:26 INFO - 'tests': ['tp5n']}, 02:02:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--xperf_path', 02:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:26 INFO - 'tests': ['tp5n']}}, 02:02:26 INFO - 'talos.zip': {'path': '', 02:02:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:26 INFO - Running post-action listener: _resource_record_post_action 02:02:26 INFO - ##### 02:02:26 INFO - ##### Finished populate-webroot step (success) 02:02:26 INFO - ##### 02:02:26 INFO - ##### 02:02:26 INFO - ##### Running create-virtualenv step. 02:02:26 INFO - ##### 02:02:26 INFO - Running pre-action listener: _resource_record_pre_action 02:02:26 INFO - Running main action method: create_virtualenv 02:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:26 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 02:02:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:26 INFO - Using real prefix '/usr' 02:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:29 INFO - Installing pip.................done. 02:02:29 INFO - Return code: 0 02:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:29 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 02:02:29 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 02:02:29 INFO - Using env: {'DISPLAY': ':0', 02:02:29 INFO - 'HOME': '/home/cltbld', 02:02:29 INFO - 'LANG': 'en_US.UTF-8', 02:02:29 INFO - 'LANGUAGE': 'en_US:en', 02:02:29 INFO - 'LOGNAME': 'cltbld', 02:02:29 INFO - 'MAIL': '/var/mail/cltbld', 02:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:29 INFO - 'MOZ_NO_REMOTE': '1', 02:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:29 INFO - 'NO_EM_RESTART': '1', 02:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:29 INFO - 'PWD': '/builds/slave/test', 02:02:29 INFO - 'SHELL': '/bin/bash', 02:02:29 INFO - 'SHLVL': '1', 02:02:29 INFO - 'TERM': 'linux', 02:02:29 INFO - 'TMOUT': '86400', 02:02:29 INFO - 'USER': 'cltbld', 02:02:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:29 INFO - '_': '/tools/buildbot/bin/python'} 02:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:02:29 INFO - Cleaning up... 02:02:29 INFO - Return code: 0 02:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:29 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 02:02:29 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 02:02:29 INFO - Using env: {'DISPLAY': ':0', 02:02:29 INFO - 'HOME': '/home/cltbld', 02:02:29 INFO - 'LANG': 'en_US.UTF-8', 02:02:29 INFO - 'LANGUAGE': 'en_US:en', 02:02:29 INFO - 'LOGNAME': 'cltbld', 02:02:29 INFO - 'MAIL': '/var/mail/cltbld', 02:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:29 INFO - 'MOZ_NO_REMOTE': '1', 02:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:29 INFO - 'NO_EM_RESTART': '1', 02:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:29 INFO - 'PWD': '/builds/slave/test', 02:02:29 INFO - 'SHELL': '/bin/bash', 02:02:29 INFO - 'SHLVL': '1', 02:02:29 INFO - 'TERM': 'linux', 02:02:29 INFO - 'TMOUT': '86400', 02:02:29 INFO - 'USER': 'cltbld', 02:02:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:29 INFO - '_': '/tools/buildbot/bin/python'} 02:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:29 INFO - Downloading/unpacking psutil>=3.1.1 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:31 INFO - Installing collected packages: psutil 02:02:31 INFO - Running setup.py install for psutil 02:02:31 INFO - building 'psutil._psutil_linux' extension 02:02:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:02:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:02:31 INFO - building 'psutil._psutil_posix' extension 02:02:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:02:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:32 INFO - Successfully installed psutil 02:02:32 INFO - Cleaning up... 02:02:32 INFO - Return code: 0 02:02:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:32 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:32 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 02:02:32 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 02:02:32 INFO - Using env: {'DISPLAY': ':0', 02:02:32 INFO - 'HOME': '/home/cltbld', 02:02:32 INFO - 'LANG': 'en_US.UTF-8', 02:02:32 INFO - 'LANGUAGE': 'en_US:en', 02:02:32 INFO - 'LOGNAME': 'cltbld', 02:02:32 INFO - 'MAIL': '/var/mail/cltbld', 02:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:32 INFO - 'MOZ_NO_REMOTE': '1', 02:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:32 INFO - 'NO_EM_RESTART': '1', 02:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:32 INFO - 'PWD': '/builds/slave/test', 02:02:32 INFO - 'SHELL': '/bin/bash', 02:02:32 INFO - 'SHLVL': '1', 02:02:32 INFO - 'TERM': 'linux', 02:02:32 INFO - 'TMOUT': '86400', 02:02:32 INFO - 'USER': 'cltbld', 02:02:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:32 INFO - '_': '/tools/buildbot/bin/python'} 02:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:34 INFO - Installing collected packages: mozsystemmonitor 02:02:34 INFO - Running setup.py install for mozsystemmonitor 02:02:34 INFO - Successfully installed mozsystemmonitor 02:02:34 INFO - Cleaning up... 02:02:34 INFO - Return code: 0 02:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:34 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 02:02:34 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 02:02:34 INFO - Using env: {'DISPLAY': ':0', 02:02:34 INFO - 'HOME': '/home/cltbld', 02:02:34 INFO - 'LANG': 'en_US.UTF-8', 02:02:34 INFO - 'LANGUAGE': 'en_US:en', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MAIL': '/var/mail/cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SHLVL': '1', 02:02:34 INFO - 'TERM': 'linux', 02:02:34 INFO - 'TMOUT': '86400', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - '_': '/tools/buildbot/bin/python'} 02:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:36 INFO - warning: no files found matching '*.txt' 02:02:36 INFO - no previously-included directories found matching 'build' 02:02:36 INFO - no previously-included directories found matching 'dist' 02:02:36 INFO - no previously-included directories found matching '.git*' 02:02:36 INFO - Installing collected packages: jsonschema, functools32 02:02:36 INFO - Running setup.py install for functools32 02:02:36 INFO - warning: no files found matching '*.txt' 02:02:36 INFO - no previously-included directories found matching 'build' 02:02:36 INFO - no previously-included directories found matching 'dist' 02:02:36 INFO - no previously-included directories found matching '.git*' 02:02:37 INFO - Successfully installed jsonschema functools32 02:02:37 INFO - Cleaning up... 02:02:37 INFO - Return code: 0 02:02:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:37 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 02:02:37 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 02:02:37 INFO - Using env: {'DISPLAY': ':0', 02:02:37 INFO - 'HOME': '/home/cltbld', 02:02:37 INFO - 'LANG': 'en_US.UTF-8', 02:02:37 INFO - 'LANGUAGE': 'en_US:en', 02:02:37 INFO - 'LOGNAME': 'cltbld', 02:02:37 INFO - 'MAIL': '/var/mail/cltbld', 02:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:37 INFO - 'MOZ_NO_REMOTE': '1', 02:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:37 INFO - 'NO_EM_RESTART': '1', 02:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:37 INFO - 'PWD': '/builds/slave/test', 02:02:37 INFO - 'SHELL': '/bin/bash', 02:02:37 INFO - 'SHLVL': '1', 02:02:37 INFO - 'TERM': 'linux', 02:02:37 INFO - 'TMOUT': '86400', 02:02:37 INFO - 'USER': 'cltbld', 02:02:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:37 INFO - '_': '/tools/buildbot/bin/python'} 02:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Downloading docopt-0.6.1.tar.gz 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:40 INFO - Running setup.py install for blobuploader 02:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:40 INFO - Running setup.py install for requests 02:02:40 INFO - Running setup.py install for docopt 02:02:40 INFO - Successfully installed blobuploader requests docopt 02:02:40 INFO - Cleaning up... 02:02:40 INFO - Return code: 0 02:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:40 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 02:02:40 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 02:02:40 INFO - Using env: {'DISPLAY': ':0', 02:02:40 INFO - 'HOME': '/home/cltbld', 02:02:40 INFO - 'LANG': 'en_US.UTF-8', 02:02:40 INFO - 'LANGUAGE': 'en_US:en', 02:02:40 INFO - 'LOGNAME': 'cltbld', 02:02:40 INFO - 'MAIL': '/var/mail/cltbld', 02:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:40 INFO - 'MOZ_NO_REMOTE': '1', 02:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:40 INFO - 'NO_EM_RESTART': '1', 02:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:40 INFO - 'PWD': '/builds/slave/test', 02:02:40 INFO - 'SHELL': '/bin/bash', 02:02:40 INFO - 'SHLVL': '1', 02:02:40 INFO - 'TERM': 'linux', 02:02:40 INFO - 'TMOUT': '86400', 02:02:40 INFO - 'USER': 'cltbld', 02:02:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:40 INFO - '_': '/tools/buildbot/bin/python'} 02:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:40 INFO - Running setup.py (path:/tmp/pip-3db5YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:40 INFO - Running setup.py (path:/tmp/pip-3yYkDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:41 INFO - Running setup.py (path:/tmp/pip-9VPF7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:41 INFO - Running setup.py (path:/tmp/pip-e_2pjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:41 INFO - Running setup.py (path:/tmp/pip-hCWtr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:41 INFO - Running setup.py (path:/tmp/pip-2r7c6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:41 INFO - Running setup.py (path:/tmp/pip-wcqr7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:41 INFO - Running setup.py (path:/tmp/pip-TKyTxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:41 INFO - Running setup.py (path:/tmp/pip-QD27k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:41 INFO - Running setup.py (path:/tmp/pip-pHi8fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:41 INFO - Running setup.py (path:/tmp/pip-i4b3JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:41 INFO - Running setup.py (path:/tmp/pip-ZFBFs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:41 INFO - Running setup.py (path:/tmp/pip-o911BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:42 INFO - Running setup.py (path:/tmp/pip-bENfk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:42 INFO - Running setup.py (path:/tmp/pip-xwSsWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:42 INFO - Running setup.py (path:/tmp/pip-NOWYUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:42 INFO - Running setup.py (path:/tmp/pip-wgZb6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:42 INFO - Running setup.py install for manifestparser 02:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Running setup.py install for mozcrash 02:02:42 INFO - Running setup.py install for mozdebug 02:02:42 INFO - Running setup.py install for mozdevice 02:02:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Running setup.py install for mozfile 02:02:42 INFO - Running setup.py install for mozhttpd 02:02:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Running setup.py install for mozinfo 02:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozInstall 02:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozleak 02:02:43 INFO - Running setup.py install for mozlog 02:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for moznetwork 02:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozprocess 02:02:43 INFO - Running setup.py install for mozprofile 02:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozrunner 02:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozscreenshot 02:02:43 INFO - Running setup.py install for moztest 02:02:43 INFO - Running setup.py install for mozversion 02:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:44 INFO - Cleaning up... 02:02:44 INFO - Return code: 0 02:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:44 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:44 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 02:02:44 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 02:02:44 INFO - Using env: {'DISPLAY': ':0', 02:02:44 INFO - 'HOME': '/home/cltbld', 02:02:44 INFO - 'LANG': 'en_US.UTF-8', 02:02:44 INFO - 'LANGUAGE': 'en_US:en', 02:02:44 INFO - 'LOGNAME': 'cltbld', 02:02:44 INFO - 'MAIL': '/var/mail/cltbld', 02:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:44 INFO - 'MOZ_NO_REMOTE': '1', 02:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:44 INFO - 'NO_EM_RESTART': '1', 02:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:44 INFO - 'PWD': '/builds/slave/test', 02:02:44 INFO - 'SHELL': '/bin/bash', 02:02:44 INFO - 'SHLVL': '1', 02:02:44 INFO - 'TERM': 'linux', 02:02:44 INFO - 'TMOUT': '86400', 02:02:44 INFO - 'USER': 'cltbld', 02:02:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:44 INFO - '_': '/tools/buildbot/bin/python'} 02:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:44 INFO - Running setup.py (path:/tmp/pip-WBndMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:44 INFO - Running setup.py (path:/tmp/pip-7zBZz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:44 INFO - Running setup.py (path:/tmp/pip-rpQ7pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:44 INFO - Running setup.py (path:/tmp/pip-Zu7Mru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:44 INFO - Running setup.py (path:/tmp/pip-MD_xgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:44 INFO - Running setup.py (path:/tmp/pip-YwEJaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 INFO - Running setup.py (path:/tmp/pip-SihT6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 INFO - Running setup.py (path:/tmp/pip-qFN1pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:44 INFO - Running setup.py (path:/tmp/pip-EHGxUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:44 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)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:44 INFO - Running setup.py (path:/tmp/pip-N_lBJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:45 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:45 INFO - Running setup.py (path:/tmp/pip-V15VQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:45 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:45 INFO - Running setup.py (path:/tmp/pip-uY26Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:45 INFO - Running setup.py (path:/tmp/pip-mx8i6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:45 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:45 INFO - Running setup.py (path:/tmp/pip-6atQtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:45 INFO - Running setup.py (path:/tmp/pip-auEA_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:45 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:45 INFO - Running setup.py (path:/tmp/pip-fQMRKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:45 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)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:45 INFO - Running setup.py (path:/tmp/pip-2EhxF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:45 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)) 02:02:45 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)) 02:02:45 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)) 02:02:45 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)) 02:02:45 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)) 02:02:45 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)) 02:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:47 INFO - Downloading blessings-1.6.tar.gz 02:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:47 INFO - Installing collected packages: blessings 02:02:47 INFO - Running setup.py install for blessings 02:02:47 INFO - Successfully installed blessings 02:02:47 INFO - Cleaning up... 02:02:47 INFO - Return code: 0 02:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:47 INFO - Reading from file tmpfile_stdout 02:02:47 INFO - Current package versions: 02:02:47 INFO - argparse == 1.2.1 02:02:47 INFO - blessings == 1.6 02:02:47 INFO - blobuploader == 1.2.4 02:02:47 INFO - docopt == 0.6.1 02:02:47 INFO - functools32 == 3.2.3-2 02:02:47 INFO - jsonschema == 2.5.1 02:02:47 INFO - manifestparser == 1.1 02:02:47 INFO - mozInstall == 1.12 02:02:47 INFO - mozcrash == 0.17 02:02:47 INFO - mozdebug == 0.1 02:02:47 INFO - mozdevice == 0.48 02:02:47 INFO - mozfile == 1.2 02:02:47 INFO - mozhttpd == 0.7 02:02:47 INFO - mozinfo == 0.9 02:02:47 INFO - mozleak == 0.1 02:02:47 INFO - mozlog == 3.2 02:02:47 INFO - moznetwork == 0.27 02:02:47 INFO - mozprocess == 0.22 02:02:47 INFO - mozprofile == 0.28 02:02:47 INFO - mozrunner == 6.11 02:02:47 INFO - mozscreenshot == 0.1 02:02:47 INFO - mozsystemmonitor == 0.3 02:02:47 INFO - moztest == 0.7 02:02:47 INFO - mozversion == 1.4 02:02:47 INFO - psutil == 3.1.1 02:02:47 INFO - requests == 1.2.3 02:02:47 INFO - wsgiref == 0.1.2 02:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:47 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:47 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 02:02:47 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 02:02:47 INFO - Using env: {'DISPLAY': ':0', 02:02:47 INFO - 'HOME': '/home/cltbld', 02:02:47 INFO - 'LANG': 'en_US.UTF-8', 02:02:47 INFO - 'LANGUAGE': 'en_US:en', 02:02:47 INFO - 'LOGNAME': 'cltbld', 02:02:47 INFO - 'MAIL': '/var/mail/cltbld', 02:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:47 INFO - 'MOZ_NO_REMOTE': '1', 02:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:47 INFO - 'NO_EM_RESTART': '1', 02:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:47 INFO - 'PWD': '/builds/slave/test', 02:02:47 INFO - 'SHELL': '/bin/bash', 02:02:47 INFO - 'SHLVL': '1', 02:02:47 INFO - 'TERM': 'linux', 02:02:47 INFO - 'TMOUT': '86400', 02:02:47 INFO - 'USER': 'cltbld', 02:02:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:47 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 INFO - Cleaning up... 02:02:48 INFO - Return code: 0 02:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:48 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 02:02:48 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 02:02:48 INFO - Using env: {'DISPLAY': ':0', 02:02:48 INFO - 'HOME': '/home/cltbld', 02:02:48 INFO - 'LANG': 'en_US.UTF-8', 02:02:48 INFO - 'LANGUAGE': 'en_US:en', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MAIL': '/var/mail/cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SHLVL': '1', 02:02:48 INFO - 'TERM': 'linux', 02:02:48 INFO - 'TMOUT': '86400', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:48 INFO - Cleaning up... 02:02:48 INFO - Return code: 0 02:02:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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 0x7f1e2059df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2686350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, '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': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', '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 02:02:48 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 02:02:48 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 02:02:48 INFO - Using env: {'DISPLAY': ':0', 02:02:48 INFO - 'HOME': '/home/cltbld', 02:02:48 INFO - 'LANG': 'en_US.UTF-8', 02:02:48 INFO - 'LANGUAGE': 'en_US:en', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MAIL': '/var/mail/cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SHLVL': '1', 02:02:48 INFO - 'TERM': 'linux', 02:02:48 INFO - 'TMOUT': '86400', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 INFO - Downloading/unpacking flake8 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:51 INFO - no previously-included directories found matching 'docs/_build' 02:02:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:51 INFO - Running setup.py install for pep8 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:51 INFO - no previously-included directories found matching 'docs/_build' 02:02:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:51 INFO - Cleaning up... 02:02:51 INFO - Return code: 0 02:02:51 INFO - Running post-action listener: _resource_record_post_action 02:02:51 INFO - Running post-action listener: _start_resource_monitoring 02:02:51 INFO - Starting resource monitoring. 02:02:51 INFO - ##### 02:02:51 INFO - ##### Finished create-virtualenv step (success) 02:02:51 INFO - ##### 02:02:51 INFO - ##### 02:02:51 INFO - ##### Running install step. 02:02:51 INFO - ##### 02:02:51 INFO - Running pre-action listener: _resource_record_pre_action 02:02:51 INFO - Running main action method: install 02:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:51 INFO - Reading from file tmpfile_stdout 02:02:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:51 INFO - Reading from file tmpfile_stdout 02:02:51 INFO - Output received: 02:02:51 INFO - Usage: mozinstall [options] installer 02:02:51 INFO - Options: 02:02:51 INFO - -h, --help show this help message and exit 02:02:51 INFO - -d DEST, --destination=DEST 02:02:51 INFO - Directory to install application into. [default: 02:02:51 INFO - "/builds/slave/test"] 02:02:51 INFO - --app=APP Application being installed. [default: firefox] 02:02:51 INFO - mkdir: /builds/slave/test/build/application 02:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:03:07 INFO - Reading from file tmpfile_stdout 02:03:07 INFO - Output received: 02:03:07 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:07 INFO - Running post-action listener: _resource_record_post_action 02:03:07 INFO - ##### 02:03:07 INFO - ##### Finished install step (success) 02:03:07 INFO - ##### 02:03:07 INFO - ##### 02:03:07 INFO - ##### Running run-tests step. 02:03:07 INFO - ##### 02:03:07 INFO - Running pre-action listener: _resource_record_pre_action 02:03:07 INFO - Running main action method: run_tests 02:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:07 INFO - Python 2.7.3 02:03:07 INFO - Return code: 0 02:03:07 INFO - grabbing minidump binary from tooltool 02:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:07 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 0x27151c0>, '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 0x27160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2716550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:07 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 02:03:07 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 02:03:07 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 02:03:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:07 INFO - Return code: 0 02:03:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:03:08 INFO - Return code: 0 02:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 02:03:08 INFO - Using env: {'DISPLAY': ':0', 02:03:08 INFO - 'HOME': '/home/cltbld', 02:03:08 INFO - 'LANG': 'en_US.UTF-8', 02:03:08 INFO - 'LANGUAGE': 'en_US:en', 02:03:08 INFO - 'LOGNAME': 'cltbld', 02:03:08 INFO - 'MAIL': '/var/mail/cltbld', 02:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:08 INFO - 'MOZ_NO_REMOTE': '1', 02:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:08 INFO - 'NO_EM_RESTART': '1', 02:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:08 INFO - 'PWD': '/builds/slave/test', 02:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:08 INFO - 'SHELL': '/bin/bash', 02:03:08 INFO - 'SHLVL': '1', 02:03:08 INFO - 'TERM': 'linux', 02:03:08 INFO - 'TMOUT': '86400', 02:03:08 INFO - 'USER': 'cltbld', 02:03:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645', 02:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:08 INFO - '_': '/tools/buildbot/bin/python'} 02:03:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:03:08 INFO - mozversion application_buildid: 20160611012127 02:03:08 INFO - mozversion application_changeset: ec173d9293abdd10fafbcf0ee543c74ca21902f1 02:03:08 INFO - mozversion application_display_name: Nightly 02:03:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:08 INFO - mozversion application_name: Firefox 02:03:08 INFO - mozversion application_remotingname: firefox 02:03:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:03:08 INFO - mozversion application_vendor: Mozilla 02:03:08 INFO - mozversion application_version: 50.0a1 02:03:08 INFO - mozversion platform_buildid: 20160611012127 02:03:08 INFO - mozversion platform_changeset: ec173d9293abdd10fafbcf0ee543c74ca21902f1 02:03:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:03:08 INFO - mozversion platform_version: 50.0a1 02:03:08 INFO - using testdate: 1465635788 02:03:08 INFO - actual date: 1465635788 02:03:08 INFO - starting webserver on 'localhost:44799' 02:03:08 INFO - SUITE-START | Running 2 tests 02:03:08 INFO - TEST-START | dromaeo_css 02:03:08 INFO - operating with platform_type : linux_ 02:03:08 INFO - Initialising browser for dromaeo_css test... 02:03:08 INFO - TEST-INFO | started process 1359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3cvU3/profile http://localhost:44799/getInfo.html) 02:03:14 INFO - PROCESS | 1359 | __metrics Screen width/height:1600/1200 02:03:14 INFO - PROCESS | 1359 | colorDepth:24 02:03:14 INFO - PROCESS | 1359 | Browser inner width/height: 1024/697 02:03:14 INFO - PROCESS | 1359 | __metrics 02:03:14 ERROR - PROCESS | 1359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:03:15 INFO - TEST-INFO | 1359: exit 0 02:03:15 INFO - Browser initialized. 02:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:15 INFO - TEST-INFO | started process 1479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3cvU3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:28 INFO - PROCESS | 1479 | RSS: Main: 185561088 02:03:28 INFO - PROCESS | 1479 | 02:04:17 INFO - PROCESS | 1479 | 1465635857590 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:06:29 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44799/tests/dromaeo/cssquery-ext.html) 02:06:31 INFO - PROCESS | 1479 | RSS: Main: 189034496 02:06:31 INFO - PROCESS | 1479 | 02:09:33 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-ext.html (next: http://localhost:44799/tests/dromaeo/cssquery-jquery.html) 02:09:33 INFO - PROCESS | 1479 | RSS: Main: 188305408 02:09:33 INFO - PROCESS | 1479 | 02:12:35 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44799/tests/dromaeo/cssquery-mootools.html) 02:12:36 INFO - PROCESS | 1479 | RSS: Main: 189300736 02:12:36 INFO - PROCESS | 1479 | 02:15:38 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44799/tests/dromaeo/cssquery-prototype.html) 02:15:38 INFO - PROCESS | 1479 | RSS: Main: 186560512 02:15:38 INFO - PROCESS | 1479 | 02:18:41 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44799/tests/dromaeo/cssquery-yui.html) 02:18:41 INFO - PROCESS | 1479 | RSS: Main: 188710912 02:18:41 INFO - PROCESS | 1479 | 02:21:44 INFO - PROCESS | 1479 | Cycle 1(1): loaded http://localhost:44799/tests/dromaeo/cssquery-yui.html (next: http://localhost:44799/tests/dromaeo/cssquery-dojo.html) 02:21:45 INFO - PROCESS | 1479 | RSS: Main: 189874176 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | __start_tp_report 02:21:45 INFO - PROCESS | 1479 | _x_x_mozilla_page_load 02:21:45 INFO - PROCESS | 1479 | _x_x_mozilla_page_load_details 02:21:45 INFO - PROCESS | 1479 | |i|pagename|runs| 02:21:45 INFO - PROCESS | 1479 | |0;dojo.html;2607.7783388411985;2659.04274461194;2669.265951863237;2673.705892351842;2682.222155574882;4721.976390118049;4775.594074503667;4779.115863565243;4853.951460485394;4890.290907818364;4660;4785.593224575915;4813.109574728677;4837.201861692816;4845.563899249067;4346.9130617387555;4374.4313239278845;4454.109178164364;4477.7984990675495;4495.100979804036;4166.208420400129;4507.504174540798;4520.073384956077;4531.0258294466685;4544.522825103366;4272.594103560157;4346.673999450022;4359.564043595647;4365.978170109145;4421.093675796454;4302.634276086536;4308.202982448257;4312.331588603772;4313.051128751669;4351.19502891966;4318.460192475941;4321.935170972438;4329.848455304081;4338.848140315074;4380.912381752379;4742.50203728607;4758.405199350082;4807.6394270429855;4823.5176482351835;4829.2997515360075;5155.536001759822;5165.457626949192;5171.37943446785;5178.870528236786;5232.895342093175;5077.898442031139;5187.19598462239;5221.6083793715625;5224.582033437316;5225.346831646044;4726.810927562893;4755.738434386073;4764.475907650156;4765.976170119127;4768.213244814636;5152.995165942605;5175.948240517622;5180.948190518122;5190.11767999441;5201.375834899761;4955.5044495550155;4960.255961605716;4962.057209130254;5007.622903701511;5073.644844860898;5200.089984252741;5202.869928251824;5224;5225.634205605571;5264.631475796734;4960.503949605083;5080.13637681595;5084.313617661643;5122.692638441706;5163.302954101224;4993.775280112331;5136.768845401966;5137.357830271216;5141.742912854343;5151.922721159186;4269.7224680395675;4294.506131794821;4323.567643235651;4327.588879056485;4341.088371442032;3794.506714127201;3802.524684414448;3806.847726090981;3826.4069069294305;3842.615738426135;4377.015171586431;4518.051209246029;4555.2711566149255;4570.200214962435;4590.104929538775;5209.635325527177;5248.711320877312;5253.133233016586;5272.393674727378;5312.335958005249;4512.842050528216;4556.134334476439;4560.042391097841;4569.702969307051;4608.147492713859;4490.730556166641;4505.932411013838;4556.954430455719;4643.210654188796;4682.555157260055;4818.397700287464;4837.854864353934;4840.419149701988;4875.34182885313;4892.92660610084;5113.181890897438;5120;5147.974260128675;5149.871253218699;5152.562032227303;4697.060587882369;4772.976135119302;4854.781534831011;4885.169521181337;4889.266610008527;5095.541401273903;5102.08162530748;5103.464136265638;5119.539241468286;5166.4058633257655;5186.481351864783;5187.533122019036;5192.065428222805;5198.142306519533;5227.895442091213;4935.087008903364;4941.901161976813;4960.751962401793;4977.178765503651;5029.723365214948;4978.4523702393435;4979.825706100414;5001.474845141353;5023.799048038038;5037.7733002014265;4948.851534453972;4967.900641987212;4969.652124351405;4987;5038.773255203598;4920.31115643803;5053.393592768891;5107.106256405188;5116.820911268088;5201.843944681666;4996.200607902718;5012.699238045583;5012.899742005213;5020.297158397901;5057.115004874206 02:21:45 INFO - PROCESS | 1479 | |1;ext.html;535.6340089336102;575.9539236861054;582.3652219081202;602.5781952633155;605.1769593353042;34734.0055893572;38231;38764.41853372198;38872.80563597182;38901.41647875284;39420.60579394205;39479.60520394803;39570.40644390336;39826.004349891264;40029.799851000775;7748.263914928073;7861.449698521106;7871;7872.29149376556;7875.212478752108;7745.728899488519;7789.3768498519985;7848.921510784905;7862.646180921873;7875.724349647763;7821.921780782176;7881.2118788121015;7888.092869320016;7905.881411778828;7907.8418431631335;7824.491408058487;7868.409869259771;7868.724594639189;7878.527288362659;7879.33025692811;7704.191059938737;7771.805704857367;7772.183920688303;7801.2198780121535;7804;37216.44175337372;37386.62613373859;37595.43606845899;37607.81196094029;37679.623203767886;2997.4904266274784;3037.4532584134845;3075.9692403075906;3176.6664500227607;3343.9466568030994;28634.713652863622;29175.854120729473;29178.41643167146;29190.27024324388;29743.553846692317;3390.69483746464;3419.6238413774463;3431.2965842002577;3458.1008937676384;3475.09647491654;246531;246733;247602;247756;248826.9999999982;31786.364272714418;50718.492815071375;51245.48754512407;51289.23066154011;51378;31774.2056448586;33597.49603755945;33618;33779.49330760041;33881.491777623356;13420;13480.191188528719;13499.122557033957;13580.38888250031;13582.728345433035;11047.779044419067;11062.22564420483;11084.168687348481;11096.889031109748;11149.219554631098;7798.805029874298;7894.763157105296;7902.644381002869;7957.880631790527;8007.559584222807;3118.656947735747;3160.3679264147263;3161.6206055273515;3173.222560472699;3177.7616678749187;905.1988989743992;952.7141857442739;1022.6318525330875;1047.2250534604339;1058.9576416943237;27931.72068279332;27958.86020569925;27970.58044129299;28357.574636380472;28425.857870710515;882.342654722236;964.7491652170486;1023.3859684189426;1065.7229120428744;1074.0762943868267;14396.136231826124;14445.566633001026;14639.634009149857;14896.329665165094;15033;372133;373793;376380;376466;376861;48199.27701084487;48455.5154448451;48579.757101214265;48712.269315960286;49050;1188.8216767484773;1192.2607983050564;1204.5061524774626;1221.6335099470123;1231.5012419969926;25903.352416189748;26832.19503414901;27253.86373068122;27564.448711026067;27791.16626501208;42256.15487690167;42560.78719606506;42579;42635.14729705326;42664.146717066105;314932;319249;319329;320573;320942;25228.369290767878;25249.747502525475;25518.617220741333;25522.489550209262;25557.616635750106;41337.1732565353;42515.787421063935;42539.787301064534;42988.78505607452;43418.13163736771;36045.27909441849;36739.816300919396;36764.816175918946;36939;37212;36034.63965360418;37102.44346334753;37183.256334873695;37235.255294894494;37541.4368784463;35698.8215058923;35967.460488092176;36361;36379.09052273714;36646.08384790295;31632.367352653277;32347.589626696757;32721;32722.23694275189;33858.49212261769;25329.74670253274;25570.744292556836;25688.8715556421;25919.74080259249;25998.35004124912 02:21:45 INFO - PROCESS | 1479 | |2;jquery.html;369.99260014799705;370.31306925652905;373.46407904656803;389.77587886964983;390.5918315360448;15647.139407332606;16088.115153666558;17100.401485947994;17102.914485427555;17140.22868970896;15460.768088478682;15743.291551880164;16379.91810040948;16407.91796041018;16441.588960276;5051.09080365535;5221.399539053001;5251.186066159751;5264.894702105956;5275.208718692188;5064.113780088488;5126.769295381698;5176.611754118438;5178.7669554869935;5182.689038657692;5385.515303622673;5449.155380915945;5485.835424937259;5488.259085023511;5489.4236105208975;5428.75570599322;5444.183372494138;5449.809256676017;5615.2700148980775;5622.690752008638;5380;5394.1908713692865;5403.675779453245;5417.59368047394;5456.290682211287;12793.55222567215;17674.734878976826;17810.753247272696;18547.536311592183;18779.906100469547;1782.6612943540686;1802.6845302072215;1926.8651194416395;1989.631918095157;2016.485796121994;9330.891814312621;9462.57418416173;11064.446777661165;11646.76706465866;12449.439775210138;1765.4350607805507;1773.9645207095914;1775.7691500104904;1792.8655350848608;1822.2893071702047;67721.66139169323;68552.65723671399;68670.65664671695;69077.65461172712;69888;9671.371360861522;9703.757406064764;10152.49237538135;10192.745181370377;10324.07083362501;14153.504627337994;14199.36102875373;14242.216678082805;14273.072250303698;14294.928525357307;6893.655317234218;6894.379505844498;7098.787036388917;7118.394936430358;7304.5982470963545;6525.053867189231;6600.108985287021;6627.1716035495565;6670.533062685662;6822.727090916308;4379.080393117417;4392.077663690597;4417.094495628388;4431.091626216617;4453.777311134495;1821.826926441986;1833.1475863723433;1837.9816201838078;1882.7458293130526;1892.0728842867172;863.1929146248152;886.5345693510958;896.4173287363266;898.7169041751828;959.0936564946059;15084.019538730166;15815.525534233991;16113.194340282938;16769.56841258011;17016.149192540324;854.8076682746332;857.4169564696067;876.8728534362482;894.186290475677;897.0312062971975;8937.776555586162;9086.954565227265;9194;9349.15857572808;9551.14039736427;396260;405513;407931;409727;411333;73891.26108738952;76293.61853190699;76535;76781.61609191919;77320;882.5057967538199;897.210454799772;917.4403514026183;919.5586118662945;957.5499515227832;14951.401943922556;15310.15794131289;15451.84548154504;15478;15963.600909977344;32104.518432224002;37130.44304335491;37895.81052094722;38532.807335964266;38782.224355513295;45725.54274457213;46212.7689361551;48683;50404.24393634025;50741.746291268304;7757.224277572198;7841.333486653698;7901.17037711032;7915.683372665259;7997.320227780471;11315.321080735182;12047.156699030984;12091.153619246568;12175.695607609881;12425.440855161358;7436.810110382313;10538.051575358255;10589.311694739818;10609.098226650822;10667.199960003187;10522.736931576772;10649.840252396376;10735.516901739597;10836.13310935139;10968;10673.972274618987;10686.465676715978;10740.755459296115;10743.677689669323;11056.944715276371;6721.092652491851;6973.3375329343635;7295.270472952662;7948.244916732901;8266.504009759434;10293.794124117327;10412.271141020055;10582.100521455763;10621.575136994434;10628.787424251626 02:21:45 INFO - PROCESS | 1479 | |3;mootools.html;1333.699917518558;1413.9395453409943;1463.6853076588538;1639.1886016421872;1641.7044931912267;6875.828104297395;7354.852902941938;7612.391008719296;8112;8121.350291976642;7398;7537.208593097728;7684.500507467011;7706.4990775599545;7716.498427602216;2202.702635144251;2251.2570851618925;2256.571251462225;2259.5819773341987;2262.66060090986;2156.687280344357;2175.8585691929975;2214.30249471416;2216.2907869481774;2218.7670294619074;2177.586258610867;2196.53872686736;2218.4897473581086;2227.610168220563;2237.2617036377956;2128.978710212901;2139.187108898624;2145.120500594764;2147.0552956699003;2149.516358819253;2111.2505060703384;2127.7765834587453;2156.482444213393;2156.590247852903;2158.0504577985794;7716.112647045606;7777;7797.259260370312;7847.0975837778815;7865.331446827026;4622.168009758242;4708.788104535304;4717.905641887143;4725.1730947084125;4746.596539294164;2817.9859100704366;2885.422915416925;2972.9554056689167;2974.985125074361;2983.6270466191727;891.7057371067597;897.1880448194395;919.9172074513259;927.6057675487958;933.9533023348805;10310.226732995055;10531.526081326281;10538.209634277384;10638.095761860252;10652.893471065345;4148.377743338463;4272.935905961351;4304.440422745023;4355.477342718831;4393.231184542692;8993.595288212045;9009.954950225338;9011.63953441855;9013.008569057398;9018.909810901938;4647.465541462775;4649.093426781813;4708.176069187878;4734.621230301636;4786.44955830084;3870.2259548089933;4099.549049604541;4228.1966426378885;4287.97856010718;4362.76004819738;3702.5371828521434;3770.415585584184;3804.4483549885667;3816.885493435201;3860.575336712959;1226.8711785262597;1262.0282382565374;1264.2477725753163;1265.5697062998624;1275.3878138493576;676.1574708918158;818.2472125644422;826.7767702720232;827.2554700769356;829.266099501933;4970.62720295972;5101.642884998015;5104.948950510522;5127.5897928166405;5281.023010742948;785.9664541128398;804.5213098206558;833.441594131933;838.9286910612544;884.5754038061766;3530.293941211768;3537.964620353815;3615.9638403616154;3617.186133120027;3673.6142705016123;9329.813403732023;9404.059594040678;9634.518274086267;9652.75868103303;9688.660896868716;9601.135897769234;9640.662576809778;9666.275029372826;9678.95160524193;9679.612815487302;7125.073740413816;7131.96434017837;7214.134303883568;7215.098112735908;7276.235995220532;5298;5346.893062138658;5368.2484452177505;5370.543503802221;5455.727213639223;8735.912640873765;8842.204201621886;8940.5082720451;9122.224610907882;9145;8506;8832.955835220782;8835.779105522413;8993.190612844875;8993.32550058735;5932.466078052996;6436.645984470899;6649.867002659823;6767.1879374475375;6915.619640919596;7485.326320630951;7485.625718713934;7499.2500749924575;7503.4372422069655;7531.8117047074265;6633.701483433354;6763.560368576027;6850.588964662136;6865.862682746417;6955.826104347432;6620.337966203341;6631.33686631333;6671.232808226922;6716.328367163244;6790.354916282945;6115.1438798569125;6130.846728831815;6209.906851397142;6226.346233645402;6256.499480041677;4175.812088455966;4219.957800421957;4235.95764042368;4265.338872474771;4290.206311832321;4327.891802704831;4333.068390295975;4394.736315821061;4403.5596440356985;4447.577480139382 02:21:45 INFO - PROCESS | 1479 | |4;prototype.html;295.9866805993731;302.61567808882717;303.8177093743754;312.45008784539203;316.85583059707835;5044.445111037788;5061.139606266935;5062.038212739577;5067.163917953542;5079.492050794918;4963.205887058071;4971.900561988758;4984.327115839361;4989.351384320043;4999.3000979862845;3954.209158168371;3970.7617542947514;3972.245273398045;3983.1635356575152;3989.68082553395;3645.2709458108484;3908.335582950891;3917.5494818096;4008.959910400888;4013.097053163044;3865.362215234497;3865.594112618177;3867.284552357823;3873.2447172801317;3875.2830726315583;3849.2878817418587;3876.573576906538;3882.611738826123;3907.1208977980014;3919.549251836047;3210.2776875203126;3298.8289157349036;3395.2869897321593;3403.353362861073;3403.846826892796;4869.56347877377;4920.6801557898625;4925.458199598042;4927.294433815733;4927.926081108786;4395.670324725658;4447.577480139382;4448.865539287461;4452.243118669834;4461.906832825946;5034.672746271481;5206.713630750307;5208.609354298443;5221.895562088775;5287.180487024518;3651.908702282438;3690.206605579813;3711.2577484502935;3712.1833196696684;3741.56971948224;5377.220303056035;5406.83779486616;5415.945840541623;5431.538319242869;5442.707162166911;3612.6387361263664;3736.5702944161226;3742.6234341192994;3763.49192858966;3786.2995345861104;3782.2813665404037;3782.8084153491563;3796.8291426885858;3798.525184351956;3808.847646094125;4368.388425620416;4377.606015458624;4392.165488557164;4402.5597440255715;4427.645788336926;4916.410030796256;5160.974195129001;5245.1607742761735;5301;5310.822562749254;1328.6877583767807;1344.475654494748;1345.896364980726;1346.337273467267;1349.1500354776624;816.8366326734676;829.1418381974627;840.1010918317342;844.5861527851308;851.8126012277289;4226.556211597799;4260.850870219528;4263.59495847894;4264.82717252758;4273.444452221253;4818.71087734737;4832.226843704991;4902.411710594752;4907.282451142143;4921.481140984213;4221.746695198298;4224.655316299483;4238.4490016298305;4246.426732391088;4251.957480425218;2489.863057531817;2642.7621514063826;2649.443616840485;2806.6070750095005;2811.831290122599;5006.89986200274;5087.592992560661;5092.872678183075;5117.616178786606;5123.181270648941;5506.752196151183;5513.393526712059;5522.5581953443625;5537.8061767837935;5568.693721845338;4876.780544875489;5040;5071.7971281149075;5073.543381095719;5092.3335198656905;5388.353397592157;5398.514133727984;5461;5464.289642346628;5487.451254874481;5237.397699264633;5257.4216836147225;5259;5264.15773476242;5274.683518988873;4886.169351210232;5007.549320561167;5065.214891691794;5070.949290507047;5092.872678183075;3703.407534760079;3756.6619004289746;3768.792716400624;3779.7921114337873;3787.4886890269463;5373.247745315737;5379.65032272901;5410.3778065522965;5428.430014848384;5434.358979483676;5016.197408414782;5142.6400151989;5160.612954028388;5209.2809372906095;5214.947850521598;5170.741462926914;5174.430812610685;5198.090334191577;5199.688018718889;5203.401608814884;5080.669756465818;5083.237514372874;5106.310648062613;5106.412762532208;5185.325907631984;5273.6572122811895;5277.525022747971;5278.841634750964;5296.285001524745;5315.973420132875;5116.232565115262;5133.486651334837;5144.897102057863;5182.792688292426;5185.42960274377 02:21:45 INFO - PROCESS | 1479 | |5;yui.html;634.7968650031988;670.3263220463436;730.3135053050129;733.9816504587385;760.8364201696636;11843.289402635837;12753.808692869614;12910.419031143598;13075.54235601754;13515.729685406286;11606.59376921808;11691.649250522476;11719.238249513775;11731.765364692701;11765.882341176586;620.6834514397667;767.93088622024;774.1329710723998;795.2326005404783;796.6733639207926;787.5707739282076;793.2226418110256;794.3883209928351;794.8529522038441;796.3191471292049;825.3685930263354;829.1501211258447;829.4235506323108;831.7463173732009;833.6165363932598;821.8972628421448;822.9670813167467;825.5542007316072;825.8183199696057;827.6275675945849;601.4406601860268;604.5163868904858;604.8518113062283;605.8303674970971;607.5504126946072;12840.871591284062;12905.806412903814;12936.223826570342;12986.610401687965;13008.414621341968;13549.254790986492;13845.446182152702;13859.861401385959;13921.23433211173;13998.93000535001;10149.340292881014;10181.440020798853;10271.7432064199;10803.4058126803;11011.339319640767;4325.243082460588;4365.912681746379;4381.452318460192;4389.363542286383;4512.977435112836;56220.15669764957;56265.71867140638;56350.71824640891;56475.71762141204;56790.71604641992;10538.841917371246;10735;10780;10867.152584060728;10952.397618131079;18886.150123244486;18906.52733681669;18922.3377181798;18943.336983205798;18950.336738214373;6979.93020069803;7049.224585295613;7080.256573059857;7201.89197162043;7224.169220539705;3822.3310920588788;3879.650831425185;3887.8056097195026;3923.725339226227;4055.3511438169753;2929.6923822998706;3003.6996300370224;3005.218643152796;3012.141539661186;3023.576699262105;484.0609218116842;497.7411745892188;502.5803454115854;506.08651384251044;514.2209552527924;454.75443260638883;527.6095689189972;568.0938902450584;588.2294194604996;599.8710277290404;6892.847017393702;7197;7295.306945840137;7298.854022919618;7398.852022959511;526.8472143078541;553.6429003292934;553.8166372451614;561.1526594841819;580.8112363481886;3400.6939375456327;3418.384690755638;3440.724742020632;3441.4493681011418;3508.754387192923;59490;83951;85473.57263213769;85783.14216857751;90806;49132.50867491351;62396.68801655962;78625;80654.59672701717;81199.59400202961;45936.770316148875;60522.092168617506;62022.797720227616;62060.68969655123;72156.63921680358;7749.070111586646;7775.961120194363;7851.097123830604;7878.139820397745;8061.87907181381;37274.440883386225;39698.206035879695;40234.79882600568;40320;40377.596224037385;51766.74116629393;58124.41875581359;60579.394206057375;62017.069743952976;62910;11153.219274650697;11195.72010699739;11315.603953861575;11535.192536522363;11793.174477786473;12086.456109474919;12593.622191334274;13169.934150329187;13484.12353197039;13883.930580347034;11151.163662725166;11253.437328133725;11279.492422841156;11530.59642912494;11704.180707350404;11594.826077609012;11702.531898723955;11708.765824683629;11772.882271177179;12616.306103164414;11028.062614677843;11178.329300242012;11554.422278885853;11739.882601173878;11922.52309907594;9963.25275604318;10087.69736907894;10408.995821097296;10662.360258384522;10728.946355268174;9498.572564234764;9976.401415915068;9997.250206234416;10029.799404012025;10071.143952764098 02:21:45 INFO - PROCESS | 1479 | __end_tp_report 02:21:45 INFO - PROCESS | 1479 | __start_cc_report 02:21:45 INFO - PROCESS | 1479 | _x_x_mozilla_cycle_collect,409 02:21:45 INFO - PROCESS | 1479 | __end_cc_report 02:21:45 INFO - PROCESS | 1479 | __startTimestamp1465636905015__endTimestamp 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | ------- Summary: start ------- 02:21:45 INFO - PROCESS | 1479 | Number of tests: 6 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#0] dojo.html Cycles:165 Average:4753.79 Median:4889.27 stddev:510.61 (10.4%) stddev-sans-first:483.62 02:21:45 INFO - PROCESS | 1479 | Values: 2607.8 2659.0 2669.3 2673.7 2682.2 4722.0 4775.6 4779.1 4854.0 4890.3 4660.0 4785.6 4813.1 4837.2 4845.6 4346.9 4374.4 4454.1 4477.8 4495.1 4166.2 4507.5 4520.1 4531.0 4544.5 4272.6 4346.7 4359.6 4366.0 4421.1 4302.6 4308.2 4312.3 4313.1 4351.2 4318.5 4321.9 4329.8 4338.8 4380.9 4742.5 4758.4 4807.6 4823.5 4829.3 5155.5 5165.5 5171.4 5178.9 5232.9 5077.9 5187.2 5221.6 5224.6 5225.3 4726.8 4755.7 4764.5 4766.0 4768.2 5153.0 5175.9 5180.9 5190.1 5201.4 4955.5 4960.3 4962.1 5007.6 5073.6 5200.1 5202.9 5224.0 5225.6 5264.6 4960.5 5080.1 5084.3 5122.7 5163.3 4993.8 5136.8 5137.4 5141.7 5151.9 4269.7 4294.5 4323.6 4327.6 4341.1 3794.5 3802.5 3806.8 3826.4 3842.6 4377.0 4518.1 4555.3 4570.2 4590.1 5209.6 5248.7 5253.1 5272.4 5312.3 4512.8 4556.1 4560.0 4569.7 4608.1 4490.7 4505.9 4557.0 4643.2 4682.6 4818.4 4837.9 4840.4 4875.3 4892.9 5113.2 5120.0 5148.0 5149.9 5152.6 4697.1 4773.0 4854.8 4885.2 4889.3 5095.5 5102.1 5103.5 5119.5 5166.4 5186.5 5187.5 5192.1 5198.1 5227.9 4935.1 4941.9 4960.8 4977.2 5029.7 4978.5 4979.8 5001.5 5023.8 5037.8 4948.9 4967.9 4969.7 4987.0 5038.8 4920.3 5053.4 5107.1 5116.8 5201.8 4996.2 5012.7 5012.9 5020.3 5057.1 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#1] ext.html Cycles:180 Average:45805.84 Median:36039.96 stddev:83853.94 (232.7%) stddev-sans-first:84020.29 02:21:45 INFO - PROCESS | 1479 | Values: 535.6 576.0 582.4 602.6 605.2 34734.0 38231.0 38764.4 38872.8 38901.4 39420.6 39479.6 39570.4 39826.0 40029.8 7748.3 7861.4 7871.0 7872.3 7875.2 7745.7 7789.4 7848.9 7862.6 7875.7 7821.9 7881.2 7888.1 7905.9 7907.8 7824.5 7868.4 7868.7 7878.5 7879.3 7704.2 7771.8 7772.2 7801.2 7804.0 37216.4 37386.6 37595.4 37607.8 37679.6 2997.5 3037.5 3076.0 3176.7 3343.9 28634.7 29175.9 29178.4 29190.3 29743.6 3390.7 3419.6 3431.3 3458.1 3475.1 246531.0 246733.0 247602.0 247756.0 248827.0 31786.4 50718.5 51245.5 51289.2 51378.0 31774.2 33597.5 33618.0 33779.5 33881.5 13420.0 13480.2 13499.1 13580.4 13582.7 11047.8 11062.2 11084.2 11096.9 11149.2 7798.8 7894.8 7902.6 7957.9 8007.6 3118.7 3160.4 3161.6 3173.2 3177.8 905.2 952.7 1022.6 1047.2 1059.0 27931.7 27958.9 27970.6 28357.6 28425.9 882.3 964.7 1023.4 1065.7 1074.1 14396.1 14445.6 14639.6 14896.3 15033.0 372133.0 373793.0 376380.0 376466.0 376861.0 48199.3 48455.5 48579.8 48712.3 49050.0 1188.8 1192.3 1204.5 1221.6 1231.5 25903.4 26832.2 27253.9 27564.4 27791.2 42256.2 42560.8 42579.0 42635.1 42664.1 314932.0 319249.0 319329.0 320573.0 320942.0 25228.4 25249.7 25518.6 25522.5 25557.6 41337.2 42515.8 42539.8 42988.8 43418.1 36045.3 36739.8 36764.8 36939.0 37212.0 36034.6 37102.4 37183.3 37235.3 37541.4 35698.8 35967.5 36361.0 36379.1 36646.1 31632.4 32347.6 32721.0 32722.2 33858.5 25329.7 25570.7 25688.9 25919.7 25998.4 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#2] jquery.html Cycles:180 Average:24578.49 Median:4385.58 stddev:66914.80 (1525.8%) stddev-sans-first:67077.82 02:21:45 INFO - PROCESS | 1479 | Values: 370.0 370.3 373.5 389.8 390.6 15647.1 16088.1 17100.4 17102.9 17140.2 15460.8 15743.3 16379.9 16407.9 16441.6 5051.1 5221.4 5251.2 5264.9 5275.2 5064.1 5126.8 5176.6 5178.8 5182.7 5385.5 5449.2 5485.8 5488.3 5489.4 5428.8 5444.2 5449.8 5615.3 5622.7 5380.0 5394.2 5403.7 5417.6 5456.3 12793.6 17674.7 17810.8 18547.5 18779.9 1782.7 1802.7 1926.9 1989.6 2016.5 9330.9 9462.6 11064.4 11646.8 12449.4 1765.4 1774.0 1775.8 1792.9 1822.3 67721.7 68552.7 68670.7 69077.7 69888.0 9671.4 9703.8 10152.5 10192.7 10324.1 14153.5 14199.4 14242.2 14273.1 14294.9 6893.7 6894.4 7098.8 7118.4 7304.6 6525.1 6600.1 6627.2 6670.5 6822.7 4379.1 4392.1 4417.1 4431.1 4453.8 1821.8 1833.1 1838.0 1882.7 1892.1 863.2 886.5 896.4 898.7 959.1 15084.0 15815.5 16113.2 16769.6 17016.1 854.8 857.4 876.9 894.2 897.0 8937.8 9087.0 9194.0 9349.2 9551.1 396260.0 405513.0 407931.0 409727.0 411333.0 73891.3 76293.6 76535.0 76781.6 77320.0 882.5 897.2 917.4 919.6 957.5 14951.4 15310.2 15451.8 15478.0 15963.6 32104.5 37130.4 37895.8 38532.8 38782.2 45725.5 46212.8 48683.0 50404.2 50741.7 7757.2 7841.3 7901.2 7915.7 7997.3 11315.3 12047.2 12091.2 12175.7 12425.4 7436.8 10538.1 10589.3 10609.1 10667.2 10522.7 10649.8 10735.5 10836.1 10968.0 10674.0 10686.5 10740.8 10743.7 11056.9 6721.1 6973.3 7295.3 7948.2 8266.5 10293.8 10412.3 10582.1 10621.6 10628.8 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#3] mootools.html Cycles:180 Average:5111.11 Median:5322.45 stddev:2844.68 (53.4%) stddev-sans-first:2838.50 02:21:45 INFO - PROCESS | 1479 | Values: 1333.7 1413.9 1463.7 1639.2 1641.7 6875.8 7354.9 7612.4 8112.0 8121.4 7398.0 7537.2 7684.5 7706.5 7716.5 2202.7 2251.3 2256.6 2259.6 2262.7 2156.7 2175.9 2214.3 2216.3 2218.8 2177.6 2196.5 2218.5 2227.6 2237.3 2129.0 2139.2 2145.1 2147.1 2149.5 2111.3 2127.8 2156.5 2156.6 2158.1 7716.1 7777.0 7797.3 7847.1 7865.3 4622.2 4708.8 4717.9 4725.2 4746.6 2818.0 2885.4 2973.0 2975.0 2983.6 891.7 897.2 919.9 927.6 934.0 10310.2 10531.5 10538.2 10638.1 10652.9 4148.4 4272.9 4304.4 4355.5 4393.2 8993.6 9010.0 9011.6 9013.0 9018.9 4647.5 4649.1 4708.2 4734.6 4786.4 3870.2 4099.5 4228.2 4288.0 4362.8 3702.5 3770.4 3804.4 3816.9 3860.6 1226.9 1262.0 1264.2 1265.6 1275.4 676.2 818.2 826.8 827.3 829.3 4970.6 5101.6 5104.9 5127.6 5281.0 786.0 804.5 833.4 838.9 884.6 3530.3 3538.0 3616.0 3617.2 3673.6 9329.8 9404.1 9634.5 9652.8 9688.7 9601.1 9640.7 9666.3 9679.0 9679.6 7125.1 7132.0 7214.1 7215.1 7276.2 5298.0 5346.9 5368.2 5370.5 5455.7 8735.9 8842.2 8940.5 9122.2 9145.0 8506.0 8833.0 8835.8 8993.2 8993.3 5932.5 6436.6 6649.9 6767.2 6915.6 7485.3 7485.6 7499.3 7503.4 7531.8 6633.7 6763.6 6850.6 6865.9 6955.8 6620.3 6631.3 6671.2 6716.3 6790.4 6115.1 6130.8 6209.9 6226.3 6256.5 4175.8 4220.0 4236.0 4265.3 4290.2 4327.9 4333.1 4394.7 4403.6 4447.6 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#4] prototype.html Cycles:180 Average:4298.45 Median:4926.38 stddev:1265.22 (25.7%) stddev-sans-first:1232.59 02:21:45 INFO - PROCESS | 1479 | Values: 296.0 302.6 303.8 312.5 316.9 5044.4 5061.1 5062.0 5067.2 5079.5 4963.2 4971.9 4984.3 4989.4 4999.3 3954.2 3970.8 3972.2 3983.2 3989.7 3645.3 3908.3 3917.5 4009.0 4013.1 3865.4 3865.6 3867.3 3873.2 3875.3 3849.3 3876.6 3882.6 3907.1 3919.5 3210.3 3298.8 3395.3 3403.4 3403.8 4869.6 4920.7 4925.5 4927.3 4927.9 4395.7 4447.6 4448.9 4452.2 4461.9 5034.7 5206.7 5208.6 5221.9 5287.2 3651.9 3690.2 3711.3 3712.2 3741.6 5377.2 5406.8 5415.9 5431.5 5442.7 3612.6 3736.6 3742.6 3763.5 3786.3 3782.3 3782.8 3796.8 3798.5 3808.8 4368.4 4377.6 4392.2 4402.6 4427.6 4916.4 5161.0 5245.2 5301.0 5310.8 1328.7 1344.5 1345.9 1346.3 1349.2 816.8 829.1 840.1 844.6 851.8 4226.6 4260.9 4263.6 4264.8 4273.4 4818.7 4832.2 4902.4 4907.3 4921.5 4221.7 4224.7 4238.4 4246.4 4252.0 2489.9 2642.8 2649.4 2806.6 2811.8 5006.9 5087.6 5092.9 5117.6 5123.2 5506.8 5513.4 5522.6 5537.8 5568.7 4876.8 5040.0 5071.8 5073.5 5092.3 5388.4 5398.5 5461.0 5464.3 5487.5 5237.4 5257.4 5259.0 5264.2 5274.7 4886.2 5007.5 5065.2 5070.9 5092.9 3703.4 3756.7 3768.8 3779.8 3787.5 5373.2 5379.7 5410.4 5428.4 5434.4 5016.2 5142.6 5160.6 5209.3 5214.9 5170.7 5174.4 5198.1 5199.7 5203.4 5080.7 5083.2 5106.3 5106.4 5185.3 5273.7 5277.5 5278.8 5296.3 5316.0 5116.2 5133.5 5144.9 5182.8 5185.4 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - PROCESS | 1479 | [#5] yui.html Cycles:180 Average:16142.15 Median:2483.87 stddev:21667.90 (872.3%) stddev-sans-first:21697.39 02:21:45 INFO - PROCESS | 1479 | Values: 634.8 670.3 730.3 734.0 760.8 11843.3 12753.8 12910.4 13075.5 13515.7 11606.6 11691.6 11719.2 11731.8 11765.9 620.7 767.9 774.1 795.2 796.7 787.6 793.2 794.4 794.9 796.3 825.4 829.2 829.4 831.7 833.6 821.9 823.0 825.6 825.8 827.6 601.4 604.5 604.9 605.8 607.6 12840.9 12905.8 12936.2 12986.6 13008.4 13549.3 13845.4 13859.9 13921.2 13998.9 10149.3 10181.4 10271.7 10803.4 11011.3 4325.2 4365.9 4381.5 4389.4 4513.0 56220.2 56265.7 56350.7 56475.7 56790.7 10538.8 10735.0 10780.0 10867.2 10952.4 18886.2 18906.5 18922.3 18943.3 18950.3 6979.9 7049.2 7080.3 7201.9 7224.2 3822.3 3879.7 3887.8 3923.7 4055.4 2929.7 3003.7 3005.2 3012.1 3023.6 484.1 497.7 502.6 506.1 514.2 454.8 527.6 568.1 588.2 599.9 6892.8 7197.0 7295.3 7298.9 7398.9 526.8 553.6 553.8 561.2 580.8 3400.7 3418.4 3440.7 3441.4 3508.8 59490.0 83951.0 85473.6 85783.1 90806.0 49132.5 62396.7 78625.0 80654.6 81199.6 45936.8 60522.1 62022.8 62060.7 72156.6 7749.1 7776.0 7851.1 7878.1 8061.9 37274.4 39698.2 40234.8 40320.0 40377.6 51766.7 58124.4 60579.4 62017.1 62910.0 11153.2 11195.7 11315.6 11535.2 11793.2 12086.5 12593.6 13169.9 13484.1 13883.9 11151.2 11253.4 11279.5 11530.6 11704.2 11594.8 11702.5 11708.8 11772.9 12616.3 11028.1 11178.3 11554.4 11739.9 11922.5 9963.3 10087.7 10409.0 10662.4 10728.9 9498.6 9976.4 9997.3 10029.8 10071.1 02:21:45 INFO - PROCESS | 1479 | -------- Summary: end -------- 02:21:45 INFO - PROCESS | 1479 | 02:21:45 INFO - TEST-INFO | 1479: exit 0 02:21:45 INFO - TEST-OK | dromaeo_css | took 1116891ms 02:21:45 INFO - TEST-START | kraken 02:21:45 INFO - operating with platform_type : linux_ 02:21:45 INFO - Initialising browser for kraken test... 02:21:45 INFO - TEST-INFO | started process 1717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHULXA6/profile http://localhost:44799/getInfo.html) 02:21:50 INFO - PROCESS | 1717 | __metrics Screen width/height:1600/1200 02:21:50 INFO - PROCESS | 1717 | colorDepth:24 02:21:50 INFO - PROCESS | 1717 | Browser inner width/height: 1024/697 02:21:50 INFO - PROCESS | 1717 | __metrics 02:21:51 ERROR - PROCESS | 1717 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:21:52 INFO - TEST-INFO | 1717: exit 0 02:21:52 INFO - Browser initialized. 02:21:52 INFO - Running cycle 1/1 for kraken test... 02:21:52 INFO - TEST-INFO | started process 1837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHULXA6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:04 INFO - PROCESS | 1837 | RSS: Main: 186036224 02:22:04 INFO - PROCESS | 1837 | 02:22:07 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44799/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:08 INFO - PROCESS | 1837 | RSS: Main: 191078400 02:22:08 INFO - PROCESS | 1837 | 02:22:11 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44799/tests/kraken/driver.html?testName=audio-dft) 02:22:11 INFO - PROCESS | 1837 | RSS: Main: 190640128 02:22:11 INFO - PROCESS | 1837 | 02:22:14 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44799/tests/kraken/driver.html?testName=audio-fft) 02:22:15 INFO - PROCESS | 1837 | RSS: Main: 186519552 02:22:15 INFO - PROCESS | 1837 | 02:22:17 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44799/tests/kraken/driver.html?testName=audio-oscillator) 02:22:18 INFO - PROCESS | 1837 | RSS: Main: 187006976 02:22:18 INFO - PROCESS | 1837 | 02:22:20 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44799/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:21 INFO - PROCESS | 1837 | RSS: Main: 187375616 02:22:21 INFO - PROCESS | 1837 | 02:22:24 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44799/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:24 INFO - PROCESS | 1837 | RSS: Main: 187957248 02:22:24 INFO - PROCESS | 1837 | 02:22:28 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44799/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:29 INFO - PROCESS | 1837 | RSS: Main: 184922112 02:22:29 INFO - PROCESS | 1837 | 02:22:32 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44799/tests/kraken/driver.html?testName=json-parse-financial) 02:22:32 INFO - PROCESS | 1837 | RSS: Main: 185921536 02:22:32 INFO - PROCESS | 1837 | 02:22:34 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44799/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:35 INFO - PROCESS | 1837 | RSS: Main: 186765312 02:22:35 INFO - PROCESS | 1837 | 02:22:36 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:37 INFO - PROCESS | 1837 | RSS: Main: 186724352 02:22:37 INFO - PROCESS | 1837 | 02:22:39 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:40 INFO - PROCESS | 1837 | RSS: Main: 187191296 02:22:40 INFO - PROCESS | 1837 | 02:22:43 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:44 INFO - PROCESS | 1837 | RSS: Main: 187613184 02:22:44 INFO - PROCESS | 1837 | 02:22:46 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:47 INFO - PROCESS | 1837 | RSS: Main: 187400192 02:22:47 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | Cycle 1(1): loaded http://localhost:44799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44799/tests/kraken/driver.html?testName=ai-astar) 02:22:49 INFO - PROCESS | 1837 | RSS: Main: 188321792 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | __start_tp_report 02:22:49 INFO - PROCESS | 1837 | _x_x_mozilla_page_load 02:22:49 INFO - PROCESS | 1837 | _x_x_mozilla_page_load_details 02:22:49 INFO - PROCESS | 1837 | |i|pagename|runs| 02:22:49 INFO - PROCESS | 1837 | |0;ai-astar;116;109;116;115;114;116;115;118;117;116 02:22:49 INFO - PROCESS | 1837 | |1;audio-beat-detection;159;139;164;180;133;157;153;133;198;141 02:22:49 INFO - PROCESS | 1837 | |2;audio-dft;167;165;173;163;164;163;164;165;164;165 02:22:49 INFO - PROCESS | 1837 | |3;audio-fft;76;77;76;184;77;76;74;83;170;78 02:22:49 INFO - PROCESS | 1837 | |4;audio-oscillator;87;87;144;88;87;87;130;88;86;146 02:22:49 INFO - PROCESS | 1837 | |5;imaging-gaussian-blur;119;117;117;118;117;118;121;118;123;122 02:22:49 INFO - PROCESS | 1837 | |6;imaging-darkroom;149;148;148;150;148;149;149;151;148;146 02:22:49 INFO - PROCESS | 1837 | |7;imaging-desaturate;97;95;95;96;95;96;96;96;96;96 02:22:49 INFO - PROCESS | 1837 | |8;json-parse-financial;65;63;64;63;65;65;64;62;62;64 02:22:49 INFO - PROCESS | 1837 | |9;json-stringify-tinderbox;65;67;65;65;64;64;71;68;66;66 02:22:49 INFO - PROCESS | 1837 | |10;stanford-crypto-aes;86;84;86;85;90;86;86;92;117;89 02:22:49 INFO - PROCESS | 1837 | |11;stanford-crypto-ccm;141;134;133;140;133;147;133;152;137;161 02:22:49 INFO - PROCESS | 1837 | |12;stanford-crypto-pbkdf2;168;173;170;167;174;168;171;174;168;167 02:22:49 INFO - PROCESS | 1837 | |13;stanford-crypto-sha256-iterative;67;72;69;68;67;71;67;71;71;70 02:22:49 INFO - PROCESS | 1837 | __end_tp_report 02:22:49 INFO - PROCESS | 1837 | __start_cc_report 02:22:49 INFO - PROCESS | 1837 | _x_x_mozilla_cycle_collect,983 02:22:49 INFO - PROCESS | 1837 | __end_cc_report 02:22:49 INFO - PROCESS | 1837 | __startTimestamp1465636969658__endTimestamp 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | ------- Summary: start ------- 02:22:49 INFO - PROCESS | 1837 | Number of tests: 14 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:2.44 (2.1%) stddev-sans-first:2.57 02:22:49 INFO - PROCESS | 1837 | Values: 116.0 109.0 116.0 115.0 114.0 116.0 115.0 118.0 117.0 116.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:158.00 stddev:21.07 (13.3%) stddev-sans-first:22.31 02:22:49 INFO - PROCESS | 1837 | Values: 159.0 139.0 164.0 180.0 133.0 157.0 153.0 133.0 198.0 141.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:2.95 (1.8%) stddev-sans-first:3.06 02:22:49 INFO - PROCESS | 1837 | Values: 167.0 165.0 173.0 163.0 164.0 163.0 164.0 165.0 164.0 165.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#3] audio-fft Cycles:10 Average:97.10 Median:76.50 stddev:42.30 (55.3%) stddev-sans-first:44.18 02:22:49 INFO - PROCESS | 1837 | Values: 76.0 77.0 76.0 184.0 77.0 76.0 74.0 83.0 170.0 78.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:87.00 stddev:25.87 (29.7%) stddev-sans-first:26.78 02:22:49 INFO - PROCESS | 1837 | Values: 87.0 87.0 144.0 88.0 87.0 87.0 130.0 88.0 86.0 146.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:118.50 stddev:2.21 (1.9%) stddev-sans-first:2.35 02:22:49 INFO - PROCESS | 1837 | Values: 119.0 117.0 117.0 118.0 117.0 118.0 121.0 118.0 123.0 122.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 02:22:49 INFO - PROCESS | 1837 | Values: 149.0 148.0 148.0 150.0 148.0 149.0 149.0 151.0 148.0 146.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 02:22:49 INFO - PROCESS | 1837 | Values: 97.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 02:22:49 INFO - PROCESS | 1837 | Values: 65.0 63.0 64.0 63.0 65.0 65.0 64.0 62.0 62.0 64.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:2.13 (3.2%) stddev-sans-first:2.22 02:22:49 INFO - PROCESS | 1837 | Values: 65.0 67.0 65.0 65.0 64.0 64.0 71.0 68.0 66.0 66.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:86.00 stddev:9.77 (11.4%) stddev-sans-first:10.25 02:22:49 INFO - PROCESS | 1837 | Values: 86.0 84.0 86.0 85.0 90.0 86.0 86.0 92.0 117.0 89.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:140.50 stddev:9.52 (6.8%) stddev-sans-first:10.09 02:22:49 INFO - PROCESS | 1837 | Values: 141.0 134.0 133.0 140.0 133.0 147.0 133.0 152.0 137.0 161.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.50 stddev:2.83 (1.7%) stddev-sans-first:2.91 02:22:49 INFO - PROCESS | 1837 | Values: 168.0 173.0 170.0 167.0 174.0 168.0 171.0 174.0 168.0 167.0 02:22:49 INFO - PROCESS | 1837 | 02:22:49 INFO - PROCESS | 1837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.50 stddev:1.95 (2.8%) stddev-sans-first:1.88 02:22:49 INFO - PROCESS | 1837 | Values: 67.0 72.0 69.0 68.0 67.0 71.0 67.0 71.0 71.0 70.0 02:22:49 INFO - PROCESS | 1837 | -------- Summary: end -------- 02:22:49 INFO - PROCESS | 1837 | 02:22:50 INFO - TEST-INFO | 1837: exit 0 02:22:50 INFO - TEST-OK | kraken | took 64941ms 02:22:50 INFO - SUITE-END | took 1181s 02:22:50 INFO - Completed test suite (00:19:41) 02:22:50 INFO - javascript benchmark 02:22:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6356.192479282281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.7783388411985, 2659.04274461194, 2669.265951863237, 2673.705892351842, 2682.222155574882, 4721.976390118049, 4775.594074503667, 4779.115863565243, 4853.951460485394, 4890.290907818364, 4660.0, 4785.593224575915, 4813.109574728677, 4837.201861692816, 4845.563899249067, 4346.9130617387555, 4374.4313239278845, 4454.109178164364, 4477.7984990675495, 4495.100979804036, 4166.208420400129, 4507.504174540798, 4520.073384956077, 4531.0258294466685, 4544.522825103366, 4272.594103560157, 4346.673999450022, 4359.564043595647, 4365.978170109145, 4421.093675796454, 4302.634276086536, 4308.202982448257, 4312.331588603772, 4313.051128751669, 4351.19502891966, 4318.460192475941, 4321.935170972438, 4329.848455304081, 4338.848140315074, 4380.912381752379, 4742.50203728607, 4758.405199350082, 4807.6394270429855, 4823.5176482351835, 4829.2997515360075, 5155.536001759822, 5165.457626949192, 5171.37943446785, 5178.870528236786, 5232.895342093175, 5077.898442031139, 5187.19598462239, 5221.6083793715625, 5224.582033437316, 5225.346831646044, 4726.810927562893, 4755.738434386073, 4764.475907650156, 4765.976170119127, 4768.213244814636, 5152.995165942605, 5175.948240517622, 5180.948190518122, 5190.11767999441, 5201.375834899761, 4955.5044495550155, 4960.255961605716, 4962.057209130254, 5007.622903701511, 5073.644844860898, 5200.089984252741, 5202.869928251824, 5224.0, 5225.634205605571, 5264.631475796734, 4960.503949605083, 5080.13637681595, 5084.313617661643, 5122.692638441706, 5163.302954101224, 4993.775280112331, 5136.768845401966, 5137.357830271216, 5141.742912854343, 5151.922721159186, 4269.7224680395675, 4294.506131794821, 4323.567643235651, 4327.588879056485, 4341.088371442032, 3794.506714127201, 3802.524684414448, 3806.847726090981, 3826.4069069294305, 3842.615738426135, 4377.015171586431, 4518.051209246029, 4555.2711566149255, 4570.200214962435, 4590.104929538775, 5209.635325527177, 5248.711320877312, 5253.133233016586, 5272.393674727378, 5312.335958005249, 4512.842050528216, 4556.134334476439, 4560.042391097841, 4569.702969307051, 4608.147492713859, 4490.730556166641, 4505.932411013838, 4556.954430455719, 4643.210654188796, 4682.555157260055, 4818.397700287464, 4837.854864353934, 4840.419149701988, 4875.34182885313, 4892.92660610084, 5113.181890897438, 5120.0, 5147.974260128675, 5149.871253218699, 5152.562032227303, 4697.060587882369, 4772.976135119302, 4854.781534831011, 4885.169521181337, 4889.266610008527, 5095.541401273903, 5102.08162530748, 5103.464136265638, 5119.539241468286, 5166.4058633257655, 5186.481351864783, 5187.533122019036, 5192.065428222805, 5198.142306519533, 5227.895442091213, 4935.087008903364, 4941.901161976813, 4960.751962401793, 4977.178765503651, 5029.723365214948, 4978.4523702393435, 4979.825706100414, 5001.474845141353, 5023.799048038038, 5037.7733002014265, 4948.851534453972, 4967.900641987212, 4969.652124351405, 4987.0, 5038.773255203598, 4920.31115643803, 5053.393592768891, 5107.106256405188, 5116.820911268088, 5201.843944681666, 4996.200607902718, 5012.699238045583, 5012.899742005213, 5020.297158397901, 5057.115004874206], "value": 4720.432795673658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.6340089336102, 575.9539236861054, 582.3652219081202, 602.5781952633155, 605.1769593353042, 34734.0055893572, 38231.0, 38764.41853372198, 38872.80563597182, 38901.41647875284, 39420.60579394205, 39479.60520394803, 39570.40644390336, 39826.004349891264, 40029.799851000775, 7748.263914928073, 7861.449698521106, 7871.0, 7872.29149376556, 7875.212478752108, 7745.728899488519, 7789.3768498519985, 7848.921510784905, 7862.646180921873, 7875.724349647763, 7821.921780782176, 7881.2118788121015, 7888.092869320016, 7905.881411778828, 7907.8418431631335, 7824.491408058487, 7868.409869259771, 7868.724594639189, 7878.527288362659, 7879.33025692811, 7704.191059938737, 7771.805704857367, 7772.183920688303, 7801.2198780121535, 7804.0, 37216.44175337372, 37386.62613373859, 37595.43606845899, 37607.81196094029, 37679.623203767886, 2997.4904266274784, 3037.4532584134845, 3075.9692403075906, 3176.6664500227607, 3343.9466568030994, 28634.713652863622, 29175.854120729473, 29178.41643167146, 29190.27024324388, 29743.553846692317, 3390.69483746464, 3419.6238413774463, 3431.2965842002577, 3458.1008937676384, 3475.09647491654, 246531.0, 246733.0, 247602.0, 247756.0, 248826.9999999982, 31786.364272714418, 50718.492815071375, 51245.48754512407, 51289.23066154011, 51378.0, 31774.2056448586, 33597.49603755945, 33618.0, 33779.49330760041, 33881.491777623356, 13420.0, 13480.191188528719, 13499.122557033957, 13580.38888250031, 13582.728345433035, 11047.779044419067, 11062.22564420483, 11084.168687348481, 11096.889031109748, 11149.219554631098, 7798.805029874298, 7894.763157105296, 7902.644381002869, 7957.880631790527, 8007.559584222807, 3118.656947735747, 3160.3679264147263, 3161.6206055273515, 3173.222560472699, 3177.7616678749187, 905.1988989743992, 952.7141857442739, 1022.6318525330875, 1047.2250534604339, 1058.9576416943237, 27931.72068279332, 27958.86020569925, 27970.58044129299, 28357.574636380472, 28425.857870710515, 882.342654722236, 964.7491652170486, 1023.3859684189426, 1065.7229120428744, 1074.0762943868267, 14396.136231826124, 14445.566633001026, 14639.634009149857, 14896.329665165094, 15033.0, 372133.0, 373793.0, 376380.0, 376466.0, 376861.0, 48199.27701084487, 48455.5154448451, 48579.757101214265, 48712.269315960286, 49050.0, 1188.8216767484773, 1192.2607983050564, 1204.5061524774626, 1221.6335099470123, 1231.5012419969926, 25903.352416189748, 26832.19503414901, 27253.86373068122, 27564.448711026067, 27791.16626501208, 42256.15487690167, 42560.78719606506, 42579.0, 42635.14729705326, 42664.146717066105, 314932.0, 319249.0, 319329.0, 320573.0, 320942.0, 25228.369290767878, 25249.747502525475, 25518.617220741333, 25522.489550209262, 25557.616635750106, 41337.1732565353, 42515.787421063935, 42539.787301064534, 42988.78505607452, 43418.13163736771, 36045.27909441849, 36739.816300919396, 36764.816175918946, 36939.0, 37212.0, 36034.63965360418, 37102.44346334753, 37183.256334873695, 37235.255294894494, 37541.4368784463, 35698.8215058923, 35967.460488092176, 36361.0, 36379.09052273714, 36646.08384790295, 31632.367352653277, 32347.589626696757, 32721.0, 32722.23694275189, 33858.49212261769, 25329.74670253274, 25570.744292556836, 25688.8715556421, 25919.74080259249, 25998.35004124912], "value": 16492.270560053785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.99260014799705, 370.31306925652905, 373.46407904656803, 389.77587886964983, 390.5918315360448, 15647.139407332606, 16088.115153666558, 17100.401485947994, 17102.914485427555, 17140.22868970896, 15460.768088478682, 15743.291551880164, 16379.91810040948, 16407.91796041018, 16441.588960276, 5051.09080365535, 5221.399539053001, 5251.186066159751, 5264.894702105956, 5275.208718692188, 5064.113780088488, 5126.769295381698, 5176.611754118438, 5178.7669554869935, 5182.689038657692, 5385.515303622673, 5449.155380915945, 5485.835424937259, 5488.259085023511, 5489.4236105208975, 5428.75570599322, 5444.183372494138, 5449.809256676017, 5615.2700148980775, 5622.690752008638, 5380.0, 5394.1908713692865, 5403.675779453245, 5417.59368047394, 5456.290682211287, 12793.55222567215, 17674.734878976826, 17810.753247272696, 18547.536311592183, 18779.906100469547, 1782.6612943540686, 1802.6845302072215, 1926.8651194416395, 1989.631918095157, 2016.485796121994, 9330.891814312621, 9462.57418416173, 11064.446777661165, 11646.76706465866, 12449.439775210138, 1765.4350607805507, 1773.9645207095914, 1775.7691500104904, 1792.8655350848608, 1822.2893071702047, 67721.66139169323, 68552.65723671399, 68670.65664671695, 69077.65461172712, 69888.0, 9671.371360861522, 9703.757406064764, 10152.49237538135, 10192.745181370377, 10324.07083362501, 14153.504627337994, 14199.36102875373, 14242.216678082805, 14273.072250303698, 14294.928525357307, 6893.655317234218, 6894.379505844498, 7098.787036388917, 7118.394936430358, 7304.5982470963545, 6525.053867189231, 6600.108985287021, 6627.1716035495565, 6670.533062685662, 6822.727090916308, 4379.080393117417, 4392.077663690597, 4417.094495628388, 4431.091626216617, 4453.777311134495, 1821.826926441986, 1833.1475863723433, 1837.9816201838078, 1882.7458293130526, 1892.0728842867172, 863.1929146248152, 886.5345693510958, 896.4173287363266, 898.7169041751828, 959.0936564946059, 15084.019538730166, 15815.525534233991, 16113.194340282938, 16769.56841258011, 17016.149192540324, 854.8076682746332, 857.4169564696067, 876.8728534362482, 894.186290475677, 897.0312062971975, 8937.776555586162, 9086.954565227265, 9194.0, 9349.15857572808, 9551.14039736427, 396260.0, 405513.0, 407931.0, 409727.0, 411333.0, 73891.26108738952, 76293.61853190699, 76535.0, 76781.61609191919, 77320.0, 882.5057967538199, 897.210454799772, 917.4403514026183, 919.5586118662945, 957.5499515227832, 14951.401943922556, 15310.15794131289, 15451.84548154504, 15478.0, 15963.600909977344, 32104.518432224002, 37130.44304335491, 37895.81052094722, 38532.807335964266, 38782.224355513295, 45725.54274457213, 46212.7689361551, 48683.0, 50404.24393634025, 50741.746291268304, 7757.224277572198, 7841.333486653698, 7901.17037711032, 7915.683372665259, 7997.320227780471, 11315.321080735182, 12047.156699030984, 12091.153619246568, 12175.695607609881, 12425.440855161358, 7436.810110382313, 10538.051575358255, 10589.311694739818, 10609.098226650822, 10667.199960003187, 10522.736931576772, 10649.840252396376, 10735.516901739597, 10836.13310935139, 10968.0, 10673.972274618987, 10686.465676715978, 10740.755459296115, 10743.677689669323, 11056.944715276371, 6721.092652491851, 6973.3375329343635, 7295.270472952662, 7948.244916732901, 8266.504009759434, 10293.794124117327, 10412.271141020055, 10582.100521455763, 10621.575136994434, 10628.787424251626], "value": 8209.754179297355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.699917518558, 1413.9395453409943, 1463.6853076588538, 1639.1886016421872, 1641.7044931912267, 6875.828104297395, 7354.852902941938, 7612.391008719296, 8112.0, 8121.350291976642, 7398.0, 7537.208593097728, 7684.500507467011, 7706.4990775599545, 7716.498427602216, 2202.702635144251, 2251.2570851618925, 2256.571251462225, 2259.5819773341987, 2262.66060090986, 2156.687280344357, 2175.8585691929975, 2214.30249471416, 2216.2907869481774, 2218.7670294619074, 2177.586258610867, 2196.53872686736, 2218.4897473581086, 2227.610168220563, 2237.2617036377956, 2128.978710212901, 2139.187108898624, 2145.120500594764, 2147.0552956699003, 2149.516358819253, 2111.2505060703384, 2127.7765834587453, 2156.482444213393, 2156.590247852903, 2158.0504577985794, 7716.112647045606, 7777.0, 7797.259260370312, 7847.0975837778815, 7865.331446827026, 4622.168009758242, 4708.788104535304, 4717.905641887143, 4725.1730947084125, 4746.596539294164, 2817.9859100704366, 2885.422915416925, 2972.9554056689167, 2974.985125074361, 2983.6270466191727, 891.7057371067597, 897.1880448194395, 919.9172074513259, 927.6057675487958, 933.9533023348805, 10310.226732995055, 10531.526081326281, 10538.209634277384, 10638.095761860252, 10652.893471065345, 4148.377743338463, 4272.935905961351, 4304.440422745023, 4355.477342718831, 4393.231184542692, 8993.595288212045, 9009.954950225338, 9011.63953441855, 9013.008569057398, 9018.909810901938, 4647.465541462775, 4649.093426781813, 4708.176069187878, 4734.621230301636, 4786.44955830084, 3870.2259548089933, 4099.549049604541, 4228.1966426378885, 4287.97856010718, 4362.76004819738, 3702.5371828521434, 3770.415585584184, 3804.4483549885667, 3816.885493435201, 3860.575336712959, 1226.8711785262597, 1262.0282382565374, 1264.2477725753163, 1265.5697062998624, 1275.3878138493576, 676.1574708918158, 818.2472125644422, 826.7767702720232, 827.2554700769356, 829.266099501933, 4970.62720295972, 5101.642884998015, 5104.948950510522, 5127.5897928166405, 5281.023010742948, 785.9664541128398, 804.5213098206558, 833.441594131933, 838.9286910612544, 884.5754038061766, 3530.293941211768, 3537.964620353815, 3615.9638403616154, 3617.186133120027, 3673.6142705016123, 9329.813403732023, 9404.059594040678, 9634.518274086267, 9652.75868103303, 9688.660896868716, 9601.135897769234, 9640.662576809778, 9666.275029372826, 9678.95160524193, 9679.612815487302, 7125.073740413816, 7131.96434017837, 7214.134303883568, 7215.098112735908, 7276.235995220532, 5298.0, 5346.893062138658, 5368.2484452177505, 5370.543503802221, 5455.727213639223, 8735.912640873765, 8842.204201621886, 8940.5082720451, 9122.224610907882, 9145.0, 8506.0, 8832.955835220782, 8835.779105522413, 8993.190612844875, 8993.32550058735, 5932.466078052996, 6436.645984470899, 6649.867002659823, 6767.1879374475375, 6915.619640919596, 7485.326320630951, 7485.625718713934, 7499.2500749924575, 7503.4372422069655, 7531.8117047074265, 6633.701483433354, 6763.560368576027, 6850.588964662136, 6865.862682746417, 6955.826104347432, 6620.337966203341, 6631.33686631333, 6671.232808226922, 6716.328367163244, 6790.354916282945, 6115.1438798569125, 6130.846728831815, 6209.906851397142, 6226.346233645402, 6256.499480041677, 4175.812088455966, 4219.957800421957, 4235.95764042368, 4265.338872474771, 4290.206311832321, 4327.891802704831, 4333.068390295975, 4394.736315821061, 4403.5596440356985, 4447.577480139382], "value": 4125.2367133299795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9866805993731, 302.61567808882717, 303.8177093743754, 312.45008784539203, 316.85583059707835, 5044.445111037788, 5061.139606266935, 5062.038212739577, 5067.163917953542, 5079.492050794918, 4963.205887058071, 4971.900561988758, 4984.327115839361, 4989.351384320043, 4999.3000979862845, 3954.209158168371, 3970.7617542947514, 3972.245273398045, 3983.1635356575152, 3989.68082553395, 3645.2709458108484, 3908.335582950891, 3917.5494818096, 4008.959910400888, 4013.097053163044, 3865.362215234497, 3865.594112618177, 3867.284552357823, 3873.2447172801317, 3875.2830726315583, 3849.2878817418587, 3876.573576906538, 3882.611738826123, 3907.1208977980014, 3919.549251836047, 3210.2776875203126, 3298.8289157349036, 3395.2869897321593, 3403.353362861073, 3403.846826892796, 4869.56347877377, 4920.6801557898625, 4925.458199598042, 4927.294433815733, 4927.926081108786, 4395.670324725658, 4447.577480139382, 4448.865539287461, 4452.243118669834, 4461.906832825946, 5034.672746271481, 5206.713630750307, 5208.609354298443, 5221.895562088775, 5287.180487024518, 3651.908702282438, 3690.206605579813, 3711.2577484502935, 3712.1833196696684, 3741.56971948224, 5377.220303056035, 5406.83779486616, 5415.945840541623, 5431.538319242869, 5442.707162166911, 3612.6387361263664, 3736.5702944161226, 3742.6234341192994, 3763.49192858966, 3786.2995345861104, 3782.2813665404037, 3782.8084153491563, 3796.8291426885858, 3798.525184351956, 3808.847646094125, 4368.388425620416, 4377.606015458624, 4392.165488557164, 4402.5597440255715, 4427.645788336926, 4916.410030796256, 5160.974195129001, 5245.1607742761735, 5301.0, 5310.822562749254, 1328.6877583767807, 1344.475654494748, 1345.896364980726, 1346.337273467267, 1349.1500354776624, 816.8366326734676, 829.1418381974627, 840.1010918317342, 844.5861527851308, 851.8126012277289, 4226.556211597799, 4260.850870219528, 4263.59495847894, 4264.82717252758, 4273.444452221253, 4818.71087734737, 4832.226843704991, 4902.411710594752, 4907.282451142143, 4921.481140984213, 4221.746695198298, 4224.655316299483, 4238.4490016298305, 4246.426732391088, 4251.957480425218, 2489.863057531817, 2642.7621514063826, 2649.443616840485, 2806.6070750095005, 2811.831290122599, 5006.89986200274, 5087.592992560661, 5092.872678183075, 5117.616178786606, 5123.181270648941, 5506.752196151183, 5513.393526712059, 5522.5581953443625, 5537.8061767837935, 5568.693721845338, 4876.780544875489, 5040.0, 5071.7971281149075, 5073.543381095719, 5092.3335198656905, 5388.353397592157, 5398.514133727984, 5461.0, 5464.289642346628, 5487.451254874481, 5237.397699264633, 5257.4216836147225, 5259.0, 5264.15773476242, 5274.683518988873, 4886.169351210232, 5007.549320561167, 5065.214891691794, 5070.949290507047, 5092.872678183075, 3703.407534760079, 3756.6619004289746, 3768.792716400624, 3779.7921114337873, 3787.4886890269463, 5373.247745315737, 5379.65032272901, 5410.3778065522965, 5428.430014848384, 5434.358979483676, 5016.197408414782, 5142.6400151989, 5160.612954028388, 5209.2809372906095, 5214.947850521598, 5170.741462926914, 5174.430812610685, 5198.090334191577, 5199.688018718889, 5203.401608814884, 5080.669756465818, 5083.237514372874, 5106.310648062613, 5106.412762532208, 5185.325907631984, 5273.6572122811895, 5277.525022747971, 5278.841634750964, 5296.285001524745, 5315.973420132875, 5116.232565115262, 5133.486651334837, 5144.897102057863, 5182.792688292426, 5185.42960274377], "value": 3894.2736869412092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.7968650031988, 670.3263220463436, 730.3135053050129, 733.9816504587385, 760.8364201696636, 11843.289402635837, 12753.808692869614, 12910.419031143598, 13075.54235601754, 13515.729685406286, 11606.59376921808, 11691.649250522476, 11719.238249513775, 11731.765364692701, 11765.882341176586, 620.6834514397667, 767.93088622024, 774.1329710723998, 795.2326005404783, 796.6733639207926, 787.5707739282076, 793.2226418110256, 794.3883209928351, 794.8529522038441, 796.3191471292049, 825.3685930263354, 829.1501211258447, 829.4235506323108, 831.7463173732009, 833.6165363932598, 821.8972628421448, 822.9670813167467, 825.5542007316072, 825.8183199696057, 827.6275675945849, 601.4406601860268, 604.5163868904858, 604.8518113062283, 605.8303674970971, 607.5504126946072, 12840.871591284062, 12905.806412903814, 12936.223826570342, 12986.610401687965, 13008.414621341968, 13549.254790986492, 13845.446182152702, 13859.861401385959, 13921.23433211173, 13998.93000535001, 10149.340292881014, 10181.440020798853, 10271.7432064199, 10803.4058126803, 11011.339319640767, 4325.243082460588, 4365.912681746379, 4381.452318460192, 4389.363542286383, 4512.977435112836, 56220.15669764957, 56265.71867140638, 56350.71824640891, 56475.71762141204, 56790.71604641992, 10538.841917371246, 10735.0, 10780.0, 10867.152584060728, 10952.397618131079, 18886.150123244486, 18906.52733681669, 18922.3377181798, 18943.336983205798, 18950.336738214373, 6979.93020069803, 7049.224585295613, 7080.256573059857, 7201.89197162043, 7224.169220539705, 3822.3310920588788, 3879.650831425185, 3887.8056097195026, 3923.725339226227, 4055.3511438169753, 2929.6923822998706, 3003.6996300370224, 3005.218643152796, 3012.141539661186, 3023.576699262105, 484.0609218116842, 497.7411745892188, 502.5803454115854, 506.08651384251044, 514.2209552527924, 454.75443260638883, 527.6095689189972, 568.0938902450584, 588.2294194604996, 599.8710277290404, 6892.847017393702, 7197.0, 7295.306945840137, 7298.854022919618, 7398.852022959511, 526.8472143078541, 553.6429003292934, 553.8166372451614, 561.1526594841819, 580.8112363481886, 3400.6939375456327, 3418.384690755638, 3440.724742020632, 3441.4493681011418, 3508.754387192923, 59490.0, 83951.0, 85473.57263213769, 85783.14216857751, 90806.0, 49132.50867491351, 62396.68801655962, 78625.0, 80654.59672701717, 81199.59400202961, 45936.770316148875, 60522.092168617506, 62022.797720227616, 62060.68969655123, 72156.63921680358, 7749.070111586646, 7775.961120194363, 7851.097123830604, 7878.139820397745, 8061.87907181381, 37274.440883386225, 39698.206035879695, 40234.79882600568, 40320.0, 40377.596224037385, 51766.74116629393, 58124.41875581359, 60579.394206057375, 62017.069743952976, 62910.0, 11153.219274650697, 11195.72010699739, 11315.603953861575, 11535.192536522363, 11793.174477786473, 12086.456109474919, 12593.622191334274, 13169.934150329187, 13484.12353197039, 13883.930580347034, 11151.163662725166, 11253.437328133725, 11279.492422841156, 11530.59642912494, 11704.180707350404, 11594.826077609012, 11702.531898723955, 11708.765824683629, 11772.882271177179, 12616.306103164414, 11028.062614677843, 11178.329300242012, 11554.422278885853, 11739.882601173878, 11922.52309907594, 9963.25275604318, 10087.69736907894, 10408.995821097296, 10662.360258384522, 10728.946355268174, 9498.572564234764, 9976.401415915068, 9997.250206234416, 10029.799404012025, 10071.143952764098], "value": 6421.977547066809, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 116.0, 115.0, 114.0, 116.0, 115.0, 118.0, 117.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 139.0, 164.0, 180.0, 133.0, 157.0, 153.0, 133.0, 198.0, 141.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 173.0, 163.0, 164.0, 163.0, 164.0, 165.0, 164.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 184.0, 77.0, 76.0, 74.0, 83.0, 170.0, 78.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 144.0, 88.0, 87.0, 87.0, 130.0, 88.0, 86.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 118.0, 121.0, 118.0, 123.0, 122.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 150.0, 148.0, 149.0, 149.0, 151.0, 148.0, 146.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 62.0, 62.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 64.0, 64.0, 71.0, 68.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 85.0, 90.0, 86.0, 86.0, 92.0, 117.0, 89.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 133.0, 140.0, 133.0, 147.0, 133.0, 152.0, 137.0, 161.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 170.0, 167.0, 174.0, 168.0, 171.0, 174.0, 168.0, 167.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 69.0, 68.0, 67.0, 71.0, 67.0, 71.0, 71.0, 70.0], "value": 69.3, "unit": "score"}]}]} 02:22:50 INFO - Return code: 0 02:22:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:50 ERROR - # TBPL SUCCESS # 02:22:50 INFO - Running post-action listener: _resource_record_post_action 02:22:50 INFO - ##### 02:22:50 INFO - ##### Finished run-tests step (success) 02:22:50 INFO - ##### 02:22:50 INFO - Running post-run listener: _resource_record_post_run 02:22:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 535900160; Read time: 0; Write time: 464572 02:22:51 INFO - TinderboxPrint: CPU usage
13.5% 02:22:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:22:51 INFO - TinderboxPrint: I/O write bytes / time
535,900,160 / 464,572 02:22:51 INFO - TinderboxPrint: CPU idle
8,272.8 (86.5%) 02:22:51 INFO - TinderboxPrint: CPU user
1,234.7 (12.9%) 02:22:51 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237916160; Read time: 0; Write time: 245768 02:22:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 297254912; Read time: 0; Write time: 218764 02:22:51 INFO - Running post-run listener: _upload_blobber_files 02:22:51 INFO - Blob upload gear active. 02:22:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:51 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 02:22:51 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:51 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:52 INFO - (blobuploader) - INFO - Done attempting. 02:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:53 INFO - (blobuploader) - INFO - Done attempting. 02:22:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:57 INFO - (blobuploader) - INFO - Done attempting. 02:22:57 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:57 INFO - Return code: 0 02:22:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/568385326cf1de213199571dc7e6f12ac721e4357955ecf3de6778322ccaa58fe6dff52ba29ffafee20acabbdde58549f4bd9dd09415205dbfd720fbe29b639d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5986693e64ae2aba0e24a1665718f3fb219b3175665dda2835871b03af1640b1a2e02abca2ded84cff3531e2f2f8f1d3da9c0d5de839c4ca0553bea1f9c6b018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa960f508af5cf85f77c0bd4c744d47bbc20cae4a455561a605a8094bb2621ed6aa39bcf23cadf2af0a7b699fba9a2c9d84830494dc57abef661402416d11bc8"} 02:22:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:57 INFO - Contents: 02:22:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/568385326cf1de213199571dc7e6f12ac721e4357955ecf3de6778322ccaa58fe6dff52ba29ffafee20acabbdde58549f4bd9dd09415205dbfd720fbe29b639d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5986693e64ae2aba0e24a1665718f3fb219b3175665dda2835871b03af1640b1a2e02abca2ded84cff3531e2f2f8f1d3da9c0d5de839c4ca0553bea1f9c6b018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa960f508af5cf85f77c0bd4c744d47bbc20cae4a455561a605a8094bb2621ed6aa39bcf23cadf2af0a7b699fba9a2c9d84830494dc57abef661402416d11bc8"} 02:22:57 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:57 INFO - Copying logs to upload dir... 02:22:57 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.882552 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-11 02:22:56.767150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:22:56.774637) ========= 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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 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/Fx-Team-Non-PGO/sha512/568385326cf1de213199571dc7e6f12ac721e4357955ecf3de6778322ccaa58fe6dff52ba29ffafee20acabbdde58549f4bd9dd09415205dbfd720fbe29b639d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5986693e64ae2aba0e24a1665718f3fb219b3175665dda2835871b03af1640b1a2e02abca2ded84cff3531e2f2f8f1d3da9c0d5de839c4ca0553bea1f9c6b018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa960f508af5cf85f77c0bd4c744d47bbc20cae4a455561a605a8094bb2621ed6aa39bcf23cadf2af0a7b699fba9a2c9d84830494dc57abef661402416d11bc8"} build_url:https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/CSXIGGXJRDuDG1MogaavNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/568385326cf1de213199571dc7e6f12ac721e4357955ecf3de6778322ccaa58fe6dff52ba29ffafee20acabbdde58549f4bd9dd09415205dbfd720fbe29b639d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5986693e64ae2aba0e24a1665718f3fb219b3175665dda2835871b03af1640b1a2e02abca2ded84cff3531e2f2f8f1d3da9c0d5de839c4ca0553bea1f9c6b018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa960f508af5cf85f77c0bd4c744d47bbc20cae4a455561a605a8094bb2621ed6aa39bcf23cadf2af0a7b699fba9a2c9d84830494dc57abef661402416d11bc8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:22:56.799663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:22:56.800017) ========= 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=00204705a9daa57ed339a427000001b9-1465633734.343380-1847270645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:22:56.884267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:22:56.884585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:22:56.884950) ========= ========= Total master_lag: 0.22 =========