builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1464979129.08 results: success (0) buildid: 20160603110828 builduid: 2837e85c596949a799730c728d2ad59b revision: 1a72dc1810bc0170754b9fbf14a79e7f855346df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.077084) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.077886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.078189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.111890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.112198) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 11:38:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.1M=0s 2016-06-03 11:38:49 (25.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.203596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.203935) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.256445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.256829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a72dc1810bc0170754b9fbf14a79e7f855346df --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 1a72dc1810bc0170754b9fbf14a79e7f855346df --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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 11:38:49,323 truncating revision to first 12 chars 2016-06-03 11:38:49,324 Setting DEBUG logging. 2016-06-03 11:38:49,324 attempt 1/10 2016-06-03 11:38:49,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a72dc1810bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 11:38:49,707 unpacking tar archive at: fx-team-1a72dc1810bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.987152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.987483) ========= script_repo_revision: 1a72dc1810bc0170754b9fbf14a79e7f855346df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.987929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:49.988302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 11:38:50.000158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-03 11:38:50.000454) ========= /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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:50 INFO - MultiFileLogger online at 20160603 11:38:50 in /builds/slave/test 11:38:50 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 11:38:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:50 INFO - {'append_to_log': False, 11:38:50 INFO - 'base_work_dir': '/builds/slave/test', 11:38:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:38:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:50 INFO - 'branch': 'Fx-Team-Non-PGO', 11:38:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:50 INFO - 'config_files': ('talos/linux_config.py',), 11:38:50 INFO - 'default_actions': ('clobber', 11:38:50 INFO - 'read-buildbot-config', 11:38:50 INFO - 'download-and-extract', 11:38:50 INFO - 'populate-webroot', 11:38:50 INFO - 'create-virtualenv', 11:38:50 INFO - 'install', 11:38:50 INFO - 'run-tests'), 11:38:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:50 INFO - 'download_minidump_stackwalk': True, 11:38:50 INFO - 'download_symbols': 'ondemand', 11:38:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:50 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:50 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:50 INFO - 'installer_path': 'installer.exe', 11:38:50 INFO - 'log_level': 'info', 11:38:50 INFO - 'log_name': 'talos', 11:38:50 INFO - 'log_to_console': True, 11:38:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:50 INFO - 'opt_config_files': (), 11:38:50 INFO - 'pip_index': False, 11:38:50 INFO - 'sps_profile': False, 11:38:50 INFO - 'sps_profile_interval': 0, 11:38:50 INFO - 'suite': 'dromaeojs-e10s', 11:38:50 INFO - 'system_bits': '32', 11:38:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:50 INFO - 'title': 'talos-linux64-ix-002', 11:38:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:50 INFO - 'use_talos_json': True, 11:38:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:50 INFO - 'work_dir': 'build'} 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running clobber step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: clobber 11:38:50 INFO - rmtree: /builds/slave/test/build 11:38:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - ##### 11:38:50 INFO - ##### Finished clobber step (success) 11:38:50 INFO - ##### 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running read-buildbot-config step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: read_buildbot_config 11:38:50 INFO - Using buildbot properties: 11:38:50 INFO - { 11:38:50 INFO - "project": "", 11:38:50 INFO - "product": "firefox", 11:38:50 INFO - "script_repo_revision": "production", 11:38:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:38:50 INFO - "repository": "", 11:38:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:38:50 INFO - "buildid": "20160603110828", 11:38:50 INFO - "pgo_build": "False", 11:38:50 INFO - "basedir": "/builds/slave/test", 11:38:50 INFO - "buildnumber": 1553, 11:38:50 INFO - "slavename": "talos-linux64-ix-002", 11:38:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:38:50 INFO - "platform": "ubuntu64_hw", 11:38:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:38:50 INFO - "branch": "fx-team", 11:38:50 INFO - "repo_path": "integration/fx-team", 11:38:50 INFO - "revision": "1a72dc1810bc0170754b9fbf14a79e7f855346df", 11:38:50 INFO - "stage_platform": "linux64", 11:38:50 INFO - "builduid": "2837e85c596949a799730c728d2ad59b", 11:38:50 INFO - "slavebuilddir": "test" 11:38:50 INFO - } 11:38:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - ##### 11:38:50 INFO - ##### Finished read-buildbot-config step (success) 11:38:50 INFO - ##### 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running download-and-extract step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: download_and_extract 11:38:50 INFO - mkdir: /builds/slave/test/build/tests 11:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:50 INFO - https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:38:51 INFO - Downloaded 1361 bytes. 11:38:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:38:51 INFO - Using the following test package requirements: 11:38:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:38:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'jsshell-linux-x86_64.zip'], 11:38:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:38:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:38:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:51 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')]} 11:38:51 INFO - https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:56 INFO - Downloaded 22868152 bytes. 11:38:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:38:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:38:57 INFO - Return code: 0 11:38:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:57 INFO - https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:39:03 INFO - Downloaded 22868152 bytes. 11:39:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:39:05 INFO - Return code: 0 11:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:05 INFO - https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:39:06 INFO - Downloaded 10833369 bytes. 11:39:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:39:06 INFO - Return code: 0 11:39: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')]} 11:39:06 INFO - https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:39:07 INFO - Downloaded 55177539 bytes. 11:39:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:39:07 INFO - mkdir: /builds/slave/test/properties 11:39:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:07 INFO - Contents: 11:39:07 INFO - build_url:https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:39:08 INFO - Running post-action listener: _resource_record_post_action 11:39:08 INFO - Running post-action listener: set_extra_try_arguments 11:39:08 INFO - ##### 11:39:08 INFO - ##### Finished download-and-extract step (success) 11:39:08 INFO - ##### 11:39:08 INFO - ##### 11:39:08 INFO - ##### Running populate-webroot step. 11:39:08 INFO - ##### 11:39:08 INFO - Running pre-action listener: _resource_record_pre_action 11:39:08 INFO - Running main action method: populate_webroot 11:39:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:08 INFO - '--tppagecycles', 11:39:08 INFO - '7'], 11:39:08 INFO - 'tests': ['tsvgm']}}, 11:39:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['damp', 'tps']}, 11:39:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'tests': ['damp', 'tps']}, 11:39:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['dromaeo_dom']}, 11:39:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['a11yr', 11:39:08 INFO - 'ts_paint', 11:39:08 INFO - 'tpaint', 11:39:08 INFO - 'sessionrestore', 11:39:08 INFO - 'sessionrestore_no_auto_restore', 11:39:08 INFO - 'tabpaint']}, 11:39:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['tsvgx', 11:39:08 INFO - 'tsvgr_opacity', 11:39:08 INFO - 'tart', 11:39:08 INFO - 'tscrollx', 11:39:08 INFO - 'cart']}, 11:39:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:08 INFO - 'tsvgr_opacity', 11:39:08 INFO - 'tart', 11:39:08 INFO - 'tscrollx', 11:39:08 INFO - 'cart']}, 11:39:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'talos_options': ['--disable-e10s'], 11:39:08 INFO - 'tests': ['tp5o']}, 11:39:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'tests': ['tp5o']}, 11:39:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'talos_options': ['--disable-e10s', 11:39:08 INFO - '--xperf_path', 11:39:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:08 INFO - 'tests': ['tp5n']}, 11:39:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:08 INFO - 'talos_options': ['--xperf_path', 11:39:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:08 INFO - 'tests': ['tp5n']}}, 11:39:08 INFO - 'talos.zip': {'path': '', 11:39:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:08 INFO - Running post-action listener: _resource_record_post_action 11:39:08 INFO - ##### 11:39:08 INFO - ##### Finished populate-webroot step (success) 11:39:08 INFO - ##### 11:39:08 INFO - ##### 11:39:08 INFO - ##### Running create-virtualenv step. 11:39:08 INFO - ##### 11:39:08 INFO - Running pre-action listener: _resource_record_pre_action 11:39:08 INFO - Running main action method: create_virtualenv 11:39:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:08 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 11:39:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:08 INFO - Using real prefix '/usr' 11:39:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:11 INFO - Installing pip.................done. 11:39:11 INFO - Return code: 0 11:39:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:11 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 11:39:11 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 11:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:11 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 11:39:11 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:11 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 11:39:11 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 11:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:11 INFO - Downloading/unpacking psutil>=3.1.1 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:13 INFO - Installing collected packages: psutil 11:39:13 INFO - Running setup.py install for psutil 11:39:13 INFO - building 'psutil._psutil_linux' extension 11:39:13 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 11:39:13 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 11:39:13 INFO - building 'psutil._psutil_posix' extension 11:39:13 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 11:39:14 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 11:39:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:14 INFO - Successfully installed psutil 11:39:14 INFO - Cleaning up... 11:39:14 INFO - Return code: 0 11:39:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:14 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')]} 11:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:14 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')]} 11:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:14 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:14 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 11:39:14 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 11:39:14 INFO - Using env: {'DISPLAY': ':0', 11:39:14 INFO - 'HOME': '/home/cltbld', 11:39:14 INFO - 'LANG': 'en_US.UTF-8', 11:39:14 INFO - 'LANGUAGE': 'en_US:en', 11:39:14 INFO - 'LOGNAME': 'cltbld', 11:39:14 INFO - 'MAIL': '/var/mail/cltbld', 11:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:14 INFO - 'MOZ_NO_REMOTE': '1', 11:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:14 INFO - 'NO_EM_RESTART': '1', 11:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:14 INFO - 'PWD': '/builds/slave/test', 11:39:14 INFO - 'SHELL': '/bin/bash', 11:39:14 INFO - 'SHLVL': '1', 11:39:14 INFO - 'TERM': 'linux', 11:39:14 INFO - 'TMOUT': '86400', 11:39:14 INFO - 'USER': 'cltbld', 11:39:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:14 INFO - '_': '/tools/buildbot/bin/python'} 11:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:16 INFO - Installing collected packages: mozsystemmonitor 11:39:16 INFO - Running setup.py install for mozsystemmonitor 11:39:16 INFO - Successfully installed mozsystemmonitor 11:39:16 INFO - Cleaning up... 11:39:16 INFO - Return code: 0 11:39:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:16 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 11:39:16 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 11:39:16 INFO - Using env: {'DISPLAY': ':0', 11:39:16 INFO - 'HOME': '/home/cltbld', 11:39:16 INFO - 'LANG': 'en_US.UTF-8', 11:39:16 INFO - 'LANGUAGE': 'en_US:en', 11:39:16 INFO - 'LOGNAME': 'cltbld', 11:39:16 INFO - 'MAIL': '/var/mail/cltbld', 11:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:16 INFO - 'MOZ_NO_REMOTE': '1', 11:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:16 INFO - 'NO_EM_RESTART': '1', 11:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:16 INFO - 'PWD': '/builds/slave/test', 11:39:16 INFO - 'SHELL': '/bin/bash', 11:39:16 INFO - 'SHLVL': '1', 11:39:16 INFO - 'TERM': 'linux', 11:39:16 INFO - 'TMOUT': '86400', 11:39:16 INFO - 'USER': 'cltbld', 11:39:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:16 INFO - '_': '/tools/buildbot/bin/python'} 11:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:18 INFO - warning: no files found matching '*.txt' 11:39:18 INFO - no previously-included directories found matching 'build' 11:39:18 INFO - no previously-included directories found matching 'dist' 11:39:18 INFO - no previously-included directories found matching '.git*' 11:39:18 INFO - Installing collected packages: jsonschema, functools32 11:39:18 INFO - Running setup.py install for functools32 11:39:18 INFO - warning: no files found matching '*.txt' 11:39:18 INFO - no previously-included directories found matching 'build' 11:39:18 INFO - no previously-included directories found matching 'dist' 11:39:18 INFO - no previously-included directories found matching '.git*' 11:39:18 INFO - Successfully installed jsonschema functools32 11:39:18 INFO - Cleaning up... 11:39:19 INFO - Return code: 0 11:39:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:19 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:19 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 11:39:19 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 11:39:19 INFO - Using env: {'DISPLAY': ':0', 11:39:19 INFO - 'HOME': '/home/cltbld', 11:39:19 INFO - 'LANG': 'en_US.UTF-8', 11:39:19 INFO - 'LANGUAGE': 'en_US:en', 11:39:19 INFO - 'LOGNAME': 'cltbld', 11:39:19 INFO - 'MAIL': '/var/mail/cltbld', 11:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:19 INFO - 'MOZ_NO_REMOTE': '1', 11:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:19 INFO - 'NO_EM_RESTART': '1', 11:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:19 INFO - 'PWD': '/builds/slave/test', 11:39:19 INFO - 'SHELL': '/bin/bash', 11:39:19 INFO - 'SHLVL': '1', 11:39:19 INFO - 'TERM': 'linux', 11:39:19 INFO - 'TMOUT': '86400', 11:39:19 INFO - 'USER': 'cltbld', 11:39:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:19 INFO - '_': '/tools/buildbot/bin/python'} 11:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:21 INFO - Downloading docopt-0.6.1.tar.gz 11:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:21 INFO - Running setup.py install for blobuploader 11:39:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:21 INFO - Running setup.py install for requests 11:39:22 INFO - Running setup.py install for docopt 11:39:22 INFO - Successfully installed blobuploader requests docopt 11:39:22 INFO - Cleaning up... 11:39:22 INFO - Return code: 0 11:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:22 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')]} 11:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:22 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')]} 11:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:22 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:22 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 11:39:22 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 11:39:22 INFO - Using env: {'DISPLAY': ':0', 11:39:22 INFO - 'HOME': '/home/cltbld', 11:39:22 INFO - 'LANG': 'en_US.UTF-8', 11:39:22 INFO - 'LANGUAGE': 'en_US:en', 11:39:22 INFO - 'LOGNAME': 'cltbld', 11:39:22 INFO - 'MAIL': '/var/mail/cltbld', 11:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:22 INFO - 'MOZ_NO_REMOTE': '1', 11:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:22 INFO - 'NO_EM_RESTART': '1', 11:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:22 INFO - 'PWD': '/builds/slave/test', 11:39:22 INFO - 'SHELL': '/bin/bash', 11:39:22 INFO - 'SHLVL': '1', 11:39:22 INFO - 'TERM': 'linux', 11:39:22 INFO - 'TMOUT': '86400', 11:39:22 INFO - 'USER': 'cltbld', 11:39:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:22 INFO - '_': '/tools/buildbot/bin/python'} 11:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:22 INFO - Running setup.py (path:/tmp/pip-QCgu9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:22 INFO - Running setup.py (path:/tmp/pip-CU0Ha8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:22 INFO - Running setup.py (path:/tmp/pip-FKWkLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:22 INFO - Running setup.py (path:/tmp/pip-jfbyh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:23 INFO - Running setup.py (path:/tmp/pip-D_6abg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:23 INFO - Running setup.py (path:/tmp/pip-ele8FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:23 INFO - Running setup.py (path:/tmp/pip-GyHt98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:23 INFO - Running setup.py (path:/tmp/pip-hZMnV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:23 INFO - Running setup.py (path:/tmp/pip-RvmBuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:23 INFO - Running setup.py (path:/tmp/pip-YXBL0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:23 INFO - Running setup.py (path:/tmp/pip-60Kfrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:23 INFO - Running setup.py (path:/tmp/pip-FOwa0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:23 INFO - Running setup.py (path:/tmp/pip-EOpdC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:23 INFO - Running setup.py (path:/tmp/pip-mIhP_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:23 INFO - Running setup.py (path:/tmp/pip-pYse5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:23 INFO - Running setup.py (path:/tmp/pip-iCDbVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:23 INFO - Running setup.py (path:/tmp/pip-YFPXJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:23 INFO - Running setup.py install for manifestparser 11:39:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for mozcrash 11:39:24 INFO - Running setup.py install for mozdebug 11:39:24 INFO - Running setup.py install for mozdevice 11:39:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for mozfile 11:39:24 INFO - Running setup.py install for mozhttpd 11:39:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for mozinfo 11:39:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for mozInstall 11:39:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for mozleak 11:39:24 INFO - Running setup.py install for mozlog 11:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:24 INFO - Running setup.py install for moznetwork 11:39:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Running setup.py install for mozprocess 11:39:25 INFO - Running setup.py install for mozprofile 11:39:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Running setup.py install for mozrunner 11:39:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Running setup.py install for mozscreenshot 11:39:25 INFO - Running setup.py install for moztest 11:39:25 INFO - Running setup.py install for mozversion 11:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:25 INFO - Cleaning up... 11:39:25 INFO - Return code: 0 11:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:25 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:25 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 11:39:25 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 11:39:25 INFO - Using env: {'DISPLAY': ':0', 11:39:25 INFO - 'HOME': '/home/cltbld', 11:39:25 INFO - 'LANG': 'en_US.UTF-8', 11:39:25 INFO - 'LANGUAGE': 'en_US:en', 11:39:25 INFO - 'LOGNAME': 'cltbld', 11:39:25 INFO - 'MAIL': '/var/mail/cltbld', 11:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:25 INFO - 'MOZ_NO_REMOTE': '1', 11:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:25 INFO - 'NO_EM_RESTART': '1', 11:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:25 INFO - 'PWD': '/builds/slave/test', 11:39:25 INFO - 'SHELL': '/bin/bash', 11:39:25 INFO - 'SHLVL': '1', 11:39:25 INFO - 'TERM': 'linux', 11:39:25 INFO - 'TMOUT': '86400', 11:39:25 INFO - 'USER': 'cltbld', 11:39:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:25 INFO - '_': '/tools/buildbot/bin/python'} 11:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:25 INFO - Running setup.py (path:/tmp/pip-35H4f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:26 INFO - Running setup.py (path:/tmp/pip-YPJb1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:26 INFO - Running setup.py (path:/tmp/pip-GNvWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:26 INFO - Running setup.py (path:/tmp/pip-Peep3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:26 INFO - Running setup.py (path:/tmp/pip-ALXN2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:26 INFO - Running setup.py (path:/tmp/pip-gGnTaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:26 INFO - Running setup.py (path:/tmp/pip-X5413q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:26 INFO - Running setup.py (path:/tmp/pip-ulYwGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:26 INFO - Running setup.py (path:/tmp/pip-y4_b_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:26 INFO - Running setup.py (path:/tmp/pip-aRF8N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:26 INFO - Running setup.py (path:/tmp/pip-mZXfKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:26 INFO - Running setup.py (path:/tmp/pip-KsQcZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:26 INFO - Running setup.py (path:/tmp/pip-wa9SNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:26 INFO - Running setup.py (path:/tmp/pip-7bmy6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:26 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)) 11:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:26 INFO - Running setup.py (path:/tmp/pip-OCQrrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:27 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)) 11:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:27 INFO - Running setup.py (path:/tmp/pip-smWXOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:27 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)) 11:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:27 INFO - Running setup.py (path:/tmp/pip-70tRZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:27 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)) 11:39:27 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)) 11:39:27 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)) 11:39:27 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)) 11:39:27 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)) 11:39:27 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)) 11:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:29 INFO - Downloading blessings-1.6.tar.gz 11:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:29 INFO - Installing collected packages: blessings 11:39:29 INFO - Running setup.py install for blessings 11:39:29 INFO - Successfully installed blessings 11:39:29 INFO - Cleaning up... 11:39:29 INFO - Return code: 0 11:39:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:29 INFO - Reading from file tmpfile_stdout 11:39:29 INFO - Current package versions: 11:39:29 INFO - argparse == 1.2.1 11:39:29 INFO - blessings == 1.6 11:39:29 INFO - blobuploader == 1.2.4 11:39:29 INFO - docopt == 0.6.1 11:39:29 INFO - functools32 == 3.2.3-2 11:39:29 INFO - jsonschema == 2.5.1 11:39:29 INFO - manifestparser == 1.1 11:39:29 INFO - mozInstall == 1.12 11:39:29 INFO - mozcrash == 0.17 11:39:29 INFO - mozdebug == 0.1 11:39:29 INFO - mozdevice == 0.48 11:39:29 INFO - mozfile == 1.2 11:39:29 INFO - mozhttpd == 0.7 11:39:29 INFO - mozinfo == 0.9 11:39:29 INFO - mozleak == 0.1 11:39:29 INFO - mozlog == 3.2 11:39:29 INFO - moznetwork == 0.27 11:39:29 INFO - mozprocess == 0.22 11:39:29 INFO - mozprofile == 0.28 11:39:29 INFO - mozrunner == 6.11 11:39:29 INFO - mozscreenshot == 0.1 11:39:29 INFO - mozsystemmonitor == 0.3 11:39:29 INFO - moztest == 0.7 11:39:29 INFO - mozversion == 1.4 11:39:29 INFO - psutil == 3.1.1 11:39:29 INFO - requests == 1.2.3 11:39:29 INFO - wsgiref == 0.1.2 11:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:29 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:29 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 11:39:29 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 11:39:29 INFO - Using env: {'DISPLAY': ':0', 11:39:29 INFO - 'HOME': '/home/cltbld', 11:39:29 INFO - 'LANG': 'en_US.UTF-8', 11:39:29 INFO - 'LANGUAGE': 'en_US:en', 11:39:29 INFO - 'LOGNAME': 'cltbld', 11:39:29 INFO - 'MAIL': '/var/mail/cltbld', 11:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:29 INFO - 'MOZ_NO_REMOTE': '1', 11:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:29 INFO - 'NO_EM_RESTART': '1', 11:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:29 INFO - 'PWD': '/builds/slave/test', 11:39:29 INFO - 'SHELL': '/bin/bash', 11:39:29 INFO - 'SHLVL': '1', 11:39:29 INFO - 'TERM': 'linux', 11:39:29 INFO - 'TMOUT': '86400', 11:39:29 INFO - 'USER': 'cltbld', 11:39:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:29 INFO - '_': '/tools/buildbot/bin/python'} 11:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 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)) 11:39:29 INFO - Cleaning up... 11:39:29 INFO - Return code: 0 11:39:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39: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', 'jsonschema'] in /builds/slave/test/build 11:39: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 jsonschema 11:39:29 INFO - Using env: {'DISPLAY': ':0', 11:39:29 INFO - 'HOME': '/home/cltbld', 11:39:29 INFO - 'LANG': 'en_US.UTF-8', 11:39:29 INFO - 'LANGUAGE': 'en_US:en', 11:39:29 INFO - 'LOGNAME': 'cltbld', 11:39:29 INFO - 'MAIL': '/var/mail/cltbld', 11:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:29 INFO - 'MOZ_NO_REMOTE': '1', 11:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:29 INFO - 'NO_EM_RESTART': '1', 11:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:29 INFO - 'PWD': '/builds/slave/test', 11:39:29 INFO - 'SHELL': '/bin/bash', 11:39:29 INFO - 'SHLVL': '1', 11:39:29 INFO - 'TERM': 'linux', 11:39:29 INFO - 'TMOUT': '86400', 11:39:29 INFO - 'USER': 'cltbld', 11:39:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:29 INFO - '_': '/tools/buildbot/bin/python'} 11:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:30 INFO - Cleaning up... 11:39:30 INFO - Return code: 0 11:39:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:39:30 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')]} 11:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 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')]} 11:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 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 0x7f0585194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', '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 11:39:30 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 11:39:30 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 11:39:30 INFO - Using env: {'DISPLAY': ':0', 11:39:30 INFO - 'HOME': '/home/cltbld', 11:39:30 INFO - 'LANG': 'en_US.UTF-8', 11:39:30 INFO - 'LANGUAGE': 'en_US:en', 11:39:30 INFO - 'LOGNAME': 'cltbld', 11:39:30 INFO - 'MAIL': '/var/mail/cltbld', 11:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:30 INFO - 'MOZ_NO_REMOTE': '1', 11:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:30 INFO - 'NO_EM_RESTART': '1', 11:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:30 INFO - 'PWD': '/builds/slave/test', 11:39:30 INFO - 'SHELL': '/bin/bash', 11:39:30 INFO - 'SHLVL': '1', 11:39:30 INFO - 'TERM': 'linux', 11:39:30 INFO - 'TMOUT': '86400', 11:39:30 INFO - 'USER': 'cltbld', 11:39:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:30 INFO - '_': '/tools/buildbot/bin/python'} 11:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:30 INFO - Downloading/unpacking flake8 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:30 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 11:39:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:39:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:39:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:39:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:33 INFO - no previously-included directories found matching 'docs/_build' 11:39:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:39:33 INFO - Running setup.py install for pep8 11:39:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:33 INFO - no previously-included directories found matching 'docs/_build' 11:39:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:39:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:39:33 INFO - Cleaning up... 11:39:33 INFO - Return code: 0 11:39:33 INFO - Running post-action listener: _resource_record_post_action 11:39:33 INFO - Running post-action listener: _start_resource_monitoring 11:39:33 INFO - Starting resource monitoring. 11:39:33 INFO - ##### 11:39:33 INFO - ##### Finished create-virtualenv step (success) 11:39:33 INFO - ##### 11:39:33 INFO - ##### 11:39:33 INFO - ##### Running install step. 11:39:33 INFO - ##### 11:39:33 INFO - Running pre-action listener: _resource_record_pre_action 11:39:33 INFO - Running main action method: install 11:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:33 INFO - Reading from file tmpfile_stdout 11:39:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:33 INFO - Reading from file tmpfile_stdout 11:39:33 INFO - Output received: 11:39:33 INFO - Usage: mozinstall [options] installer 11:39:33 INFO - Options: 11:39:33 INFO - -h, --help show this help message and exit 11:39:33 INFO - -d DEST, --destination=DEST 11:39:33 INFO - Directory to install application into. [default: 11:39:33 INFO - "/builds/slave/test"] 11:39:33 INFO - --app=APP Application being installed. [default: firefox] 11:39:33 INFO - mkdir: /builds/slave/test/build/application 11:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:39:49 INFO - Reading from file tmpfile_stdout 11:39:49 INFO - Output received: 11:39:49 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:49 INFO - Running post-action listener: _resource_record_post_action 11:39:49 INFO - ##### 11:39:49 INFO - ##### Finished install step (success) 11:39:49 INFO - ##### 11:39:49 INFO - ##### 11:39:49 INFO - ##### Running run-tests step. 11:39:49 INFO - ##### 11:39:49 INFO - Running pre-action listener: _resource_record_pre_action 11:39:49 INFO - Running main action method: run_tests 11:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:49 INFO - Python 2.7.3 11:39:49 INFO - Return code: 0 11:39:49 INFO - grabbing minidump binary from tooltool 11:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:49 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 0x1e562e0>, '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 0x1dc2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:49 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 11:39:49 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 11:39:49 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 11:39:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:49 INFO - Return code: 0 11:39:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:39:50 INFO - Return code: 0 11:39:50 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/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:39:50 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/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 11:39:50 INFO - Using env: {'DISPLAY': ':0', 11:39:50 INFO - 'HOME': '/home/cltbld', 11:39:50 INFO - 'LANG': 'en_US.UTF-8', 11:39:50 INFO - 'LANGUAGE': 'en_US:en', 11:39:50 INFO - 'LOGNAME': 'cltbld', 11:39:50 INFO - 'MAIL': '/var/mail/cltbld', 11:39:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:50 INFO - 'MOZ_NO_REMOTE': '1', 11:39:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:50 INFO - 'NO_EM_RESTART': '1', 11:39:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:50 INFO - 'PWD': '/builds/slave/test', 11:39:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:50 INFO - 'SHELL': '/bin/bash', 11:39:50 INFO - 'SHLVL': '1', 11:39:50 INFO - 'TERM': 'linux', 11:39:50 INFO - 'TMOUT': '86400', 11:39:50 INFO - 'USER': 'cltbld', 11:39:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828', 11:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:50 INFO - '_': '/tools/buildbot/bin/python'} 11:39:50 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/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:39:50 INFO - mozversion application_buildid: 20160603110828 11:39:50 INFO - mozversion application_changeset: 1a72dc1810bc0170754b9fbf14a79e7f855346df 11:39:50 INFO - mozversion application_display_name: Nightly 11:39:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:50 INFO - mozversion application_name: Firefox 11:39:50 INFO - mozversion application_remotingname: firefox 11:39:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:39:50 INFO - mozversion application_vendor: Mozilla 11:39:50 INFO - mozversion application_version: 49.0a1 11:39:50 INFO - mozversion platform_buildid: 20160603110828 11:39:50 INFO - mozversion platform_changeset: 1a72dc1810bc0170754b9fbf14a79e7f855346df 11:39:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:39:50 INFO - mozversion platform_version: 49.0a1 11:39:50 INFO - using testdate: 1464979190 11:39:50 INFO - actual date: 1464979190 11:39:50 INFO - starting webserver on 'localhost:35660' 11:39:50 INFO - SUITE-START | Running 2 tests 11:39:50 INFO - TEST-START | dromaeo_css 11:39:50 INFO - operating with platform_type : linux_ 11:39:50 INFO - Initialising browser for dromaeo_css test... 11:39:50 INFO - TEST-INFO | started process 13963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgJ2peo/profile http://localhost:35660/getInfo.html) 11:39:55 INFO - PROCESS | 13963 | __metrics Screen width/height:1600/1200 11:39:55 INFO - PROCESS | 13963 | colorDepth:24 11:39:55 INFO - PROCESS | 13963 | Browser inner width/height: 1024/697 11:39:55 INFO - PROCESS | 13963 | __metrics 11:39:56 ERROR - PROCESS | 13963 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:39:57 INFO - TEST-INFO | 13963: exit 0 11:39:57 INFO - Browser initialized. 11:39:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:57 INFO - TEST-INFO | started process 14080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgJ2peo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:09 INFO - PROCESS | 14080 | RSS: Main: 168902656 11:40:09 INFO - PROCESS | 14080 | 11:40:58 INFO - PROCESS | 14080 | 1464979258861 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] 11:43:09 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35660/tests/dromaeo/cssquery-ext.html) 11:43:10 INFO - PROCESS | 14080 | RSS: Main: 171683840 11:43:10 INFO - PROCESS | 14080 | 11:46:12 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-ext.html (next: http://localhost:35660/tests/dromaeo/cssquery-jquery.html) 11:46:13 INFO - PROCESS | 14080 | RSS: Main: 170221568 11:46:13 INFO - PROCESS | 14080 | 11:49:15 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35660/tests/dromaeo/cssquery-mootools.html) 11:49:16 INFO - PROCESS | 14080 | RSS: Main: 171720704 11:49:16 INFO - PROCESS | 14080 | 11:52:18 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35660/tests/dromaeo/cssquery-prototype.html) 11:52:18 INFO - PROCESS | 14080 | RSS: Main: 169357312 11:52:18 INFO - PROCESS | 14080 | 11:55:21 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35660/tests/dromaeo/cssquery-yui.html) 11:55:22 INFO - PROCESS | 14080 | RSS: Main: 171585536 11:55:22 INFO - PROCESS | 14080 | 11:58:24 INFO - PROCESS | 14080 | Cycle 1(1): loaded http://localhost:35660/tests/dromaeo/cssquery-yui.html (next: http://localhost:35660/tests/dromaeo/cssquery-dojo.html) 11:58:25 INFO - PROCESS | 14080 | RSS: Main: 172417024 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | __start_tp_report 11:58:25 INFO - PROCESS | 14080 | _x_x_mozilla_page_load 11:58:25 INFO - PROCESS | 14080 | _x_x_mozilla_page_load_details 11:58:25 INFO - PROCESS | 14080 | |i|pagename|runs| 11:58:25 INFO - PROCESS | 14080 | |0;dojo.html;2683.0206974454322;2727.9318017049563;2737.014674717103;2746.2447826847615;2747.0385365122197;4751.762411879406;4755.381800365956;4790.856274311767;4837.419509658837;4884.145274576944;4681.204195286801;4738.881527961803;4751.976240118804;4756.28655701644;4781.928271075928;4332.415123958264;4425.77871106445;4438.178936896668;4446.244138496447;4446.955530444703;50.62412570524951;4229.027323715532;4331.9783401083105;4415.094905544372;4473.172463094338;4324.567543245682;4346.652267818583;4398.604125628709;4408.360787685768;4412.073464572443;4386.56134386562;4392.670549708752;4405.163019026407;4413.271810151321;4444.755538445384;4322;4345.456817897762;4351.347297905308;4355.7822108894425;4379.956200437987;4639.744814035227;4659.5573420525;4666.976665116653;4671.696339737906;4726.810927562893;5058.7976480940715;5107.055194788976;5110.105731496973;5122.795088196468;5163.793448262065;4994.550490455877;5137.3064636274;5178.896422071537;5186.974065129688;5214.739263036833;4869.6591238612955;4879.194932836078;4884.145274576935;4888.340074090023;4936.531029552187;5136.049830781242;5334.466553344712;5336.759845806948;5341.145416733304;5356.062689029404;5039.823606173766;5089.338386009795;5096.490350964948;5117.104506711311;5118.38579370478;5184.844454666366;5214.45248248936;5214.6610470320065;5218.269442278084;5277.9472205278225;4964.15609346412;5103.795848166106;5153.6907785532985;5162.380514338303;5167.431582525919;5062.164742817467;5069.188929771219;5092.134337162691;5093.388793344822;5113.335266415343;4327.069680018811;4340.674449416307;4340.804663790137;4383.846565370261;4415.580519850609;3741.345264578688;3782.451544526028;3796.962030379716;3824.4263360495593;3834.884953451401;4330.198913201068;4365.432493775852;4424.203643344229;4468.50846406895;4470.731756094645;5146.0479811235045;5167.767450464738;5179.430262671103;5185.611079169077;5219.269302297681;4330.28550289205;4414.536473670282;4431.40176076232;4466.955330446719;4472.888177795581;4613.754286342669;4630.58324750774;4632.86101416958;4661.673682842168;4696.694714843524;4821.2045012573235;4856.975715121473;4867.488913664014;4883.121038213156;4924.458309586014;4982.7508624569355;5126.79492820283;5172.741362931763;5174.120399532013;5195.19474481456;4799.184138696361;4852.053849499455;4853.159536408656;4873.415190177201;4894.143524883202;5044.596432285335;5095.847124586268;5100.158473851921;5108.770105345194;5146.614003949644;5015.699058056528;5125.8718532037;5175.534201921845;5196.53231209193;5216.791328346823;5032.949670503248;5042.268871013609;5062.974685126551;5071.847844564669;5121.436641969306;4862.294967229803;5027.899442011066;5055.418626857811;5057.570106540838;5065.949340506548;4872.3909511311085;4888.780004899859;4944.357233559758;4952.232403977389;4960.727160006234;5064.949350506447;5080.695158290514;5091.923621145612;5110.463401342806;5112.71880046601;4775.06886157196;4802.303665968345;4947.925781113358;4955.1576232039915;5013.949860501349 11:58:25 INFO - PROCESS | 14080 | |1;ext.html;544.4229117135836;599.7810799058344;603.008051754863;611.9663418511982;617.966011869347;34390;38763.80618096913;38994.41508377377;39141;39246.21507569847;39888.202235955265;40261.99345016376;40423.797881010556;40469.19061618766;40564.39153412701;7693.7307194248215;7865.724699635514;7876.684932602689;7899.526028438283;7905.486143400689;7663.655135518915;7757.961210193941;7758.14660387357;7759;7759.5344279343135;7741.806454838646;7749.147593764681;7753.418493612973;7755.379569634444;7757.806054848617;7697.384209263273;7721.996140501727;7736.265054819812;7736.574488403136;7737.342325902248;7719.3052625263435;7755.224477552256;7793.220677932161;7805.024371953506;7820.648070836826;29599.556006659917;37298;37669.81165094157;37704.24591508182;37748.433773493416;2883.1206482022976;2896.0877323643194;2965.184574242079;2986.5072263076568;3448.9310213795834;28247.152585422264;28694.569581456293;29061;29061.85469072641;29571.408571828444;3028.9394212115853;3101.131683128705;3101.4417404867113;3137.921551961196;3158.3209609933747;252026.0980426457;254334;254533.09134180215;255009.99999999814;256056;55982.44017559854;56736;56833.71583142058;56834.431655682914;56942.71528642413;33554.49668254978;34374.31251374959;34477.655223447946;36682.8165859169;36746.44880326797;13448.46206151743;13489.865101349058;13530.594082177551;13575.117617355038;13615.931920340336;10705.250632455653;10728;10778.461076946121;10812.513436895359;10813.18901082422;18828.623427531373;18948.81051189498;18974.620507590047;19061.142248598848;19100.713489297672;6992.440604751608;6998.160220773438;7025.89461158083;7112.14654241484;7248.782536523912;830.7632324787406;874.8556488179506;933.8132373525186;960.582146766159;977.4330888084894;27066;27805.59499788265;27821.16536503908;27895.16314510568;28256.8587157067;985.3545927417553;997.680742162501;1006.1347241372414;1016.207358260558;1032.9380237185642;14698.33857476416;15196.848031519543;15214.695706085817;15302;15406.614834629225;389687;390998;392530;394580;396854;49031.75484122628;49550.75224623854;49575.256371154464;49681;49738.25392619114;1197.2946028891458;1201.2552217624955;1226.6810629236463;1236.9196002259823;1246.4266437438698;26629.733702662725;27516.58725119165;27833.44333113367;28018.579721303788;28502.144935651962;44150.33774493449;44228;44403.33394999142;44591.77704111459;44723;324145;325437;325936;326369;327212;25499.6175057378;26003.73996260089;26035.869820650776;26191.738082619693;26236.344091397867;42725;42961.140777184904;43124.78437607792;43355.349669754345;44300;36365.81817090898;37572.436413454365;37630.247395052495;37736.245275093795;38259.42610860895;36575.45136823003;37100;37228.25543489169;37479;37513.43729844109;31548.053558393283;36109.27781444409;36728;37139;37160.25679486341;31055.223619409695;33689.494657579664;33952.81165159208;34106.82946585251;34408;24426.145084921944;24692.506149876543;24788.38029049216;25195.24414267575;25207.49585008326 11:58:25 INFO - PROCESS | 14080 | |2;jquery.html;357.3906489435512;362.2537572600443;362.73520330158965;364.5206553382302;377.2775135615297;15991;16280.511584652464;17132.571685707862;17209.139543022862;17211.483655490323;14415.423383064664;15261.389544418238;15426.460073897415;15464.84535154648;15466.690666186669;4609.769511524427;5009.9749501252445;5013.699178049329;5017.172166592508;5027.773750181233;3633.091727068233;4908.361912951312;5465.480779325958;5722.79970201043;5739.024365857793;5739.741711622987;5751.626144300607;5760.6255593386295;5785.82642520725;5792.362840087587;5644.3508996465525;5891.11633255013;5892.351841297454;5901.05583106703;5906.114082887559;4937.308776771255;5129.538341549279;5134.512221338967;5155.561777248939;5178.0679477694;14941.103533787898;16887.915560422243;19921.203151873906;20134.597308053904;20234.898825505927;1924.3072493902184;1992.521794769245;2011.989940050305;2021.14101506859;2199.1863010686147;12895.742085158337;13007.674808129777;13030.087893847434;13177;13317.600471985856;1544.8068991376078;1648.332425367716;1676.228934690044;1686.376040864888;1710.1363811275226;64235.35764642341;67566.66216668885;68747;69078;69274.65362673205;8674.132586741402;8722.433041852259;9522.666706665372;9587.664431744855;9635.277354198322;12859.678508037186;12902;12988.610341689764;13026.28355440441;13067.346632668328;6816.659167041727;6900.2409734929115;6910.7581234657555;6923.273056329013;6934.895976560356;6308;6428.678566071678;6468.54720169593;6489.1888513935755;6527.314631963671;5815.447532484407;5909.468147866713;6058.363871793486;6077.453029227391;6142.877142457126;1538.5230578520695;1641.3106495272013;1693.161884866974;1714.5627864894373;1730.7749992500894;857.8584533552018;878.0253918150847;887.2281115429618;914.5701520285455;927.8608208768603;15882.523524294289;16224.18879056066;16401.83598164027;16666.50000499987;16703.248353824107;909.9363044586815;929.9860502092474;961.293449314753;991.1971303244395;992.1566668332005;9625.71122866315;9663.371880827724;9688.757781055388;9709.174720148867;9801.460919649488;354406;358673;360655;361416;362486;64957.67521162364;68798;69502.65248673724;70151.64924175346;70673.64663176754;932.5896605493562;955.398099197515;971.5773638467148;980.4166520920041;980.67147505585;15221.162836044125;15270.694586108439;15401.922990384975;15412.306446209723;15429.151396673291;32612.83693581517;34031;34559.82720086384;35995;36901.26197476089;48117.278240827116;48562.75718621384;49700.75149624229;49772.751136244086;50157.74921125371;7582.582957937367;7675.61621918913;7688.461807673633;7694.153643099143;7876.6061696913775;6717.328267173243;8790.560471976503;11219.495122719334;11868.169228153947;12001.519939202683;10157.746056348651;10208.693739187836;10447.268691191848;10495.110880041666;10540.420276884844;10070.194384449373;10378;10493.422861742678;10498.632547861094;10533.712764950038;10296.330738502273;10367.222458315808;10417.322874013165;10439.164866810788;10639.202059845697;7616.961915190389;7634.6946122154495;7771.378289736695;7787.18234585383;8015.599220039091;9252.722418327461;9912.107910288109;9924.454155021544;10004.499775011074;10399.58401663925 11:58:25 INFO - PROCESS | 14080 | |3;mootools.html;1332.3604669758515;1410.4146779086677;1484.5026915983144;1700.3963592924504;1729.0835856995789;6600.174978127734;7282.9271707282915;7339.963300183498;7791.104023037353;7799.33705635021;7406.407487401008;7518.436117291211;7580.848383032336;7593.316601505863;7614.847703045935;2111.7149184860077;2147.6134295826823;2150.9892450537805;2152.817010554105;2156.3638726575696;2039.5105174758025;2058.1458694641706;2120.098957942876;2132.9146834126695;2142.9249976250835;2087.332053742803;2097.2030628361204;2113.165299706615;2118.851680382374;2143.678448232762;2027.5539381336082;2041.836653067751;2047.3039166683325;2053.7330147080856;2057.0229141157906;1950.161430584848;2036.562139140092;2098.9475263118393;2102.4428526440506;2103.4425877142417;7539.849203015909;7564.167941526428;7589.203133670941;7590.6963721451075;7606.2393760624045;4335.674824388184;4439.644828413751;4462.509123996358;4481.843135490242;4486.461624605068;2891.6819149893495;2909.8836046558113;2945.4550908082074;2958.4970555005702;2981.9105426837014;865.8095219051798;868.5787393114334;881.8809460722784;905.6467977488785;906.2478143141177;10018.64934727281;10179.949100254526;10193.898061019368;10195.184385249162;10213;4080.653144482693;4083.673306135502;4148.937765933513;4157.438745769343;4173.749575025508;8687.869681954775;8692.217700406994;8707.303415726727;8715.128487151234;8715.172058654418;4329.372241025034;4349.9130017399475;4369.060651959844;4375.081232941055;4400.69195156336;3545.3795585772386;3967.920641587152;4016.6585840203325;4030.5969403059457;4108.342665173558;3569.161247106928;3582.7671201371827;3601.513795637608;3646.106703857519;3778.7165962552917;1137.2948771761396;1167.854018247719;1187.0681515010674;1194.8805119488156;1203.9879601203875;776.0842206196742;783.6669415498391;837.388706244445;883.6818745251833;889.9243564296978;5283.920741188886;5439.292891924025;5469.671819690831;5484.91772623411;5529.281193444826;383.3827537664414;383.4114634036796;392.34478421036937;393.71455694621744;395.7269484055992;3715.256948610289;3759.4924685167152;3798.563165235978;3862.1889403225637;3950.051987522974;9302.348835581579;9424.764380890396;9509.857352139723;9522.714318570454;9533.52332383378;9406.1064198901;9503.57233924475;9521.523923803783;9528.90471095294;9536.952315238379;7341.3392794648735;7492.138404083491;7496.137944136494;7505.812354691067;7556.65995030225;5399.43305952885;5541.251930989265;5591.9720401397735;5649.12438572022;5742.626729262584;8815.515146666738;9158.633654653739;9167.679131230376;9183.908160918305;9200.723978280663;9049.59276832531;9176.220021297997;9192.678256261266;9282.582283797381;9316.580753866228;6171.382861713792;6172.4136207060255;6270.874582508233;6289.213848268966;6292.590981586182;7014.368706816207;7056.400205982549;7071.681774320065;7074.964625176841;7113;6334.556581039283;6430.710618022106;6501.2198536175965;6570.178727659043;6597.406233439014;6393.1688880445245;6396.872062558629;6475.384838440341;6527.412532871875;6540.901886471612;5949.702514874326;5966.105084237399;5974.581779275409;5990.520758339409;6028.457438830526;4368.213721530155;4482.820687172477;4487.887802804956;4535.25168347219;4561.156186105581;4510.954890451185;4527.456705195397;4574.565416285448;4588.151192029485;4653.511381304914 11:58:25 INFO - PROCESS | 14080 | |4;prototype.html;284.2424937541452;285.94852926473226;290.3409260977582;290.42206010040013;291.3982625877563;4943.950560494394;4976.576990955773;4977.1290024245745;4982.501749825015;4984.551390374865;4890.975545122269;4891.144049791281;4932.457429682732;4948.678335908164;4955.578775804052;3625.2568223514118;3789.128500444899;3791.488149099878;3808.6000969898178;3818.408146737246;3812.4471951567007;3840.923181536368;3866.1107945172625;3897.883063508085;3903.7852918089493;3827.885163445101;3838.8272527736317;3847.211321679049;3858.2090671412293;3858.86493972711;3728.0866187783895;3788.9688249400647;3834.4440056191834;3865.942010869825;3870.2259548090215;3370.1237678203843;3398.49022646605;3405.1997780521556;3406.131436483681;3419.4186988211814;4711.599514041311;4727.905441891143;4736.123817093849;4742.051589682077;4756.66703330767;4436.44544431946;4452.933206001912;4465.709728867613;4475.507694153641;4491.461024677027;5009.34504712503;5143.508382569051;5170.586353091744;5172.2241663750365;5211.921821172686;3710.406334986389;3716.9442458363146;3726.31063253299;3730.2725968436166;3747.850085996557;5390;5449.237106805051;5452.700101494416;5455.318085239345;5504.724763761796;3445.7243420526297;3648.7993160376436;3651.7991510467177;3658.719448193111;3837.5394952605866;3694.852205911787;3700.8704695336073;3732.5894151643297;3739.9626003739613;3740.251949610089;4327.3725309830525;4330.155619654137;4337.82648694055;4341.37050127736;4346.456692913386;5042.747862606855;5213.6089793265655;5268.789248430096;5276.81531146408;5277.208418737144;1265.829113069742;1277.3677029870273;1277.7061275906408;1278.829870668328;1283.4224598930518;789.960501974899;807.1323327422926;810.4286478032973;815.4210510537466;819.0335404222955;4461.57615026572;4535.231259808677;4536.274196128604;4554.180247555471;4572.850760142727;5278.155495120839;5299.814506492255;5320.733963301819;5327.108876348841;5350.678959262456;4392.890177745582;4516.1419330327135;4528.298113792367;4555.339475775994;4581.205464666551;2832.8017038807498;2856.9572106181095;2863.3557449574096;2875.324298789783;2889.1477014280836;4968.30443737877;4972.154733695281;4999.800007999712;5004.949950500449;5060.746962651852;5228.771238758889;5403.621746477787;5454.236406902957;5469.726513674301;5577.9163312550345;5070.594352451795;5093.643444958817;5094.2613321068975;5109.897802043938;5143.819966301162;5375.3280839895015;5431;5433.744995826845;5452;5455.509004189642;5190.273361729436;5287.444818294024;5306.602004849729;5316.787328506816;5349.314965785765;5072.771725272445;5087.87280317995;5090.54919347984;5098.762285948375;5113.181890897438;3760.8495660173285;3763.303788799081;3769.792661403649;3791.9241615168094;3799.1072098056384;5341.866453338697;5385.030694475032;5396.298481197419;5412.506306099391;5484.396716361117;5192.714400707997;5225.895482090413;5232.3459567554055;5244.370675518962;5260.421353651019;5193.844184674465;5220.582353411642;5257.78968841242;5278.788848446173;5288.202011316171;4955.35580374549;5135.8202462915115;5141.640085194001;5146.485351464824;5166.612504062286;5020.221865610836;5115.5396014358885;5278.1027225372545;5293.338332708411;5305.389880163831;5111.361079865017;5123.28274041627;5133.537981581676;5140.871478213075;5155.639105262746 11:58:25 INFO - PROCESS | 14080 | |5;yui.html;612.8559788449713;655.2628293170184;705.4708968273794;728.6502478810171;763.7774077434665;12011.579594714187;12792.808107878389;12865.549705760288;13127.409266583003;13204.669883252924;11587.478563464643;12217.633470995885;12224.266544007365;12227.877721222785;12269.447874845631;635.2123367024878;786.5280831501111;797.8603744344746;805.0621026504116;809.6356639512213;802.7150361621627;803.5219044668413;805.6938363421891;805.8589746794316;806.9072056713466;849.5752123938031;850.7447765670305;850.8128211793427;851.0893344121793;851.8892543969275;846.6613354658125;847.8812966184709;848.7920459487434;849.371465115816;849.7493239494364;619.4177473175201;619.7706848466097;619.845038740315;620.0822782282247;620.2587907450599;12403.255804651659;12433.316167610777;12641.93679031599;12692;12709.618711438672;13699.589012329547;13844.792328115087;13915;14113.717725645532;14251.287435628177;10435.113015393625;10509.527071281735;10540.683779486628;10560.155187584975;10573.471326433648;2955.2020954342206;2961.3781105967773;2968.9703102969124;2969.7178768017;2972.0340889210875;58254.70872645652;60550.697246513926;60739.392606073816;60888;61623.07565386523;10120.746981325527;10309.690709278733;10457.581696732046;10575.36547807134;10617.309874858109;17510.737338939925;17800.020998845186;17846.643067138844;17934.103294835208;18943.90528047351;6456.0961465394885;6549.869002619921;6646.8005959821285;6666.733330666816;6746.662666866735;3734.9439758403646;3791.374423220138;3818.961810381916;3824.1969186470596;3829.4830197922925;2996.640403151636;3103.7051480109353;3123.937521249608;3129.9687003130134;3130.5617213590117;506.44797171083695;506.8530126263416;510.3238209372596;516.8501134670903;519.5272302204976;600.5105838741412;602.7137109872775;606.3451472409787;616.3682225718585;645.0099097884724;7840;8369.748907532783;8509.27671147947;8594.527300998505;8633.611487482953;580.9970950145307;601.7021574320739;618.4464903911064;624.1792043462832;624.8781487609872;3805.1818858945458;3873.070463088895;3875.5155605549307;3921.274564205631;3977.9204415911518;85627;86097.56951215204;87206;89510.55244723865;92935.53532232431;49098.509014909396;50292.49707502951;50444.74777626088;68862;78796.03009924798;69136.308636914;69798.65100674464;70507.2949270511;70644.64677676682;70778;7378.778636640909;7596.240375962359;7645.4648174629465;7689.038870141232;8474.364422668448;31499.685003150593;40814.59185408108;41233.1753364937;41552.37671434991;44393.55606443894;44410.777946110065;60121.39878601333;61817.38182618296;61996;62725.37274627378;10957.83563246536;10965.780684386427;11016.724581885517;11020.614278500214;11108.444577770917;12220.755584888075;12249.877501224873;12535.561255356384;12641.93679031599;12663.556775512812;12558.811617825922;12775.552855650008;12877.935610321889;12939.960649481953;12958.352082395653;11650.184487086162;12042.939785301018;12122.454489547816;12148.75702485963;12155.696107597027;11762.470688818852;11840.526378944745;12154.331511766584;12529.498820047096;12704.174228675107;9596.90403095988;9688.757781055248;9737.756556086155;9988.950055249968;10069.597216111273;9929.503524823585;10074.597016119273;10132.797344053226;10136.695899123039;10202.795944081225 11:58:25 INFO - PROCESS | 14080 | __end_tp_report 11:58:25 INFO - PROCESS | 14080 | __start_cc_report 11:58:25 INFO - PROCESS | 14080 | _x_x_mozilla_cycle_collect,370 11:58:25 INFO - PROCESS | 14080 | __end_cc_report 11:58:25 INFO - PROCESS | 14080 | __startTimestamp1464980305032__endTimestamp 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | ------- Summary: start ------- 11:58:25 INFO - PROCESS | 14080 | Number of tests: 6 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#0] dojo.html Cycles:165 Average:4723.50 Median:4884.15 stddev:621.54 (12.7%) stddev-sans-first:602.48 11:58:25 INFO - PROCESS | 14080 | Values: 2683.0 2727.9 2737.0 2746.2 2747.0 4751.8 4755.4 4790.9 4837.4 4884.1 4681.2 4738.9 4752.0 4756.3 4781.9 4332.4 4425.8 4438.2 4446.2 4447.0 50.6 4229.0 4332.0 4415.1 4473.2 4324.6 4346.7 4398.6 4408.4 4412.1 4386.6 4392.7 4405.2 4413.3 4444.8 4322.0 4345.5 4351.3 4355.8 4380.0 4639.7 4659.6 4667.0 4671.7 4726.8 5058.8 5107.1 5110.1 5122.8 5163.8 4994.6 5137.3 5178.9 5187.0 5214.7 4869.7 4879.2 4884.1 4888.3 4936.5 5136.0 5334.5 5336.8 5341.1 5356.1 5039.8 5089.3 5096.5 5117.1 5118.4 5184.8 5214.5 5214.7 5218.3 5277.9 4964.2 5103.8 5153.7 5162.4 5167.4 5062.2 5069.2 5092.1 5093.4 5113.3 4327.1 4340.7 4340.8 4383.8 4415.6 3741.3 3782.5 3797.0 3824.4 3834.9 4330.2 4365.4 4424.2 4468.5 4470.7 5146.0 5167.8 5179.4 5185.6 5219.3 4330.3 4414.5 4431.4 4467.0 4472.9 4613.8 4630.6 4632.9 4661.7 4696.7 4821.2 4857.0 4867.5 4883.1 4924.5 4982.8 5126.8 5172.7 5174.1 5195.2 4799.2 4852.1 4853.2 4873.4 4894.1 5044.6 5095.8 5100.2 5108.8 5146.6 5015.7 5125.9 5175.5 5196.5 5216.8 5032.9 5042.3 5063.0 5071.8 5121.4 4862.3 5027.9 5055.4 5057.6 5065.9 4872.4 4888.8 4944.4 4952.2 4960.7 5064.9 5080.7 5091.9 5110.5 5112.7 4775.1 4802.3 4947.9 4955.2 5013.9 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#1] ext.html Cycles:180 Average:47500.15 Median:37119.50 stddev:86733.69 (233.7%) stddev-sans-first:86905.35 11:58:25 INFO - PROCESS | 14080 | Values: 544.4 599.8 603.0 612.0 618.0 34390.0 38763.8 38994.4 39141.0 39246.2 39888.2 40262.0 40423.8 40469.2 40564.4 7693.7 7865.7 7876.7 7899.5 7905.5 7663.7 7758.0 7758.1 7759.0 7759.5 7741.8 7749.1 7753.4 7755.4 7757.8 7697.4 7722.0 7736.3 7736.6 7737.3 7719.3 7755.2 7793.2 7805.0 7820.6 29599.6 37298.0 37669.8 37704.2 37748.4 2883.1 2896.1 2965.2 2986.5 3448.9 28247.2 28694.6 29061.0 29061.9 29571.4 3028.9 3101.1 3101.4 3137.9 3158.3 252026.1 254334.0 254533.1 255010.0 256056.0 55982.4 56736.0 56833.7 56834.4 56942.7 33554.5 34374.3 34477.7 36682.8 36746.4 13448.5 13489.9 13530.6 13575.1 13615.9 10705.3 10728.0 10778.5 10812.5 10813.2 18828.6 18948.8 18974.6 19061.1 19100.7 6992.4 6998.2 7025.9 7112.1 7248.8 830.8 874.9 933.8 960.6 977.4 27066.0 27805.6 27821.2 27895.2 28256.9 985.4 997.7 1006.1 1016.2 1032.9 14698.3 15196.8 15214.7 15302.0 15406.6 389687.0 390998.0 392530.0 394580.0 396854.0 49031.8 49550.8 49575.3 49681.0 49738.3 1197.3 1201.3 1226.7 1236.9 1246.4 26629.7 27516.6 27833.4 28018.6 28502.1 44150.3 44228.0 44403.3 44591.8 44723.0 324145.0 325437.0 325936.0 326369.0 327212.0 25499.6 26003.7 26035.9 26191.7 26236.3 42725.0 42961.1 43124.8 43355.3 44300.0 36365.8 37572.4 37630.2 37736.2 38259.4 36575.5 37100.0 37228.3 37479.0 37513.4 31548.1 36109.3 36728.0 37139.0 37160.3 31055.2 33689.5 33952.8 34106.8 34408.0 24426.1 24692.5 24788.4 25195.2 25207.5 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#2] jquery.html Cycles:180 Average:23016.84 Median:27319.03 stddev:59322.52 (217.1%) stddev-sans-first:59464.54 11:58:25 INFO - PROCESS | 14080 | Values: 357.4 362.3 362.7 364.5 377.3 15991.0 16280.5 17132.6 17209.1 17211.5 14415.4 15261.4 15426.5 15464.8 15466.7 4609.8 5010.0 5013.7 5017.2 5027.8 3633.1 4908.4 5465.5 5722.8 5739.0 5739.7 5751.6 5760.6 5785.8 5792.4 5644.4 5891.1 5892.4 5901.1 5906.1 4937.3 5129.5 5134.5 5155.6 5178.1 14941.1 16887.9 19921.2 20134.6 20234.9 1924.3 1992.5 2012.0 2021.1 2199.2 12895.7 13007.7 13030.1 13177.0 13317.6 1544.8 1648.3 1676.2 1686.4 1710.1 64235.4 67566.7 68747.0 69078.0 69274.7 8674.1 8722.4 9522.7 9587.7 9635.3 12859.7 12902.0 12988.6 13026.3 13067.3 6816.7 6900.2 6910.8 6923.3 6934.9 6308.0 6428.7 6468.5 6489.2 6527.3 5815.4 5909.5 6058.4 6077.5 6142.9 1538.5 1641.3 1693.2 1714.6 1730.8 857.9 878.0 887.2 914.6 927.9 15882.5 16224.2 16401.8 16666.5 16703.2 909.9 930.0 961.3 991.2 992.2 9625.7 9663.4 9688.8 9709.2 9801.5 354406.0 358673.0 360655.0 361416.0 362486.0 64957.7 68798.0 69502.7 70151.6 70673.6 932.6 955.4 971.6 980.4 980.7 15221.2 15270.7 15401.9 15412.3 15429.2 32612.8 34031.0 34559.8 35995.0 36901.3 48117.3 48562.8 49700.8 49772.8 50157.7 7582.6 7675.6 7688.5 7694.2 7876.6 6717.3 8790.6 11219.5 11868.2 12001.5 10157.7 10208.7 10447.3 10495.1 10540.4 10070.2 10378.0 10493.4 10498.6 10533.7 10296.3 10367.2 10417.3 10439.2 10639.2 7617.0 7634.7 7771.4 7787.2 8015.6 9252.7 9912.1 9924.5 10004.5 10399.6 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#3] mootools.html Cycles:180 Average:5026.50 Median:5341.68 stddev:2830.90 (53.0%) stddev-sans-first:2825.23 11:58:25 INFO - PROCESS | 14080 | Values: 1332.4 1410.4 1484.5 1700.4 1729.1 6600.2 7282.9 7340.0 7791.1 7799.3 7406.4 7518.4 7580.8 7593.3 7614.8 2111.7 2147.6 2151.0 2152.8 2156.4 2039.5 2058.1 2120.1 2132.9 2142.9 2087.3 2097.2 2113.2 2118.9 2143.7 2027.6 2041.8 2047.3 2053.7 2057.0 1950.2 2036.6 2098.9 2102.4 2103.4 7539.8 7564.2 7589.2 7590.7 7606.2 4335.7 4439.6 4462.5 4481.8 4486.5 2891.7 2909.9 2945.5 2958.5 2981.9 865.8 868.6 881.9 905.6 906.2 10018.6 10179.9 10193.9 10195.2 10213.0 4080.7 4083.7 4148.9 4157.4 4173.7 8687.9 8692.2 8707.3 8715.1 8715.2 4329.4 4349.9 4369.1 4375.1 4400.7 3545.4 3967.9 4016.7 4030.6 4108.3 3569.2 3582.8 3601.5 3646.1 3778.7 1137.3 1167.9 1187.1 1194.9 1204.0 776.1 783.7 837.4 883.7 889.9 5283.9 5439.3 5469.7 5484.9 5529.3 383.4 383.4 392.3 393.7 395.7 3715.3 3759.5 3798.6 3862.2 3950.1 9302.3 9424.8 9509.9 9522.7 9533.5 9406.1 9503.6 9521.5 9528.9 9537.0 7341.3 7492.1 7496.1 7505.8 7556.7 5399.4 5541.3 5592.0 5649.1 5742.6 8815.5 9158.6 9167.7 9183.9 9200.7 9049.6 9176.2 9192.7 9282.6 9316.6 6171.4 6172.4 6270.9 6289.2 6292.6 7014.4 7056.4 7071.7 7075.0 7113.0 6334.6 6430.7 6501.2 6570.2 6597.4 6393.2 6396.9 6475.4 6527.4 6540.9 5949.7 5966.1 5974.6 5990.5 6028.5 4368.2 4482.8 4487.9 4535.3 4561.2 4511.0 4527.5 4574.6 4588.2 4653.5 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#4] prototype.html Cycles:180 Average:4307.72 Median:4955.47 stddev:1274.57 (25.7%) stddev-sans-first:1241.86 11:58:25 INFO - PROCESS | 14080 | Values: 284.2 285.9 290.3 290.4 291.4 4944.0 4976.6 4977.1 4982.5 4984.6 4891.0 4891.1 4932.5 4948.7 4955.6 3625.3 3789.1 3791.5 3808.6 3818.4 3812.4 3840.9 3866.1 3897.9 3903.8 3827.9 3838.8 3847.2 3858.2 3858.9 3728.1 3789.0 3834.4 3865.9 3870.2 3370.1 3398.5 3405.2 3406.1 3419.4 4711.6 4727.9 4736.1 4742.1 4756.7 4436.4 4452.9 4465.7 4475.5 4491.5 5009.3 5143.5 5170.6 5172.2 5211.9 3710.4 3716.9 3726.3 3730.3 3747.9 5390.0 5449.2 5452.7 5455.3 5504.7 3445.7 3648.8 3651.8 3658.7 3837.5 3694.9 3700.9 3732.6 3740.0 3740.3 4327.4 4330.2 4337.8 4341.4 4346.5 5042.7 5213.6 5268.8 5276.8 5277.2 1265.8 1277.4 1277.7 1278.8 1283.4 790.0 807.1 810.4 815.4 819.0 4461.6 4535.2 4536.3 4554.2 4572.9 5278.2 5299.8 5320.7 5327.1 5350.7 4392.9 4516.1 4528.3 4555.3 4581.2 2832.8 2857.0 2863.4 2875.3 2889.1 4968.3 4972.2 4999.8 5004.9 5060.7 5228.8 5403.6 5454.2 5469.7 5577.9 5070.6 5093.6 5094.3 5109.9 5143.8 5375.3 5431.0 5433.7 5452.0 5455.5 5190.3 5287.4 5306.6 5316.8 5349.3 5072.8 5087.9 5090.5 5098.8 5113.2 3760.8 3763.3 3769.8 3791.9 3799.1 5341.9 5385.0 5396.3 5412.5 5484.4 5192.7 5225.9 5232.3 5244.4 5260.4 5193.8 5220.6 5257.8 5278.8 5288.2 4955.4 5135.8 5141.6 5146.5 5166.6 5020.2 5115.5 5278.1 5293.3 5305.4 5111.4 5123.3 5133.5 5140.9 5155.6 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - PROCESS | 14080 | [#5] yui.html Cycles:180 Average:16392.49 Median:46754.64 stddev:22301.02 (47.7%) stddev-sans-first:22332.10 11:58:25 INFO - PROCESS | 14080 | Values: 612.9 655.3 705.5 728.7 763.8 12011.6 12792.8 12865.5 13127.4 13204.7 11587.5 12217.6 12224.3 12227.9 12269.4 635.2 786.5 797.9 805.1 809.6 802.7 803.5 805.7 805.9 806.9 849.6 850.7 850.8 851.1 851.9 846.7 847.9 848.8 849.4 849.7 619.4 619.8 619.8 620.1 620.3 12403.3 12433.3 12641.9 12692.0 12709.6 13699.6 13844.8 13915.0 14113.7 14251.3 10435.1 10509.5 10540.7 10560.2 10573.5 2955.2 2961.4 2969.0 2969.7 2972.0 58254.7 60550.7 60739.4 60888.0 61623.1 10120.7 10309.7 10457.6 10575.4 10617.3 17510.7 17800.0 17846.6 17934.1 18943.9 6456.1 6549.9 6646.8 6666.7 6746.7 3734.9 3791.4 3819.0 3824.2 3829.5 2996.6 3103.7 3123.9 3130.0 3130.6 506.4 506.9 510.3 516.9 519.5 600.5 602.7 606.3 616.4 645.0 7840.0 8369.7 8509.3 8594.5 8633.6 581.0 601.7 618.4 624.2 624.9 3805.2 3873.1 3875.5 3921.3 3977.9 85627.0 86097.6 87206.0 89510.6 92935.5 49098.5 50292.5 50444.7 68862.0 78796.0 69136.3 69798.7 70507.3 70644.6 70778.0 7378.8 7596.2 7645.5 7689.0 8474.4 31499.7 40814.6 41233.2 41552.4 44393.6 44410.8 60121.4 61817.4 61996.0 62725.4 10957.8 10965.8 11016.7 11020.6 11108.4 12220.8 12249.9 12535.6 12641.9 12663.6 12558.8 12775.6 12877.9 12940.0 12958.4 11650.2 12042.9 12122.5 12148.8 12155.7 11762.5 11840.5 12154.3 12529.5 12704.2 9596.9 9688.8 9737.8 9989.0 10069.6 9929.5 10074.6 10132.8 10136.7 10202.8 11:58:25 INFO - PROCESS | 14080 | -------- Summary: end -------- 11:58:25 INFO - PROCESS | 14080 | 11:58:25 INFO - TEST-INFO | 14080: exit 0 11:58:25 INFO - TEST-OK | dromaeo_css | took 1115061ms 11:58:25 INFO - TEST-START | kraken 11:58:25 INFO - operating with platform_type : linux_ 11:58:25 INFO - Initialising browser for kraken test... 11:58:25 INFO - TEST-INFO | started process 14314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMhf0g/profile http://localhost:35660/getInfo.html) 11:58:30 INFO - PROCESS | 14314 | __metrics Screen width/height:1600/1200 11:58:30 INFO - PROCESS | 14314 | colorDepth:24 11:58:30 INFO - PROCESS | 14314 | Browser inner width/height: 1024/697 11:58:30 INFO - PROCESS | 14314 | __metrics 11:58:31 ERROR - PROCESS | 14314 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:58:32 INFO - TEST-INFO | 14314: exit 0 11:58:32 INFO - Browser initialized. 11:58:32 INFO - Running cycle 1/1 for kraken test... 11:58:32 INFO - TEST-INFO | started process 14430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMhf0g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:44 INFO - PROCESS | 14430 | RSS: Main: 168091648 11:58:44 INFO - PROCESS | 14430 | 11:58:46 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35660/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:47 INFO - PROCESS | 14430 | RSS: Main: 172691456 11:58:47 INFO - PROCESS | 14430 | 11:58:50 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35660/tests/kraken/driver.html?testName=audio-dft) 11:58:51 INFO - PROCESS | 14430 | RSS: Main: 172101632 11:58:51 INFO - PROCESS | 14430 | 11:58:54 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35660/tests/kraken/driver.html?testName=audio-fft) 11:58:54 INFO - PROCESS | 14430 | RSS: Main: 167342080 11:58:54 INFO - PROCESS | 14430 | 11:58:57 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35660/tests/kraken/driver.html?testName=audio-oscillator) 11:58:57 INFO - PROCESS | 14430 | RSS: Main: 168214528 11:58:57 INFO - PROCESS | 14430 | 11:58:59 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:00 INFO - PROCESS | 14430 | RSS: Main: 168361984 11:59:00 INFO - PROCESS | 14430 | 11:59:03 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35660/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:04 INFO - PROCESS | 14430 | RSS: Main: 168349696 11:59:04 INFO - PROCESS | 14430 | 11:59:07 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35660/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:08 INFO - PROCESS | 14430 | RSS: Main: 166133760 11:59:08 INFO - PROCESS | 14430 | 11:59:11 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35660/tests/kraken/driver.html?testName=json-parse-financial) 11:59:12 INFO - PROCESS | 14430 | RSS: Main: 167968768 11:59:12 INFO - PROCESS | 14430 | 11:59:13 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:14 INFO - PROCESS | 14430 | RSS: Main: 168189952 11:59:14 INFO - PROCESS | 14430 | 11:59:16 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:17 INFO - PROCESS | 14430 | RSS: Main: 168361984 11:59:17 INFO - PROCESS | 14430 | 11:59:19 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:20 INFO - PROCESS | 14430 | RSS: Main: 169017344 11:59:20 INFO - PROCESS | 14430 | 11:59:22 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:23 INFO - PROCESS | 14430 | RSS: Main: 168775680 11:59:23 INFO - PROCESS | 14430 | 11:59:26 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:27 INFO - PROCESS | 14430 | RSS: Main: 168701952 11:59:27 INFO - PROCESS | 14430 | 11:59:28 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:35660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35660/tests/kraken/driver.html?testName=ai-astar) 11:59:29 INFO - PROCESS | 14430 | RSS: Main: 169234432 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | __start_tp_report 11:59:29 INFO - PROCESS | 14430 | _x_x_mozilla_page_load 11:59:29 INFO - PROCESS | 14430 | _x_x_mozilla_page_load_details 11:59:29 INFO - PROCESS | 14430 | |i|pagename|runs| 11:59:29 INFO - PROCESS | 14430 | |0;ai-astar;114;107;114;113;114;114;120;112;112;113 11:59:29 INFO - PROCESS | 14430 | |1;audio-beat-detection;162;131;153;179;130;152;161;141;184;132 11:59:29 INFO - PROCESS | 14430 | |2;audio-dft;164;162;164;171;163;163;161;163;162;162 11:59:29 INFO - PROCESS | 14430 | |3;audio-fft;76;76;77;163;77;76;76;75;155;82 11:59:29 INFO - PROCESS | 14430 | |4;audio-oscillator;89;85;154;85;86;88;128;86;86;146 11:59:29 INFO - PROCESS | 14430 | |5;imaging-gaussian-blur;117;118;118;119;118;119;118;117;118;118 11:59:29 INFO - PROCESS | 14430 | |6;imaging-darkroom;148;149;148;148;151;149;150;149;148;147 11:59:29 INFO - PROCESS | 14430 | |7;imaging-desaturate;95;95;95;95;96;95;97;96;95;96 11:59:29 INFO - PROCESS | 14430 | |8;json-parse-financial;67;64;73;65;66;63;63;64;65;63 11:59:29 INFO - PROCESS | 14430 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;66;65;65 11:59:29 INFO - PROCESS | 14430 | |10;stanford-crypto-aes;90;82;84;82;90;85;84;85;118;88 11:59:29 INFO - PROCESS | 14430 | |11;stanford-crypto-ccm;134;132;144;131;133;131;134;143;138;139 11:59:29 INFO - PROCESS | 14430 | |12;stanford-crypto-pbkdf2;175;174;178;171;177;169;168;171;170;177 11:59:29 INFO - PROCESS | 14430 | |13;stanford-crypto-sha256-iterative;67;67;67;69;69;67;68;66;68;66 11:59:29 INFO - PROCESS | 14430 | __end_tp_report 11:59:29 INFO - PROCESS | 14430 | __start_cc_report 11:59:29 INFO - PROCESS | 14430 | _x_x_mozilla_cycle_collect,1010 11:59:29 INFO - PROCESS | 14430 | __end_cc_report 11:59:29 INFO - PROCESS | 14430 | __startTimestamp1464980369029__endTimestamp 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | ------- Summary: start ------- 11:59:29 INFO - PROCESS | 14430 | Number of tests: 14 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:3.35 11:59:29 INFO - PROCESS | 14430 | Values: 114.0 107.0 114.0 113.0 114.0 114.0 120.0 112.0 112.0 113.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:157.00 stddev:19.37 (12.3%) stddev-sans-first:20.24 11:59:29 INFO - PROCESS | 14430 | Values: 162.0 131.0 153.0 179.0 130.0 152.0 161.0 141.0 184.0 132.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.80 (1.7%) stddev-sans-first:2.96 11:59:29 INFO - PROCESS | 14430 | Values: 164.0 162.0 164.0 171.0 163.0 163.0 161.0 163.0 162.0 162.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:34.73 (45.7%) stddev-sans-first:36.27 11:59:29 INFO - PROCESS | 14430 | Values: 76.0 76.0 77.0 163.0 77.0 76.0 76.0 75.0 155.0 82.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:27.91 (32.5%) stddev-sans-first:29.12 11:59:29 INFO - PROCESS | 14430 | Values: 89.0 85.0 154.0 85.0 86.0 88.0 128.0 86.0 86.0 146.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 11:59:29 INFO - PROCESS | 14430 | Values: 117.0 118.0 118.0 119.0 118.0 119.0 118.0 117.0 118.0 118.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 11:59:29 INFO - PROCESS | 14430 | Values: 148.0 149.0 148.0 148.0 151.0 149.0 150.0 149.0 148.0 147.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:59:29 INFO - PROCESS | 14430 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 97.0 96.0 95.0 96.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:3.02 (4.6%) stddev-sans-first:3.14 11:59:29 INFO - PROCESS | 14430 | Values: 67.0 64.0 73.0 65.0 66.0 63.0 63.0 64.0 65.0 63.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 11:59:29 INFO - PROCESS | 14430 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.00 stddev:10.66 (12.5%) stddev-sans-first:11.30 11:59:29 INFO - PROCESS | 14430 | Values: 90.0 82.0 84.0 82.0 90.0 85.0 84.0 85.0 118.0 88.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:136.00 stddev:4.82 (3.5%) stddev-sans-first:5.06 11:59:29 INFO - PROCESS | 14430 | Values: 134.0 132.0 144.0 131.0 133.0 131.0 134.0 143.0 138.0 139.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.50 stddev:3.65 (2.1%) stddev-sans-first:3.80 11:59:29 INFO - PROCESS | 14430 | Values: 175.0 174.0 178.0 171.0 177.0 169.0 168.0 171.0 170.0 177.0 11:59:29 INFO - PROCESS | 14430 | 11:59:29 INFO - PROCESS | 14430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 11:59:29 INFO - PROCESS | 14430 | Values: 67.0 67.0 67.0 69.0 69.0 67.0 68.0 66.0 68.0 66.0 11:59:29 INFO - PROCESS | 14430 | -------- Summary: end -------- 11:59:29 INFO - PROCESS | 14430 | 11:59:30 INFO - TEST-INFO | 14430: exit 0 11:59:30 INFO - TEST-OK | kraken | took 64305ms 11:59:30 INFO - SUITE-END | took 1179s 11:59:30 INFO - Completed test suite (00:19:39) 11:59:30 INFO - javascript benchmark 11:59:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6366.279936001043, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.0206974454322, 2727.9318017049563, 2737.014674717103, 2746.2447826847615, 2747.0385365122197, 4751.762411879406, 4755.381800365956, 4790.856274311767, 4837.419509658837, 4884.145274576944, 4681.204195286801, 4738.881527961803, 4751.976240118804, 4756.28655701644, 4781.928271075928, 4332.415123958264, 4425.77871106445, 4438.178936896668, 4446.244138496447, 4446.955530444703, 50.62412570524951, 4229.027323715532, 4331.9783401083105, 4415.094905544372, 4473.172463094338, 4324.567543245682, 4346.652267818583, 4398.604125628709, 4408.360787685768, 4412.073464572443, 4386.56134386562, 4392.670549708752, 4405.163019026407, 4413.271810151321, 4444.755538445384, 4322.0, 4345.456817897762, 4351.347297905308, 4355.7822108894425, 4379.956200437987, 4639.744814035227, 4659.5573420525, 4666.976665116653, 4671.696339737906, 4726.810927562893, 5058.7976480940715, 5107.055194788976, 5110.105731496973, 5122.795088196468, 5163.793448262065, 4994.550490455877, 5137.3064636274, 5178.896422071537, 5186.974065129688, 5214.739263036833, 4869.6591238612955, 4879.194932836078, 4884.145274576935, 4888.340074090023, 4936.531029552187, 5136.049830781242, 5334.466553344712, 5336.759845806948, 5341.145416733304, 5356.062689029404, 5039.823606173766, 5089.338386009795, 5096.490350964948, 5117.104506711311, 5118.38579370478, 5184.844454666366, 5214.45248248936, 5214.6610470320065, 5218.269442278084, 5277.9472205278225, 4964.15609346412, 5103.795848166106, 5153.6907785532985, 5162.380514338303, 5167.431582525919, 5062.164742817467, 5069.188929771219, 5092.134337162691, 5093.388793344822, 5113.335266415343, 4327.069680018811, 4340.674449416307, 4340.804663790137, 4383.846565370261, 4415.580519850609, 3741.345264578688, 3782.451544526028, 3796.962030379716, 3824.4263360495593, 3834.884953451401, 4330.198913201068, 4365.432493775852, 4424.203643344229, 4468.50846406895, 4470.731756094645, 5146.0479811235045, 5167.767450464738, 5179.430262671103, 5185.611079169077, 5219.269302297681, 4330.28550289205, 4414.536473670282, 4431.40176076232, 4466.955330446719, 4472.888177795581, 4613.754286342669, 4630.58324750774, 4632.86101416958, 4661.673682842168, 4696.694714843524, 4821.2045012573235, 4856.975715121473, 4867.488913664014, 4883.121038213156, 4924.458309586014, 4982.7508624569355, 5126.79492820283, 5172.741362931763, 5174.120399532013, 5195.19474481456, 4799.184138696361, 4852.053849499455, 4853.159536408656, 4873.415190177201, 4894.143524883202, 5044.596432285335, 5095.847124586268, 5100.158473851921, 5108.770105345194, 5146.614003949644, 5015.699058056528, 5125.8718532037, 5175.534201921845, 5196.53231209193, 5216.791328346823, 5032.949670503248, 5042.268871013609, 5062.974685126551, 5071.847844564669, 5121.436641969306, 4862.294967229803, 5027.899442011066, 5055.418626857811, 5057.570106540838, 5065.949340506548, 4872.3909511311085, 4888.780004899859, 4944.357233559758, 4952.232403977389, 4960.727160006234, 5064.949350506447, 5080.695158290514, 5091.923621145612, 5110.463401342806, 5112.71880046601, 4775.06886157196, 4802.303665968345, 4947.925781113358, 4955.1576232039915, 5013.949860501349], "value": 4686.329807335047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.4229117135836, 599.7810799058344, 603.008051754863, 611.9663418511982, 617.966011869347, 34390.0, 38763.80618096913, 38994.41508377377, 39141.0, 39246.21507569847, 39888.202235955265, 40261.99345016376, 40423.797881010556, 40469.19061618766, 40564.39153412701, 7693.7307194248215, 7865.724699635514, 7876.684932602689, 7899.526028438283, 7905.486143400689, 7663.655135518915, 7757.961210193941, 7758.14660387357, 7759.0, 7759.5344279343135, 7741.806454838646, 7749.147593764681, 7753.418493612973, 7755.379569634444, 7757.806054848617, 7697.384209263273, 7721.996140501727, 7736.265054819812, 7736.574488403136, 7737.342325902248, 7719.3052625263435, 7755.224477552256, 7793.220677932161, 7805.024371953506, 7820.648070836826, 29599.556006659917, 37298.0, 37669.81165094157, 37704.24591508182, 37748.433773493416, 2883.1206482022976, 2896.0877323643194, 2965.184574242079, 2986.5072263076568, 3448.9310213795834, 28247.152585422264, 28694.569581456293, 29061.0, 29061.85469072641, 29571.408571828444, 3028.9394212115853, 3101.131683128705, 3101.4417404867113, 3137.921551961196, 3158.3209609933747, 252026.0980426457, 254334.0, 254533.09134180215, 255009.99999999814, 256056.0, 55982.44017559854, 56736.0, 56833.71583142058, 56834.431655682914, 56942.71528642413, 33554.49668254978, 34374.31251374959, 34477.655223447946, 36682.8165859169, 36746.44880326797, 13448.46206151743, 13489.865101349058, 13530.594082177551, 13575.117617355038, 13615.931920340336, 10705.250632455653, 10728.0, 10778.461076946121, 10812.513436895359, 10813.18901082422, 18828.623427531373, 18948.81051189498, 18974.620507590047, 19061.142248598848, 19100.713489297672, 6992.440604751608, 6998.160220773438, 7025.89461158083, 7112.14654241484, 7248.782536523912, 830.7632324787406, 874.8556488179506, 933.8132373525186, 960.582146766159, 977.4330888084894, 27066.0, 27805.59499788265, 27821.16536503908, 27895.16314510568, 28256.8587157067, 985.3545927417553, 997.680742162501, 1006.1347241372414, 1016.207358260558, 1032.9380237185642, 14698.33857476416, 15196.848031519543, 15214.695706085817, 15302.0, 15406.614834629225, 389687.0, 390998.0, 392530.0, 394580.0, 396854.0, 49031.75484122628, 49550.75224623854, 49575.256371154464, 49681.0, 49738.25392619114, 1197.2946028891458, 1201.2552217624955, 1226.6810629236463, 1236.9196002259823, 1246.4266437438698, 26629.733702662725, 27516.58725119165, 27833.44333113367, 28018.579721303788, 28502.144935651962, 44150.33774493449, 44228.0, 44403.33394999142, 44591.77704111459, 44723.0, 324145.0, 325437.0, 325936.0, 326369.0, 327212.0, 25499.6175057378, 26003.73996260089, 26035.869820650776, 26191.738082619693, 26236.344091397867, 42725.0, 42961.140777184904, 43124.78437607792, 43355.349669754345, 44300.0, 36365.81817090898, 37572.436413454365, 37630.247395052495, 37736.245275093795, 38259.42610860895, 36575.45136823003, 37100.0, 37228.25543489169, 37479.0, 37513.43729844109, 31548.053558393283, 36109.27781444409, 36728.0, 37139.0, 37160.25679486341, 31055.223619409695, 33689.494657579664, 33952.81165159208, 34106.82946585251, 34408.0, 24426.145084921944, 24692.506149876543, 24788.38029049216, 25195.24414267575, 25207.49585008326], "value": 17379.022659610462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3906489435512, 362.2537572600443, 362.73520330158965, 364.5206553382302, 377.2775135615297, 15991.0, 16280.511584652464, 17132.571685707862, 17209.139543022862, 17211.483655490323, 14415.423383064664, 15261.389544418238, 15426.460073897415, 15464.84535154648, 15466.690666186669, 4609.769511524427, 5009.9749501252445, 5013.699178049329, 5017.172166592508, 5027.773750181233, 3633.091727068233, 4908.361912951312, 5465.480779325958, 5722.79970201043, 5739.024365857793, 5739.741711622987, 5751.626144300607, 5760.6255593386295, 5785.82642520725, 5792.362840087587, 5644.3508996465525, 5891.11633255013, 5892.351841297454, 5901.05583106703, 5906.114082887559, 4937.308776771255, 5129.538341549279, 5134.512221338967, 5155.561777248939, 5178.0679477694, 14941.103533787898, 16887.915560422243, 19921.203151873906, 20134.597308053904, 20234.898825505927, 1924.3072493902184, 1992.521794769245, 2011.989940050305, 2021.14101506859, 2199.1863010686147, 12895.742085158337, 13007.674808129777, 13030.087893847434, 13177.0, 13317.600471985856, 1544.8068991376078, 1648.332425367716, 1676.228934690044, 1686.376040864888, 1710.1363811275226, 64235.35764642341, 67566.66216668885, 68747.0, 69078.0, 69274.65362673205, 8674.132586741402, 8722.433041852259, 9522.666706665372, 9587.664431744855, 9635.277354198322, 12859.678508037186, 12902.0, 12988.610341689764, 13026.28355440441, 13067.346632668328, 6816.659167041727, 6900.2409734929115, 6910.7581234657555, 6923.273056329013, 6934.895976560356, 6308.0, 6428.678566071678, 6468.54720169593, 6489.1888513935755, 6527.314631963671, 5815.447532484407, 5909.468147866713, 6058.363871793486, 6077.453029227391, 6142.877142457126, 1538.5230578520695, 1641.3106495272013, 1693.161884866974, 1714.5627864894373, 1730.7749992500894, 857.8584533552018, 878.0253918150847, 887.2281115429618, 914.5701520285455, 927.8608208768603, 15882.523524294289, 16224.18879056066, 16401.83598164027, 16666.50000499987, 16703.248353824107, 909.9363044586815, 929.9860502092474, 961.293449314753, 991.1971303244395, 992.1566668332005, 9625.71122866315, 9663.371880827724, 9688.757781055388, 9709.174720148867, 9801.460919649488, 354406.0, 358673.0, 360655.0, 361416.0, 362486.0, 64957.67521162364, 68798.0, 69502.65248673724, 70151.64924175346, 70673.64663176754, 932.5896605493562, 955.398099197515, 971.5773638467148, 980.4166520920041, 980.67147505585, 15221.162836044125, 15270.694586108439, 15401.922990384975, 15412.306446209723, 15429.151396673291, 32612.83693581517, 34031.0, 34559.82720086384, 35995.0, 36901.26197476089, 48117.278240827116, 48562.75718621384, 49700.75149624229, 49772.751136244086, 50157.74921125371, 7582.582957937367, 7675.61621918913, 7688.461807673633, 7694.153643099143, 7876.6061696913775, 6717.328267173243, 8790.560471976503, 11219.495122719334, 11868.169228153947, 12001.519939202683, 10157.746056348651, 10208.693739187836, 10447.268691191848, 10495.110880041666, 10540.420276884844, 10070.194384449373, 10378.0, 10493.422861742678, 10498.632547861094, 10533.712764950038, 10296.330738502273, 10367.222458315808, 10417.322874013165, 10439.164866810788, 10639.202059845697, 7616.961915190389, 7634.6946122154495, 7771.378289736695, 7787.18234585383, 8015.599220039091, 9252.722418327461, 9912.107910288109, 9924.454155021544, 10004.499775011074, 10399.58401663925], "value": 8165.23070166809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.3604669758515, 1410.4146779086677, 1484.5026915983144, 1700.3963592924504, 1729.0835856995789, 6600.174978127734, 7282.9271707282915, 7339.963300183498, 7791.104023037353, 7799.33705635021, 7406.407487401008, 7518.436117291211, 7580.848383032336, 7593.316601505863, 7614.847703045935, 2111.7149184860077, 2147.6134295826823, 2150.9892450537805, 2152.817010554105, 2156.3638726575696, 2039.5105174758025, 2058.1458694641706, 2120.098957942876, 2132.9146834126695, 2142.9249976250835, 2087.332053742803, 2097.2030628361204, 2113.165299706615, 2118.851680382374, 2143.678448232762, 2027.5539381336082, 2041.836653067751, 2047.3039166683325, 2053.7330147080856, 2057.0229141157906, 1950.161430584848, 2036.562139140092, 2098.9475263118393, 2102.4428526440506, 2103.4425877142417, 7539.849203015909, 7564.167941526428, 7589.203133670941, 7590.6963721451075, 7606.2393760624045, 4335.674824388184, 4439.644828413751, 4462.509123996358, 4481.843135490242, 4486.461624605068, 2891.6819149893495, 2909.8836046558113, 2945.4550908082074, 2958.4970555005702, 2981.9105426837014, 865.8095219051798, 868.5787393114334, 881.8809460722784, 905.6467977488785, 906.2478143141177, 10018.64934727281, 10179.949100254526, 10193.898061019368, 10195.184385249162, 10213.0, 4080.653144482693, 4083.673306135502, 4148.937765933513, 4157.438745769343, 4173.749575025508, 8687.869681954775, 8692.217700406994, 8707.303415726727, 8715.128487151234, 8715.172058654418, 4329.372241025034, 4349.9130017399475, 4369.060651959844, 4375.081232941055, 4400.69195156336, 3545.3795585772386, 3967.920641587152, 4016.6585840203325, 4030.5969403059457, 4108.342665173558, 3569.161247106928, 3582.7671201371827, 3601.513795637608, 3646.106703857519, 3778.7165962552917, 1137.2948771761396, 1167.854018247719, 1187.0681515010674, 1194.8805119488156, 1203.9879601203875, 776.0842206196742, 783.6669415498391, 837.388706244445, 883.6818745251833, 889.9243564296978, 5283.920741188886, 5439.292891924025, 5469.671819690831, 5484.91772623411, 5529.281193444826, 383.3827537664414, 383.4114634036796, 392.34478421036937, 393.71455694621744, 395.7269484055992, 3715.256948610289, 3759.4924685167152, 3798.563165235978, 3862.1889403225637, 3950.051987522974, 9302.348835581579, 9424.764380890396, 9509.857352139723, 9522.714318570454, 9533.52332383378, 9406.1064198901, 9503.57233924475, 9521.523923803783, 9528.90471095294, 9536.952315238379, 7341.3392794648735, 7492.138404083491, 7496.137944136494, 7505.812354691067, 7556.65995030225, 5399.43305952885, 5541.251930989265, 5591.9720401397735, 5649.12438572022, 5742.626729262584, 8815.515146666738, 9158.633654653739, 9167.679131230376, 9183.908160918305, 9200.723978280663, 9049.59276832531, 9176.220021297997, 9192.678256261266, 9282.582283797381, 9316.580753866228, 6171.382861713792, 6172.4136207060255, 6270.874582508233, 6289.213848268966, 6292.590981586182, 7014.368706816207, 7056.400205982549, 7071.681774320065, 7074.964625176841, 7113.0, 6334.556581039283, 6430.710618022106, 6501.2198536175965, 6570.178727659043, 6597.406233439014, 6393.1688880445245, 6396.872062558629, 6475.384838440341, 6527.412532871875, 6540.901886471612, 5949.702514874326, 5966.105084237399, 5974.581779275409, 5990.520758339409, 6028.457438830526, 4368.213721530155, 4482.820687172477, 4487.887802804956, 4535.25168347219, 4561.156186105581, 4510.954890451185, 4527.456705195397, 4574.565416285448, 4588.151192029485, 4653.511381304914], "value": 3977.9825647626335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2424937541452, 285.94852926473226, 290.3409260977582, 290.42206010040013, 291.3982625877563, 4943.950560494394, 4976.576990955773, 4977.1290024245745, 4982.501749825015, 4984.551390374865, 4890.975545122269, 4891.144049791281, 4932.457429682732, 4948.678335908164, 4955.578775804052, 3625.2568223514118, 3789.128500444899, 3791.488149099878, 3808.6000969898178, 3818.408146737246, 3812.4471951567007, 3840.923181536368, 3866.1107945172625, 3897.883063508085, 3903.7852918089493, 3827.885163445101, 3838.8272527736317, 3847.211321679049, 3858.2090671412293, 3858.86493972711, 3728.0866187783895, 3788.9688249400647, 3834.4440056191834, 3865.942010869825, 3870.2259548090215, 3370.1237678203843, 3398.49022646605, 3405.1997780521556, 3406.131436483681, 3419.4186988211814, 4711.599514041311, 4727.905441891143, 4736.123817093849, 4742.051589682077, 4756.66703330767, 4436.44544431946, 4452.933206001912, 4465.709728867613, 4475.507694153641, 4491.461024677027, 5009.34504712503, 5143.508382569051, 5170.586353091744, 5172.2241663750365, 5211.921821172686, 3710.406334986389, 3716.9442458363146, 3726.31063253299, 3730.2725968436166, 3747.850085996557, 5390.0, 5449.237106805051, 5452.700101494416, 5455.318085239345, 5504.724763761796, 3445.7243420526297, 3648.7993160376436, 3651.7991510467177, 3658.719448193111, 3837.5394952605866, 3694.852205911787, 3700.8704695336073, 3732.5894151643297, 3739.9626003739613, 3740.251949610089, 4327.3725309830525, 4330.155619654137, 4337.82648694055, 4341.37050127736, 4346.456692913386, 5042.747862606855, 5213.6089793265655, 5268.789248430096, 5276.81531146408, 5277.208418737144, 1265.829113069742, 1277.3677029870273, 1277.7061275906408, 1278.829870668328, 1283.4224598930518, 789.960501974899, 807.1323327422926, 810.4286478032973, 815.4210510537466, 819.0335404222955, 4461.57615026572, 4535.231259808677, 4536.274196128604, 4554.180247555471, 4572.850760142727, 5278.155495120839, 5299.814506492255, 5320.733963301819, 5327.108876348841, 5350.678959262456, 4392.890177745582, 4516.1419330327135, 4528.298113792367, 4555.339475775994, 4581.205464666551, 2832.8017038807498, 2856.9572106181095, 2863.3557449574096, 2875.324298789783, 2889.1477014280836, 4968.30443737877, 4972.154733695281, 4999.800007999712, 5004.949950500449, 5060.746962651852, 5228.771238758889, 5403.621746477787, 5454.236406902957, 5469.726513674301, 5577.9163312550345, 5070.594352451795, 5093.643444958817, 5094.2613321068975, 5109.897802043938, 5143.819966301162, 5375.3280839895015, 5431.0, 5433.744995826845, 5452.0, 5455.509004189642, 5190.273361729436, 5287.444818294024, 5306.602004849729, 5316.787328506816, 5349.314965785765, 5072.771725272445, 5087.87280317995, 5090.54919347984, 5098.762285948375, 5113.181890897438, 3760.8495660173285, 3763.303788799081, 3769.792661403649, 3791.9241615168094, 3799.1072098056384, 5341.866453338697, 5385.030694475032, 5396.298481197419, 5412.506306099391, 5484.396716361117, 5192.714400707997, 5225.895482090413, 5232.3459567554055, 5244.370675518962, 5260.421353651019, 5193.844184674465, 5220.582353411642, 5257.78968841242, 5278.788848446173, 5288.202011316171, 4955.35580374549, 5135.8202462915115, 5141.640085194001, 5146.485351464824, 5166.612504062286, 5020.221865610836, 5115.5396014358885, 5278.1027225372545, 5293.338332708411, 5305.389880163831, 5111.361079865017, 5123.28274041627, 5133.537981581676, 5140.871478213075, 5155.639105262746], "value": 3890.461329124832, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.8559788449713, 655.2628293170184, 705.4708968273794, 728.6502478810171, 763.7774077434665, 12011.579594714187, 12792.808107878389, 12865.549705760288, 13127.409266583003, 13204.669883252924, 11587.478563464643, 12217.633470995885, 12224.266544007365, 12227.877721222785, 12269.447874845631, 635.2123367024878, 786.5280831501111, 797.8603744344746, 805.0621026504116, 809.6356639512213, 802.7150361621627, 803.5219044668413, 805.6938363421891, 805.8589746794316, 806.9072056713466, 849.5752123938031, 850.7447765670305, 850.8128211793427, 851.0893344121793, 851.8892543969275, 846.6613354658125, 847.8812966184709, 848.7920459487434, 849.371465115816, 849.7493239494364, 619.4177473175201, 619.7706848466097, 619.845038740315, 620.0822782282247, 620.2587907450599, 12403.255804651659, 12433.316167610777, 12641.93679031599, 12692.0, 12709.618711438672, 13699.589012329547, 13844.792328115087, 13915.0, 14113.717725645532, 14251.287435628177, 10435.113015393625, 10509.527071281735, 10540.683779486628, 10560.155187584975, 10573.471326433648, 2955.2020954342206, 2961.3781105967773, 2968.9703102969124, 2969.7178768017, 2972.0340889210875, 58254.70872645652, 60550.697246513926, 60739.392606073816, 60888.0, 61623.07565386523, 10120.746981325527, 10309.690709278733, 10457.581696732046, 10575.36547807134, 10617.309874858109, 17510.737338939925, 17800.020998845186, 17846.643067138844, 17934.103294835208, 18943.90528047351, 6456.0961465394885, 6549.869002619921, 6646.8005959821285, 6666.733330666816, 6746.662666866735, 3734.9439758403646, 3791.374423220138, 3818.961810381916, 3824.1969186470596, 3829.4830197922925, 2996.640403151636, 3103.7051480109353, 3123.937521249608, 3129.9687003130134, 3130.5617213590117, 506.44797171083695, 506.8530126263416, 510.3238209372596, 516.8501134670903, 519.5272302204976, 600.5105838741412, 602.7137109872775, 606.3451472409787, 616.3682225718585, 645.0099097884724, 7840.0, 8369.748907532783, 8509.27671147947, 8594.527300998505, 8633.611487482953, 580.9970950145307, 601.7021574320739, 618.4464903911064, 624.1792043462832, 624.8781487609872, 3805.1818858945458, 3873.070463088895, 3875.5155605549307, 3921.274564205631, 3977.9204415911518, 85627.0, 86097.56951215204, 87206.0, 89510.55244723865, 92935.53532232431, 49098.509014909396, 50292.49707502951, 50444.74777626088, 68862.0, 78796.03009924798, 69136.308636914, 69798.65100674464, 70507.2949270511, 70644.64677676682, 70778.0, 7378.778636640909, 7596.240375962359, 7645.4648174629465, 7689.038870141232, 8474.364422668448, 31499.685003150593, 40814.59185408108, 41233.1753364937, 41552.37671434991, 44393.55606443894, 44410.777946110065, 60121.39878601333, 61817.38182618296, 61996.0, 62725.37274627378, 10957.83563246536, 10965.780684386427, 11016.724581885517, 11020.614278500214, 11108.444577770917, 12220.755584888075, 12249.877501224873, 12535.561255356384, 12641.93679031599, 12663.556775512812, 12558.811617825922, 12775.552855650008, 12877.935610321889, 12939.960649481953, 12958.352082395653, 11650.184487086162, 12042.939785301018, 12122.454489547816, 12148.75702485963, 12155.696107597027, 11762.470688818852, 11840.526378944745, 12154.331511766584, 12529.498820047096, 12704.174228675107, 9596.90403095988, 9688.757781055248, 9737.756556086155, 9988.950055249968, 10069.597216111273, 9929.503524823585, 10074.597016119273, 10132.797344053226, 10136.695899123039, 10202.795944081225], "value": 6468.06348305691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 114.0, 113.0, 114.0, 114.0, 120.0, 112.0, 112.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 153.0, 179.0, 130.0, 152.0, 161.0, 141.0, 184.0, 132.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 171.0, 163.0, 163.0, 161.0, 163.0, 162.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 163.0, 77.0, 76.0, 76.0, 75.0, 155.0, 82.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 154.0, 85.0, 86.0, 88.0, 128.0, 86.0, 86.0, 146.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 151.0, 149.0, 150.0, 149.0, 148.0, 147.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 73.0, 65.0, 66.0, 63.0, 63.0, 64.0, 65.0, 63.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 84.0, 82.0, 90.0, 85.0, 84.0, 85.0, 118.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 144.0, 131.0, 133.0, 131.0, 134.0, 143.0, 138.0, 139.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 178.0, 171.0, 177.0, 169.0, 168.0, 171.0, 170.0, 177.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 69.0, 67.0, 68.0, 66.0, 68.0, 66.0], "value": 67.4, "unit": "score"}]}]} 11:59:30 INFO - Return code: 0 11:59:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:30 ERROR - # TBPL SUCCESS # 11:59:30 INFO - Running post-action listener: _resource_record_post_action 11:59:30 INFO - ##### 11:59:30 INFO - ##### Finished run-tests step (success) 11:59:30 INFO - ##### 11:59:30 INFO - Running post-run listener: _resource_record_post_run 11:59:30 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 523423744; Read time: 392; Write time: 431664 11:59:30 INFO - TinderboxPrint: CPU usage
13.4% 11:59:30 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 392 11:59:30 INFO - TinderboxPrint: I/O write bytes / time
523,423,744 / 431,664 11:59:30 INFO - TinderboxPrint: CPU idle
8,262.8 (86.6%) 11:59:30 INFO - TinderboxPrint: CPU user
1,226.1 (12.8%) 11:59:30 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 220135424; Read time: 232; Write time: 240076 11:59:30 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285945856; Read time: 160; Write time: 188112 11:59:30 INFO - Running post-run listener: _upload_blobber_files 11:59:30 INFO - Blob upload gear active. 11:59:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:30 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 11:59:30 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'] 11:59:30 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 11:59:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:32 INFO - (blobuploader) - INFO - Done attempting. 11:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:36 INFO - (blobuploader) - INFO - Done attempting. 11:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:37 INFO - (blobuploader) - INFO - Done attempting. 11:59:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:37 INFO - Return code: 0 11:59:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e445784e2da7a7cd77579fcdc375d93e64452fa70a26a056ba5031908643551055df619026b9bb6eb96376441ff00c7024f59df6ddcf8440bebbe3a332e1013c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a6fc08b64a3390e6ac84e6df7dabb6b4d3c32f298e39e57d32f242893cc611cae332a94e8dcf223d404b1480a6dca20ee436b792eeb027ee644dbe84f2c2fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757a5c9b7b195f1449d2580811ce88010ce55199f536e62b416b37285ccb7e504af569d902c7ab0753a1e1a732ef3f13d5b7c3892cee3406e6088895529b2894"} 11:59:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:37 INFO - Contents: 11:59:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e445784e2da7a7cd77579fcdc375d93e64452fa70a26a056ba5031908643551055df619026b9bb6eb96376441ff00c7024f59df6ddcf8440bebbe3a332e1013c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a6fc08b64a3390e6ac84e6df7dabb6b4d3c32f298e39e57d32f242893cc611cae332a94e8dcf223d404b1480a6dca20ee436b792eeb027ee644dbe84f2c2fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757a5c9b7b195f1449d2580811ce88010ce55199f536e62b416b37285ccb7e504af569d902c7ab0753a1e1a732ef3f13d5b7c3892cee3406e6088895529b2894"} 11:59:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:37 INFO - Copying logs to upload dir... 11:59:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.625089 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-03 11:59:37.644996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 11:59:37.648184) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 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/e445784e2da7a7cd77579fcdc375d93e64452fa70a26a056ba5031908643551055df619026b9bb6eb96376441ff00c7024f59df6ddcf8440bebbe3a332e1013c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a6fc08b64a3390e6ac84e6df7dabb6b4d3c32f298e39e57d32f242893cc611cae332a94e8dcf223d404b1480a6dca20ee436b792eeb027ee644dbe84f2c2fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757a5c9b7b195f1449d2580811ce88010ce55199f536e62b416b37285ccb7e504af569d902c7ab0753a1e1a732ef3f13d5b7c3892cee3406e6088895529b2894"} build_url:https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/SHJVI72PQ3y1nlROd-Fwpw/artifacts/public/build/firefox-49.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/e445784e2da7a7cd77579fcdc375d93e64452fa70a26a056ba5031908643551055df619026b9bb6eb96376441ff00c7024f59df6ddcf8440bebbe3a332e1013c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a6fc08b64a3390e6ac84e6df7dabb6b4d3c32f298e39e57d32f242893cc611cae332a94e8dcf223d404b1480a6dca20ee436b792eeb027ee644dbe84f2c2fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757a5c9b7b195f1449d2580811ce88010ce55199f536e62b416b37285ccb7e504af569d902c7ab0753a1e1a732ef3f13d5b7c3892cee3406e6088895529b2894"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 11:59:37.673830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:59:37.674204) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464978353.188475-1025940828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004675 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 11:59:37.759877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 11:59:37.760243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 11:59:37.760582) ========= ========= Total master_lag: 0.18 =========