builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465495946.75 results: success (0) buildid: 20160609083020 builduid: 900b9f59ec48492dacaebcccf9258527 revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:26.746055) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:26.746671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:26.747027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:26.762404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:26.762996) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 11:12:26-- 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% 46.0M=0s 2016-06-09 11:12:27 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.420496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.199495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.200026) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020625 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.250583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.251066) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c88261bd7310a5837cccffc767df53737fd9ce --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 f1c88261bd7310a5837cccffc767df53737fd9ce --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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 11:12:27,257 truncating revision to first 12 chars 2016-06-09 11:12:27,257 Setting DEBUG logging. 2016-06-09 11:12:27,257 attempt 1/10 2016-06-09 11:12:27,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c88261bd73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 11:12:27,584 unpacking tar archive at: fx-team-f1c88261bd73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652856 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.919091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.919479) ========= script_repo_revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.919917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.920223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 11:12:27.929684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 11:12:27.930093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:28 INFO - MultiFileLogger online at 20160609 11:12:28 in /builds/slave/test 11:12:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:12:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:28 INFO - {'append_to_log': False, 11:12:28 INFO - 'base_work_dir': '/builds/slave/test', 11:12:28 INFO - 'blob_upload_branch': 'Fx-Team', 11:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:28 INFO - 'branch': 'Fx-Team', 11:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:28 INFO - 'config_files': ('talos/linux_config.py',), 11:12:28 INFO - 'default_actions': ('clobber', 11:12:28 INFO - 'read-buildbot-config', 11:12:28 INFO - 'download-and-extract', 11:12:28 INFO - 'populate-webroot', 11:12:28 INFO - 'create-virtualenv', 11:12:28 INFO - 'install', 11:12:28 INFO - 'run-tests'), 11:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:28 INFO - 'download_minidump_stackwalk': True, 11:12:28 INFO - 'download_symbols': 'ondemand', 11:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:28 INFO - 'installer_path': 'installer.exe', 11:12:28 INFO - 'log_level': 'info', 11:12:28 INFO - 'log_name': 'talos', 11:12:28 INFO - 'log_to_console': True, 11:12:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:28 INFO - 'opt_config_files': (), 11:12:28 INFO - 'pip_index': False, 11:12:28 INFO - 'sps_profile': False, 11:12:28 INFO - 'sps_profile_interval': 0, 11:12:28 INFO - 'suite': 'dromaeojs', 11:12:28 INFO - 'system_bits': '32', 11:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:28 INFO - 'title': 'talos-linux64-ix-019', 11:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:28 INFO - 'use_talos_json': True, 11:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:28 INFO - 'work_dir': 'build'} 11:12:28 INFO - ##### 11:12:28 INFO - ##### Running clobber step. 11:12:28 INFO - ##### 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: clobber 11:12:28 INFO - rmtree: /builds/slave/test/build 11:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - ##### 11:12:28 INFO - ##### Finished clobber step (success) 11:12:28 INFO - ##### 11:12:28 INFO - ##### 11:12:28 INFO - ##### Running read-buildbot-config step. 11:12:28 INFO - ##### 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: read_buildbot_config 11:12:28 INFO - Using buildbot properties: 11:12:28 INFO - { 11:12:28 INFO - "project": "", 11:12:28 INFO - "product": "firefox", 11:12:28 INFO - "script_repo_revision": "production", 11:12:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:12:28 INFO - "repository": "", 11:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:12:28 INFO - "buildid": "20160609083020", 11:12:28 INFO - "pgo_build": "True", 11:12:28 INFO - "basedir": "/builds/slave/test", 11:12:28 INFO - "buildnumber": 790, 11:12:28 INFO - "slavename": "talos-linux64-ix-019", 11:12:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:28 INFO - "platform": "ubuntu64_hw", 11:12:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:12:28 INFO - "branch": "fx-team", 11:12:28 INFO - "repo_path": "integration/fx-team", 11:12:28 INFO - "revision": "f1c88261bd7310a5837cccffc767df53737fd9ce", 11:12:28 INFO - "stage_platform": "linux64-pgo", 11:12:28 INFO - "builduid": "900b9f59ec48492dacaebcccf9258527", 11:12:28 INFO - "slavebuilddir": "test" 11:12:28 INFO - } 11:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - ##### 11:12:28 INFO - ##### Finished read-buildbot-config step (success) 11:12:28 INFO - ##### 11:12:28 INFO - ##### 11:12:28 INFO - ##### Running download-and-extract step. 11:12:28 INFO - ##### 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: download_and_extract 11:12:28 INFO - mkdir: /builds/slave/test/build/tests 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:28 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:12:29 INFO - Downloaded 1361 bytes. 11:12:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:12:29 INFO - Using the following test package requirements: 11:12:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:12:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'jsshell-linux-x86_64.zip'], 11:12:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:12:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:12:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12: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:12:29 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:30 INFO - Downloaded 24452281 bytes. 11:12:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:31 INFO - Return code: 0 11:12:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:31 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:32 INFO - Downloaded 24452281 bytes. 11:12:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:34 INFO - Return code: 0 11:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:34 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:12:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:35 INFO - Downloaded 10833377 bytes. 11:12:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:12:35 INFO - Return code: 0 11:12:35 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:12:35 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:37 INFO - Downloaded 59288651 bytes. 11:12:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:12:37 INFO - mkdir: /builds/slave/test/properties 11:12:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:37 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:37 INFO - Contents: 11:12:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - Running post-action listener: set_extra_try_arguments 11:12:37 INFO - ##### 11:12:37 INFO - ##### Finished download-and-extract step (success) 11:12:37 INFO - ##### 11:12:37 INFO - ##### 11:12:37 INFO - ##### Running populate-webroot step. 11:12:37 INFO - ##### 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: populate_webroot 11:12:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:37 INFO - '--tppagecycles', 11:12:37 INFO - '7'], 11:12:37 INFO - 'tests': ['tsvgm']}}, 11:12:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['damp', 'tps']}, 11:12:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'tests': ['damp', 'tps']}, 11:12:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['dromaeo_dom']}, 11:12:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tsvgx', 11:12:37 INFO - 'tsvgr_opacity', 11:12:37 INFO - 'tart', 11:12:37 INFO - 'tscrollx', 11:12:37 INFO - 'cart']}, 11:12:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:37 INFO - 'tsvgr_opacity', 11:12:37 INFO - 'tart', 11:12:37 INFO - 'tscrollx', 11:12:37 INFO - 'cart']}, 11:12:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tp5o']}, 11:12:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'tests': ['tp5o']}, 11:12:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s', 11:12:37 INFO - '--xperf_path', 11:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:37 INFO - 'tests': ['tp5n']}, 11:12:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:37 INFO - 'talos_options': ['--xperf_path', 11:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:37 INFO - 'tests': ['tp5n']}}, 11:12:37 INFO - 'talos.zip': {'path': '', 11:12:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - ##### 11:12:37 INFO - ##### Finished populate-webroot step (success) 11:12:37 INFO - ##### 11:12:37 INFO - ##### 11:12:37 INFO - ##### Running create-virtualenv step. 11:12:37 INFO - ##### 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: create_virtualenv 11:12:37 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:37 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:12:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:38 INFO - Using real prefix '/usr' 11:12:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:38 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:40 INFO - Installing pip.................done. 11:12:40 INFO - Return code: 0 11:12:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 11:12:40 INFO - 'HOME': '/home/cltbld', 11:12:40 INFO - 'LANG': 'en_US.UTF-8', 11:12:40 INFO - 'LANGUAGE': 'en_US:en', 11:12:40 INFO - 'LOGNAME': 'cltbld', 11:12:40 INFO - 'MAIL': '/var/mail/cltbld', 11:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:40 INFO - 'MOZ_NO_REMOTE': '1', 11:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:40 INFO - 'NO_EM_RESTART': '1', 11:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:40 INFO - 'PWD': '/builds/slave/test', 11:12:40 INFO - 'SHELL': '/bin/bash', 11:12:40 INFO - 'SHLVL': '1', 11:12:40 INFO - 'TERM': 'linux', 11:12:40 INFO - 'TMOUT': '86400', 11:12:40 INFO - 'USER': 'cltbld', 11:12:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:40 INFO - '_': '/tools/buildbot/bin/python'} 11:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:40 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:12:40 INFO - Cleaning up... 11:12:40 INFO - Return code: 0 11:12:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 11:12:40 INFO - 'HOME': '/home/cltbld', 11:12:40 INFO - 'LANG': 'en_US.UTF-8', 11:12:40 INFO - 'LANGUAGE': 'en_US:en', 11:12:40 INFO - 'LOGNAME': 'cltbld', 11:12:40 INFO - 'MAIL': '/var/mail/cltbld', 11:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:40 INFO - 'MOZ_NO_REMOTE': '1', 11:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:40 INFO - 'NO_EM_RESTART': '1', 11:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:40 INFO - 'PWD': '/builds/slave/test', 11:12:40 INFO - 'SHELL': '/bin/bash', 11:12:40 INFO - 'SHLVL': '1', 11:12:40 INFO - 'TERM': 'linux', 11:12:40 INFO - 'TMOUT': '86400', 11:12:40 INFO - 'USER': 'cltbld', 11:12:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:40 INFO - '_': '/tools/buildbot/bin/python'} 11:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:41 INFO - Downloading/unpacking psutil>=3.1.1 11:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:41 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:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:43 INFO - Installing collected packages: psutil 11:12:43 INFO - Running setup.py install for psutil 11:12:43 INFO - building 'psutil._psutil_linux' extension 11:12:43 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:12:43 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:12:43 INFO - building 'psutil._psutil_posix' extension 11:12:43 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:12:43 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:12:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:43 INFO - Successfully installed psutil 11:12:43 INFO - Cleaning up... 11:12:43 INFO - Return code: 0 11:12:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:43 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 11:12:43 INFO - 'HOME': '/home/cltbld', 11:12:43 INFO - 'LANG': 'en_US.UTF-8', 11:12:43 INFO - 'LANGUAGE': 'en_US:en', 11:12:43 INFO - 'LOGNAME': 'cltbld', 11:12:43 INFO - 'MAIL': '/var/mail/cltbld', 11:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:43 INFO - 'MOZ_NO_REMOTE': '1', 11:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:43 INFO - 'NO_EM_RESTART': '1', 11:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:43 INFO - 'PWD': '/builds/slave/test', 11:12:43 INFO - 'SHELL': '/bin/bash', 11:12:43 INFO - 'SHLVL': '1', 11:12:43 INFO - 'TERM': 'linux', 11:12:43 INFO - 'TMOUT': '86400', 11:12:43 INFO - 'USER': 'cltbld', 11:12:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:43 INFO - '_': '/tools/buildbot/bin/python'} 11:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:45 INFO - Installing collected packages: mozsystemmonitor 11:12:45 INFO - Running setup.py install for mozsystemmonitor 11:12:45 INFO - Successfully installed mozsystemmonitor 11:12:45 INFO - Cleaning up... 11:12:45 INFO - Return code: 0 11:12:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:45 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:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 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:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:45 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:12:45 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:12:45 INFO - Using env: {'DISPLAY': ':0', 11:12:45 INFO - 'HOME': '/home/cltbld', 11:12:45 INFO - 'LANG': 'en_US.UTF-8', 11:12:45 INFO - 'LANGUAGE': 'en_US:en', 11:12:45 INFO - 'LOGNAME': 'cltbld', 11:12:45 INFO - 'MAIL': '/var/mail/cltbld', 11:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:45 INFO - 'MOZ_NO_REMOTE': '1', 11:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:45 INFO - 'NO_EM_RESTART': '1', 11:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:45 INFO - 'PWD': '/builds/slave/test', 11:12:45 INFO - 'SHELL': '/bin/bash', 11:12:45 INFO - 'SHLVL': '1', 11:12:45 INFO - 'TERM': 'linux', 11:12:45 INFO - 'TMOUT': '86400', 11:12:45 INFO - 'USER': 'cltbld', 11:12:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:45 INFO - '_': '/tools/buildbot/bin/python'} 11:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:48 INFO - warning: no files found matching '*.txt' 11:12:48 INFO - no previously-included directories found matching 'build' 11:12:48 INFO - no previously-included directories found matching 'dist' 11:12:48 INFO - no previously-included directories found matching '.git*' 11:12:48 INFO - Installing collected packages: jsonschema, functools32 11:12:48 INFO - Running setup.py install for functools32 11:12:48 INFO - warning: no files found matching '*.txt' 11:12:48 INFO - no previously-included directories found matching 'build' 11:12:48 INFO - no previously-included directories found matching 'dist' 11:12:48 INFO - no previously-included directories found matching '.git*' 11:12:48 INFO - Successfully installed jsonschema functools32 11:12:48 INFO - Cleaning up... 11:12:48 INFO - Return code: 0 11:12:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:48 INFO - Using env: {'DISPLAY': ':0', 11:12:48 INFO - 'HOME': '/home/cltbld', 11:12:48 INFO - 'LANG': 'en_US.UTF-8', 11:12:48 INFO - 'LANGUAGE': 'en_US:en', 11:12:48 INFO - 'LOGNAME': 'cltbld', 11:12:48 INFO - 'MAIL': '/var/mail/cltbld', 11:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:48 INFO - 'MOZ_NO_REMOTE': '1', 11:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:48 INFO - 'NO_EM_RESTART': '1', 11:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:48 INFO - 'PWD': '/builds/slave/test', 11:12:48 INFO - 'SHELL': '/bin/bash', 11:12:48 INFO - 'SHLVL': '1', 11:12:48 INFO - 'TERM': 'linux', 11:12:48 INFO - 'TMOUT': '86400', 11:12:48 INFO - 'USER': 'cltbld', 11:12:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:48 INFO - '_': '/tools/buildbot/bin/python'} 11:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 INFO - Downloading docopt-0.6.1.tar.gz 11:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:51 INFO - Running setup.py install for blobuploader 11:12:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:51 INFO - Running setup.py install for requests 11:12:51 INFO - Running setup.py install for docopt 11:12:51 INFO - Successfully installed blobuploader requests docopt 11:12:51 INFO - Cleaning up... 11:12:51 INFO - Return code: 0 11:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:51 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:51 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:12:51 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:12:51 INFO - Using env: {'DISPLAY': ':0', 11:12:51 INFO - 'HOME': '/home/cltbld', 11:12:51 INFO - 'LANG': 'en_US.UTF-8', 11:12:51 INFO - 'LANGUAGE': 'en_US:en', 11:12:51 INFO - 'LOGNAME': 'cltbld', 11:12:51 INFO - 'MAIL': '/var/mail/cltbld', 11:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:51 INFO - 'MOZ_NO_REMOTE': '1', 11:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:51 INFO - 'NO_EM_RESTART': '1', 11:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:51 INFO - 'PWD': '/builds/slave/test', 11:12:51 INFO - 'SHELL': '/bin/bash', 11:12:51 INFO - 'SHLVL': '1', 11:12:51 INFO - 'TERM': 'linux', 11:12:51 INFO - 'TMOUT': '86400', 11:12:51 INFO - 'USER': 'cltbld', 11:12:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:51 INFO - '_': '/tools/buildbot/bin/python'} 11:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:52 INFO - Running setup.py (path:/tmp/pip-O34kmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:52 INFO - Running setup.py (path:/tmp/pip-PkNQ3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:52 INFO - Running setup.py (path:/tmp/pip-sAAT8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:52 INFO - Running setup.py (path:/tmp/pip-zwzWGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:52 INFO - Running setup.py (path:/tmp/pip-Urj7w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:52 INFO - Running setup.py (path:/tmp/pip-EgANUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:52 INFO - Running setup.py (path:/tmp/pip-Jk5hE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:52 INFO - Running setup.py (path:/tmp/pip-qSZTJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:52 INFO - Running setup.py (path:/tmp/pip-nxdqJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:52 INFO - Running setup.py (path:/tmp/pip-CIo3Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:52 INFO - Running setup.py (path:/tmp/pip-sxXjGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:52 INFO - Running setup.py (path:/tmp/pip-x9uv4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:52 INFO - Running setup.py (path:/tmp/pip-rbzq_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:53 INFO - Running setup.py (path:/tmp/pip-iydhdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:53 INFO - Running setup.py (path:/tmp/pip-RkDxlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:53 INFO - Running setup.py (path:/tmp/pip-U1g1F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:53 INFO - Running setup.py (path:/tmp/pip-mziuRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:53 INFO - Running setup.py install for manifestparser 11:12:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:53 INFO - Running setup.py install for mozcrash 11:12:53 INFO - Running setup.py install for mozdebug 11:12:53 INFO - Running setup.py install for mozdevice 11:12:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:53 INFO - Running setup.py install for mozfile 11:12:53 INFO - Running setup.py install for mozhttpd 11:12:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:53 INFO - Running setup.py install for mozinfo 11:12:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for mozInstall 11:12:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for mozleak 11:12:54 INFO - Running setup.py install for mozlog 11:12:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for moznetwork 11:12:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for mozprocess 11:12:54 INFO - Running setup.py install for mozprofile 11:12:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for mozrunner 11:12:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:54 INFO - Running setup.py install for mozscreenshot 11:12:54 INFO - Running setup.py install for moztest 11:12:54 INFO - Running setup.py install for mozversion 11:12:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:55 INFO - Cleaning up... 11:12:55 INFO - Return code: 0 11:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:55 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:12:55 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:12:55 INFO - Using env: {'DISPLAY': ':0', 11:12:55 INFO - 'HOME': '/home/cltbld', 11:12:55 INFO - 'LANG': 'en_US.UTF-8', 11:12:55 INFO - 'LANGUAGE': 'en_US:en', 11:12:55 INFO - 'LOGNAME': 'cltbld', 11:12:55 INFO - 'MAIL': '/var/mail/cltbld', 11:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:55 INFO - 'MOZ_NO_REMOTE': '1', 11:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:55 INFO - 'NO_EM_RESTART': '1', 11:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:55 INFO - 'PWD': '/builds/slave/test', 11:12:55 INFO - 'SHELL': '/bin/bash', 11:12:55 INFO - 'SHLVL': '1', 11:12:55 INFO - 'TERM': 'linux', 11:12:55 INFO - 'TMOUT': '86400', 11:12:55 INFO - 'USER': 'cltbld', 11:12:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:55 INFO - '_': '/tools/buildbot/bin/python'} 11:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:55 INFO - Running setup.py (path:/tmp/pip-RBeuus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:55 INFO - Running setup.py (path:/tmp/pip-giQ5T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:55 INFO - Running setup.py (path:/tmp/pip-DFvpBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:55 INFO - Running setup.py (path:/tmp/pip-y49wp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:55 INFO - Running setup.py (path:/tmp/pip-Rp_XVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:55 INFO - Running setup.py (path:/tmp/pip-we7rGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:55 INFO - Running setup.py (path:/tmp/pip-NuxrOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:55 INFO - Running setup.py (path:/tmp/pip-OyVX9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:55 INFO - Running setup.py (path:/tmp/pip-YglZne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:55 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:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:55 INFO - Running setup.py (path:/tmp/pip-UbtK5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:56 INFO - Running setup.py (path:/tmp/pip-muChin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:56 INFO - Running setup.py (path:/tmp/pip-zhMwnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:56 INFO - Running setup.py (path:/tmp/pip-Xc3723-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:56 INFO - Running setup.py (path:/tmp/pip-1sIXGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:56 INFO - Running setup.py (path:/tmp/pip-5MCGki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:56 INFO - Running setup.py (path:/tmp/pip-Hs3dce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:56 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:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:56 INFO - Running setup.py (path:/tmp/pip-87HF3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - Downloading blessings-1.6.tar.gz 11:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:58 INFO - Installing collected packages: blessings 11:12:58 INFO - Running setup.py install for blessings 11:12:58 INFO - Successfully installed blessings 11:12:58 INFO - Cleaning up... 11:12:58 INFO - Return code: 0 11:12:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:58 INFO - Reading from file tmpfile_stdout 11:12:58 INFO - Current package versions: 11:12:58 INFO - argparse == 1.2.1 11:12:58 INFO - blessings == 1.6 11:12:58 INFO - blobuploader == 1.2.4 11:12:58 INFO - docopt == 0.6.1 11:12:58 INFO - functools32 == 3.2.3-2 11:12:58 INFO - jsonschema == 2.5.1 11:12:58 INFO - manifestparser == 1.1 11:12:58 INFO - mozInstall == 1.12 11:12:58 INFO - mozcrash == 0.17 11:12:58 INFO - mozdebug == 0.1 11:12:58 INFO - mozdevice == 0.48 11:12:58 INFO - mozfile == 1.2 11:12:58 INFO - mozhttpd == 0.7 11:12:58 INFO - mozinfo == 0.9 11:12:58 INFO - mozleak == 0.1 11:12:58 INFO - mozlog == 3.2 11:12:58 INFO - moznetwork == 0.27 11:12:58 INFO - mozprocess == 0.22 11:12:58 INFO - mozprofile == 0.28 11:12:58 INFO - mozrunner == 6.11 11:12:58 INFO - mozscreenshot == 0.1 11:12:58 INFO - mozsystemmonitor == 0.3 11:12:58 INFO - moztest == 0.7 11:12:58 INFO - mozversion == 1.4 11:12:58 INFO - psutil == 3.1.1 11:12:58 INFO - requests == 1.2.3 11:12:58 INFO - wsgiref == 0.1.2 11:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:58 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:58 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:12:58 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:12:58 INFO - Using env: {'DISPLAY': ':0', 11:12:58 INFO - 'HOME': '/home/cltbld', 11:12:58 INFO - 'LANG': 'en_US.UTF-8', 11:12:58 INFO - 'LANGUAGE': 'en_US:en', 11:12:58 INFO - 'LOGNAME': 'cltbld', 11:12:58 INFO - 'MAIL': '/var/mail/cltbld', 11:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:58 INFO - 'MOZ_NO_REMOTE': '1', 11:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:58 INFO - 'NO_EM_RESTART': '1', 11:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:58 INFO - 'PWD': '/builds/slave/test', 11:12:58 INFO - 'SHELL': '/bin/bash', 11:12:58 INFO - 'SHLVL': '1', 11:12:58 INFO - 'TERM': 'linux', 11:12:58 INFO - 'TMOUT': '86400', 11:12:58 INFO - 'USER': 'cltbld', 11:12:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:58 INFO - '_': '/tools/buildbot/bin/python'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 INFO - Cleaning up... 11:12:59 INFO - Return code: 0 11:12:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:59 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:12:59 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:12:59 INFO - Using env: {'DISPLAY': ':0', 11:12:59 INFO - 'HOME': '/home/cltbld', 11:12:59 INFO - 'LANG': 'en_US.UTF-8', 11:12:59 INFO - 'LANGUAGE': 'en_US:en', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MAIL': '/var/mail/cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SHLVL': '1', 11:12:59 INFO - 'TERM': 'linux', 11:12:59 INFO - 'TMOUT': '86400', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - '_': '/tools/buildbot/bin/python'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:59 INFO - Cleaning up... 11:12:59 INFO - Return code: 0 11:12:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 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 0x7f3fba128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', '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:12:59 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:12:59 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:12:59 INFO - Using env: {'DISPLAY': ':0', 11:12:59 INFO - 'HOME': '/home/cltbld', 11:12:59 INFO - 'LANG': 'en_US.UTF-8', 11:12:59 INFO - 'LANGUAGE': 'en_US:en', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MAIL': '/var/mail/cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SHLVL': '1', 11:12:59 INFO - 'TERM': 'linux', 11:12:59 INFO - 'TMOUT': '86400', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - '_': '/tools/buildbot/bin/python'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 INFO - Downloading/unpacking flake8 11:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:13:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:02 INFO - no previously-included directories found matching 'docs/_build' 11:13:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:02 INFO - Running setup.py install for pep8 11:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:02 INFO - no previously-included directories found matching 'docs/_build' 11:13:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Running post-action listener: _resource_record_post_action 11:13:02 INFO - Running post-action listener: _start_resource_monitoring 11:13:02 INFO - Starting resource monitoring. 11:13:02 INFO - ##### 11:13:02 INFO - ##### Finished create-virtualenv step (success) 11:13:02 INFO - ##### 11:13:02 INFO - ##### 11:13:02 INFO - ##### Running install step. 11:13:02 INFO - ##### 11:13:02 INFO - Running pre-action listener: _resource_record_pre_action 11:13:02 INFO - Running main action method: install 11:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:02 INFO - Reading from file tmpfile_stdout 11:13:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:02 INFO - Reading from file tmpfile_stdout 11:13:02 INFO - Output received: 11:13:02 INFO - Usage: mozinstall [options] installer 11:13:02 INFO - Options: 11:13:02 INFO - -h, --help show this help message and exit 11:13:02 INFO - -d DEST, --destination=DEST 11:13:02 INFO - Directory to install application into. [default: 11:13:02 INFO - "/builds/slave/test"] 11:13:02 INFO - --app=APP Application being installed. [default: firefox] 11:13:02 INFO - mkdir: /builds/slave/test/build/application 11:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:13:19 INFO - Reading from file tmpfile_stdout 11:13:19 INFO - Output received: 11:13:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:19 INFO - Running post-action listener: _resource_record_post_action 11:13:19 INFO - ##### 11:13:19 INFO - ##### Finished install step (success) 11:13:19 INFO - ##### 11:13:19 INFO - ##### 11:13:19 INFO - ##### Running run-tests step. 11:13:19 INFO - ##### 11:13:19 INFO - Running pre-action listener: _resource_record_pre_action 11:13:19 INFO - Running main action method: run_tests 11:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:19 INFO - Python 2.7.3 11:13:19 INFO - Return code: 0 11:13:19 INFO - grabbing minidump binary from tooltool 11:13: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:13:19 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 0x2c641c0>, '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 0x2c650c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c65550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:19 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:13:19 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:13:19 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:13:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:19 INFO - Return code: 0 11:13:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:20 INFO - Return code: 0 11:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:13:20 INFO - Using env: {'DISPLAY': ':0', 11:13:20 INFO - 'HOME': '/home/cltbld', 11:13:20 INFO - 'LANG': 'en_US.UTF-8', 11:13:20 INFO - 'LANGUAGE': 'en_US:en', 11:13:20 INFO - 'LOGNAME': 'cltbld', 11:13:20 INFO - 'MAIL': '/var/mail/cltbld', 11:13:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:20 INFO - 'MOZ_NO_REMOTE': '1', 11:13:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:20 INFO - 'NO_EM_RESTART': '1', 11:13:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:20 INFO - 'PWD': '/builds/slave/test', 11:13:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:20 INFO - 'SHELL': '/bin/bash', 11:13:20 INFO - 'SHLVL': '1', 11:13:20 INFO - 'TERM': 'linux', 11:13:20 INFO - 'TMOUT': '86400', 11:13:20 INFO - 'USER': 'cltbld', 11:13:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891', 11:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:20 INFO - '_': '/tools/buildbot/bin/python'} 11:13:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:13:20 INFO - mozversion application_buildid: 20160609083020 11:13:20 INFO - mozversion application_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 11:13:20 INFO - mozversion application_display_name: Nightly 11:13:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:20 INFO - mozversion application_name: Firefox 11:13:20 INFO - mozversion application_remotingname: firefox 11:13:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:13:20 INFO - mozversion application_vendor: Mozilla 11:13:20 INFO - mozversion application_version: 50.0a1 11:13:20 INFO - mozversion platform_buildid: 20160609083020 11:13:20 INFO - mozversion platform_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 11:13:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:20 INFO - mozversion platform_version: 50.0a1 11:13:20 INFO - using testdate: 1465496000 11:13:20 INFO - actual date: 1465496000 11:13:20 INFO - starting webserver on 'localhost:50659' 11:13:20 INFO - SUITE-START | Running 2 tests 11:13:20 INFO - TEST-START | dromaeo_css 11:13:20 INFO - operating with platform_type : linux_ 11:13:20 INFO - Initialising browser for dromaeo_css test... 11:13:20 INFO - TEST-INFO | started process 7545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4NpMO/profile http://localhost:50659/getInfo.html) 11:13:25 INFO - PROCESS | 7545 | __metrics Screen width/height:1600/1200 11:13:25 INFO - PROCESS | 7545 | colorDepth:24 11:13:25 INFO - PROCESS | 7545 | Browser inner width/height: 1024/697 11:13:25 INFO - PROCESS | 7545 | __metrics 11:13:26 ERROR - PROCESS | 7545 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:13:26 INFO - PROCESS | 7545 | console.error: PushService: 11:13:26 INFO - PROCESS | 7545 | stateChangeProcessEnqueue: Error transitioning state 11:13:26 INFO - PROCESS | 7545 | UnknownError 11:13:27 INFO - TEST-INFO | 7545: exit 0 11:13:27 INFO - Browser initialized. 11:13:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:27 INFO - TEST-INFO | started process 7627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4NpMO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:39 INFO - PROCESS | 7627 | RSS: Main: 173400064 11:13:39 INFO - PROCESS | 7627 | 11:14:30 INFO - PROCESS | 7627 | 1465496070067 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:16:39 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50659/tests/dromaeo/cssquery-ext.html) 11:16:40 INFO - PROCESS | 7627 | RSS: Main: 264159232 11:16:40 INFO - PROCESS | 7627 | 11:19:42 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-ext.html (next: http://localhost:50659/tests/dromaeo/cssquery-jquery.html) 11:19:42 INFO - PROCESS | 7627 | RSS: Main: 269631488 11:19:42 INFO - PROCESS | 7627 | 11:22:44 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50659/tests/dromaeo/cssquery-mootools.html) 11:22:45 INFO - PROCESS | 7627 | RSS: Main: 269234176 11:22:45 INFO - PROCESS | 7627 | 11:25:47 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50659/tests/dromaeo/cssquery-prototype.html) 11:25:48 INFO - PROCESS | 7627 | RSS: Main: 260059136 11:25:48 INFO - PROCESS | 7627 | 11:28:50 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50659/tests/dromaeo/cssquery-yui.html) 11:28:51 INFO - PROCESS | 7627 | RSS: Main: 248909824 11:28:51 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | Cycle 1(1): loaded http://localhost:50659/tests/dromaeo/cssquery-yui.html (next: http://localhost:50659/tests/dromaeo/cssquery-dojo.html) 11:31:54 INFO - PROCESS | 7627 | RSS: Main: 296587264 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | __start_tp_report 11:31:54 INFO - PROCESS | 7627 | _x_x_mozilla_page_load 11:31:54 INFO - PROCESS | 7627 | _x_x_mozilla_page_load_details 11:31:54 INFO - PROCESS | 7627 | |i|pagename|runs| 11:31:54 INFO - PROCESS | 7627 | |0;dojo.html;3114.906552803416;3123.7500999920007;3134.9843250783742;3138.591983042204;3188.155138888195;5256.553192978592;5322.946770532293;5362.919556206655;5433.375161856387;5472.9179062314;5356.250124982495;5410.56715462763;5429.484199001088;5437.265969094171;5470.7264636768205;4856.5143485651415;4886.780094895738;4940.086084074458;4953.678010929278;5056;4959.107360675077;4965.950340496603;5004.9749751251375;5007.974960125212;5029.195328747401;4789.497102804207;4832.057748738997;4852.296417019547;4941.407031156248;4946.975265123688;4852.2479015752615;4861.295112208745;4882.853514394574;4929.2113261878285;4979.8008079676765;4887.218045112801;4916.918277978839;4922.507749225048;4928.6303527235605;4973.502649734997;5242.397124330712;5367.114426119686;5389.299391079174;5454.563634909197;5455.727213639342;5872.17789509469;5903.291605007426;5920.703964801743;5926.7925622603;5930.199423077873;5952.375000624916;5953.851153721192;5958.40415958405;5974.940250597482;5977.193078934331;5273.947260527384;5353.544948679367;5397.62216644835;5400.91898621521;5486.972565137228;5967.641941483438;5972.25346831646;5977.282726072899;5977.372375900555;5978.461938425563;5463.535599474089;5763.106718458645;5766.163906233656;5773.422657734277;5773.711314434261;5670.262865827499;5733.827985160452;5739.885202295931;5742.655440673573;5753.712314384264;5690;5736.282964629421;5736.655800651891;5740.167675687086;5742.109972954198;5558.555315574744;5668.319801623831;5704.372519022904;5739;5740.081586946152;4318.892027699333;4349.26062569364;4351;4392.846250381285;4395.252807022814;3895.2793733159456;3915.5888631693833;3919.235749028969;3929.430232616312;3961.801909904493;5300.2049692546425;5366.060939335601;5420.403755586883;5452.100403433468;5499.340079190522;5717.885642287214;5750.2237197978575;5771.711414429262;5773.105168698775;5826.941730582725;5426.511613954763;5428.75570599324;5436.130219164915;5441.075017247077;5447.53695935842;4677.508861569486;4770.427548694179;4811.133995880775;4831.613470922318;4849.321095046696;6054.788082417094;6059.515238780887;6061.060535616986;6069.484093851984;6100.48145907594;5862.149988251595;5880.059190529495;5881.441263080001;5885.3820348864465;5885.646861188342;5746.971265143815;5783.681897495678;5816.883662326814;5856.531477481876;6054.697265136813;5639.295088113986;5642.88714225705;5647.717614119196;5648.604597678123;5666.121751128581;5678.119891416837;5709.143628455765;5737.08206686928;5739.397363276963;5743.10981797822;5435.429279925551;5552.500274975271;5574.136008918624;5597.384287728428;5662.235598194191;5666.2350582670815;5690.971545142414;5691.288588926384;5693.231413759089;5703.942960570341;5427.972860135832;5564.972175139261;5634.605577609528;5640.210370548045;5647.774089036392;5647.604667673223;5697.3448053474385;5699.145128230799;5755.7697692093525;5765.509931655856;5586.301712285965;5592.3009623797025;5593.468620481048;5599.244102046335;5646.604737668324 11:31:54 INFO - PROCESS | 7627 | |1;ext.html;629.7229219143579;630.6909614289;634.3529599808196;647.3494138390917;648.8021153548167;31240.21899452512;42450.787746061265;43876.341854872124;43916.341254881205;48097.278540821826;45293.547064529346;45735.77132114335;45740;45743.313850292274;45775.31337029939;8792.78018049549;8934.195922366986;8939.910600894005;8965.058668839743;8977.46135231885;8700.129987001312;8824.735257942271;8841.778955526099;8854.114588541159;8933.419327743675;8958.193762561368;8997.77505562363;8998.86501702475;9004.639814407416;9011;8904.51025193614;8953.6866209683;8968.68609598661;8969.820603587892;8972.05793391691;8847.115288471166;8912.420692654956;8926.86609700855;8928.24109950655;8936.285097192209;42705.1458970822;43082.13835723268;43154.56845431537;43204.567954320366;43215.56784432147;3742.326381251401;3807.619238076198;3932.488776459071;4004.8197831097377;4299.226139294926;30994;31490.37019259602;31725.36549269025;31756.523652145235;31899;3994.2610617035944;4180.937285940683;4231.217224813419;4265.594768496988;4278.101598664284;355364;357054;358983;359101;359265.9999999974;59846;60450;60509.39490605125;60517.69741151354;60539.39460605426;62075.37924620786;62346.688266558376;62442.375576244565;62518;62574.37425625685;16816;17027.91486042562;17035.914820426067;17049;17057.658846822993;12912.612621621367;13045.282509462071;13051;13061.738765224833;13071.41178646963;16082.35670573164;17833.643327133643;17851.304126108;18053.7291940621;18111.547211319823;5990.5507086968655;6178.62928224308;6216.222972128484;6271.62370257786;6424.16485856845;915.514777168102;987.7086259553449;996.785691076422;1066.5040756048475;1080.2816127275273;32135.839320803712;32391.35217295641;32439.513407298437;32460;32493.35013299768;1078.7842431513573;1104.5857803323754;1107.2858006585707;1116.4752566293828;1137.766757814646;16357.918210408872;16827.74758378625;16893;16895.83104168967;16930.76529877968;568823;571855;572371;572389;572966;58230.7088464555;58595.70702146462;58628.41371586315;58871.70564147238;58902.41097589055;1264.5574049082932;1354.8306461692289;1363.400103954257;1365.5630198336635;1390.242317936727;29805.403891922473;34165.31669366549;34194.82902585471;34298.828505858306;34580.65419345875;50738;50739.49260507496;51001;51151;51230.487695124066;413653;415672;415904;416486;418075;27996;28653.426931461672;28934.710652894042;29022.854885725435;29032;49305.75347123241;49358.75320623374;49922.75038624783;50616;50916.23625645544;41036.79481602692;41870;42123.368149478396;42685.35971960485;43041.569584303754;41488;41703.374449382674;42147.7892610535;42257.140428849845;42463.57536424596;41317;41704.95737606584;41859.372109417774;42155.57844421516;42271.57728422799;35165.47251791174;37284.44073338848;37328.62671373251;37999.430008550444;38220.61779382282;28491.43017139687;29127.85436072806;29150.27124321909;29220.853895730386;29374 11:31:54 INFO - PROCESS | 7627 | |2;jquery.html;380.40086863190476;381.10250360401255;388.23905145914006;392.8350092960956;406.29913399386044;17291.567710807238;18770.343037993673;19154.13806378713;19163.233470661173;19190.23239070439;16969.3212271509;17816.109194540255;18421.263149474005;18811;18860.528486787836;5201.713905735173;5322.973385133069;5380.515753582177;5386.649867758583;5579.38626751057;5537.473939975716;5719.628224165437;5726.255586773735;5757.942420575803;5761.193432919395;5234.42421333653;5364.275822763935;5691.459311365414;5696.743646535916;5706.572007099463;5226.52961233487;5250.396204436501;5275.0768615492325;5275.28783614211;5277.076511610453;4861.149298872683;5114.616403769732;5123.231515272739;5156.535911767922;5163.922541161885;21455.785442145534;21945.122195112337;22325.888370558205;22380.664290035664;22415.103395864146;2117.3224568138203;2201.438633148553;2218.556288742258;2278.544291141778;2318.6637937499136;9383.671571494964;10566.577336906514;12035.699107522381;12532.436040378205;12798.552050678181;1758.6394789068338;1815.1922394534438;1888.2352647177777;1902.657521646103;1915.415798181554;77143.61428192822;77223;77492.61253693752;78055.60972195103;78692;10141.847872281922;10518.842217366746;10802.891971080346;10893;11192.888071119347;15369.923150384177;15406.460773872861;15416.691666166615;15424.768628470581;15468.07191568487;7733.188015258429;8021.438499305109;8032.638531266107;8130.390220733469;8148.429609927367;7601.695932162762;7670.7698769037015;7722.922770772333;7729.922700773032;7807.80480487981;4576.290674945389;4657.184992626277;4662.417197850269;4665.9766701166955;4788.209945359046;1927.88432694036;1968.6456437841039;2005.6189324028387;2019.414369832732;2036.175348983664;873.1879352202512;929.330881765128;946.5598496699068;988.4415305352453;1089.6894385100368;17430.738538921927;17551.29794808219;17968.550786230186;18762.372062332826;19153.712694309597;937.9296552758434;940.7459985803931;979.2373727290848;1023.1150055202196;1049.6916902714927;10388.688339349832;10595.364278143335;10668.946655266674;10744.520294649785;10778.461076946121;472806;475527;488478;489682;491702;68088.6595567019;96872;98029.50985245028;98090;98414;978.2907392140784;997.9351342162736;1008.7629407089328;1036.2746077745608;1036.9637062702768;16928.40750573724;17724.113794309975;17732.645347093243;17783.46649600514;17854.642907142043;36069.819650901576;40661.79669101635;40974.79512602418;41414.792926035174;41697.100321299855;51819.481805181465;53607.46392536181;56847.71576142093;56985;57253.141202881154;7995.560244186626;8172.713955011546;8215.34277257806;8267.710630127916;8279.461834980948;9070.818583628423;12710.809337859755;13062.216267024009;13130.080894337687;13740.725185496434;11719.238249513754;12020.699482513008;12070.517179312728;12192.939035304767;12297.877021230031;11755.47100380502;11820.408979550815;11845.881541184477;11953.940230298793;12294.323812190058;12057.336846473178;12102.152849300464;12124.454399552218;12246.816297755362;12363.258204507758;8101.594920254081;8260.339172866277;8279.668813247403;8530.829383412422;8884.378093533649;9576;10239.795204095728;11347.432628368713;11740.119491038036;11878.584249551224 11:31:54 INFO - PROCESS | 7627 | |3;mootools.html;1302.9674258143539;1461.0211158523791;1484.3172140815225;1593.5936336234258;1739.0782885070917;8195.098539160688;8503.404761666687;8537.31701463883;8726.301895848334;8736;8477.152284771535;8656.047834738174;8662;8663.39356245063;8677.349198810083;1886.4812176651394;1944.057132290838;1945.5136215946013;2257.16484900587;2269.296518079401;2290.633498640218;2353.047015958531;2354.5526349993534;2361.6929799126174;2364.148906393697;2271.7955384015436;2272.284230467406;2292.793648571628;2293.839431239814;2314.5718042162252;1908.6182763447366;2192.8793916334594;2241.5180736141724;2275.9317220483413;2276.271593090212;2258.5934531784274;2291.083566573384;2297.4600968772324;2306.5041016181603;2308.5036717105736;8484.278836298921;8545.615447304886;8562.272206862424;8572.185642363966;8573.614187361583;4974.701517908937;5101.362329708786;5109.795608175668;5111.386633603955;5120.539151476385;3035.3777475617444;3134.3731253749343;3324.6010478742705;3341.9498707519406;3348.4475061614803;1018.3431686562126;1025.4718819807806;1033.6743925663468;1034.57065317893;1036.7243899640293;11782.764344713143;11807.645770626896;11811.704707382298;11820.23168494045;11821.586244481401;4533.909321813545;4599.67802253839;4745.2882067690125;4747.667663263538;4761.214399624093;10143.442110683836;10161.644342447978;10168.949155254177;10185.898141018642;10218;5212.843614691566;5275.076861549213;5278.049951008856;5285.973570132125;5289.947100528945;4587.3348364486965;4723.83466578675;4726.881827954328;4804.2073057945045;4859.65982381237;3885.7279990400966;3912.9608703912595;3975.3241948868763;4019.5980401960155;4046.352583586612;1221.4686611324103;1231.4335405713293;1244.8132780082879;1259.2192840438986;1266.0567876931746;973.8782652168479;977.4672803322064;982.4743762087392;989.8020395920845;1017.9796404071877;5624.606277560613;5774.422557744192;5815.244018277597;5832.096025116114;5941.881162376728;970.3110791338088;985.9112679858847;990.3958585262984;1005.3816902604846;1043.3896170740202;3803.9619603804163;3864.729468937204;4015.13674559971;4021.758694478282;4267.4025636410925;10292.948535257276;10498.422586757802;10627.893721062845;10644.89355106439;10647.30792498485;10401.58393664245;10487.161027117812;10511.632092876713;10517.894821051692;10519.684409467729;7499.287567680953;7854.6858125674335;8028.394321135796;8045.275925166763;8073.6366863491285;5955.255593050869;6009.128676341818;6022.52448150206;6167.044108163242;6208.875822483435;9596.66411675588;9687;9996.150327222267;9996.950015249877;10017.298789084985;8478.533680647624;9565.952170239105;10024.799504009734;10059.943705910773;10121.493925303852;7385.630718464163;7602;7626.694932202871;7642.885356719765;7654.578998155155;7957.403194760532;8202.056763472277;8206.302464290364;8207.138250483613;8220;7298.598577078099;7318.414526837733;7344.889826652711;7382.889256661047;7450.6647200875;7177.461690373348;7190.06529151207;7384.778456646309;7479.513831600929;7485;6634.767783127568;6785.491088168308;6890.655467226718;6907.13660792401;7025.789226323219;5139.511746384088;5195.948040519546;5233.241180028798;5244.9737751310995;5358.276632654698;5137.691738495702;5144.125498665161;5197.168453047494;5251.3960894496095;5289.021531016774 11:31:54 INFO - PROCESS | 7627 | |4;prototype.html;301.6169464779728;316.4872905892454;319.48881789137397;320.83156342919966;324.704518887812;5286.418493965665;5330.89338213236;5345.919811202825;5386.326709161355;5397.892042159159;5043.268726034723;5131.974340128303;5265.157574788034;5295.523402893738;5297.947020529803;4059.7564146151326;4090.9590904091024;4101.8974525636795;4103.13834094839;4103.8563650272245;4087.386891966214;4098.4876890388705;4110.794460276989;4117.608827161415;4120.217158739845;3920.9411858822;3931.5871833457504;3944.5463771666195;3998.5401678806875;3999.1601763629674;3967.960320396788;3977.801109944491;3986.5216174059155;4005.2790497710403;4039.333509970851;3499.725178633883;3506.6493350664987;3517.8944631661093;3523.6300188480354;3537.8231088445473;4900.975495122501;5070.138076526962;5083.288339632454;5102.464241254652;5106.64253502255;4541.477730061019;4544.454665440136;4558.977205113986;4560.931586026212;4561.361409402686;5371.75827087782;5400.513953744182;5400.702961337125;5425.02349577076;5434.2935418395355;3800.5439347278502;3853.9036524087123;3861.826217820205;3890.3191941410423;3895.2793733159456;5595.692236927008;5613.578981576357;5620.91568626471;5654.519365853907;5655.886882262332;3988.3818008208773;3997.920041599152;4032.1330913853662;4035.1727895781296;4041.8383264669083;3989.7606143631474;4026.4362989181536;4083.734557253769;4100.712950093465;4125.752454852718;4562.908741825145;4580.770961451914;4593.816247350135;4616.28447590624;4638.793913582493;5459.727013649302;5462.9726851365485;5464.480874316933;5480.80767692926;5508.834734957958;1328.1566205459603;1361.8433880103717;1391.7773156294945;1393.4426229508076;1415;875.6978842299396;898.0615257056392;910.7905181808088;912.9911447850163;915.7298596913793;4715.693479923794;4748.311494833299;4764.904701905943;4785.210440277385;4800.8477965288075;5005.499450054966;5014.267224362731;5030.308784800114;5039.420466646309;5046.848594542096;4574.519675434098;4739.881502962385;4741.668083234141;4775.928361074587;4777.355057067321;2665.893364265408;2668.7731542818688;2676.424568717735;2697;2700.837949723023;5115.18157094863;5162.038425398325;5168.457311982263;5192.948070519322;5213.504717051874;4820.558175124081;5066.238899799618;5104.923426148611;5107.87230319245;5143.168339587031;5114.820981265638;5124.461931497213;5131.486211567521;5132.897342053213;5162.793488260428;4945.727984960861;5000.099962014411;5004.2493625956395;5018.021485810232;5030.874228144326;4911.557959783637;4966.900661986668;4972.328735620789;5257;5701.4298570142655;5837.357890632112;5852.824415267549;5857.677827719346;5902.380250073852;5907.32065812437;3982.78094704794;3988.202359528164;3992.461017762565;3996.620321069494;4011.4383986242533;5347.78608855657;5398.652835242175;5715.457031581993;5724.8282551523525;5730.74211660468;5311.309529761106;5466.398696143341;5490.725463726878;5497.532709719719;5521.641093328921;5470;5504.311961004874;5600.523955463668;5602.747876345656;5610.18652295423;5167.250748641351;5356.437574054824;5369.97315013438;5426.67439953604;5450.920230069998;5497.790486093053;5512.972435137799;5535.25274087993;5566.666000040011;5570.916436253378;5389.973050134724;5391.191321301836;5424.267723857387;5425.83344580917;5427.99582077317 11:31:54 INFO - PROCESS | 7627 | |5;yui.html;744.0067509874317;747.932686058255;764.5794812852929;768.1703759939267;777.6383981448627;14849.554513364603;15065.849341506582;15120.546383608496;15875.761863572041;16182.75725864113;14354.354054067566;14466.782998255034;14515.782263266059;14520.927395363035;14686.779698304534;658.4271683635244;782.0654318089885;794.3287921706149;810.2626609785096;813.6785969542027;803.8753993131074;808.7856717969743;809.0534075132109;809.0857331215718;809.2150613904532;849.0617867256685;852.7527017165015;854.1202561361807;854.4830377621543;854.5855260198798;691.9688614012382;839.1859895900966;851.7913111287712;852.109545524928;859.9914000859974;604.7550741949517;606.0727087556046;606.7845914700262;607.1803065861096;607.3622696169004;15136;15144.54566363011;15161.696766064617;15170.31733571992;15173.24133793317;14687.779683304652;14954.40182392703;15014.549563513112;15045.172515511642;15174.241287935669;11775.88224117765;11937.761244775143;12206.572769953009;12412.689682757913;12472.189307694971;3876.573576906538;3905.6875449963936;4004.3392840181336;4071.7760523171214;4082.632563069338;58846;59305.7034714828;59905.40094599042;59990.40009599892;60121;11530.365829879269;11580;11788.764224715458;11862.88137118635;12327.137100403064;21719.457013574785;21874.89062554677;21885.562288754136;21888.671669924963;21890.45273868166;8445.57772111392;8708.738737837875;8783.868241976375;8785.165409286108;8806.25146862511;4810.39870016248;4870.220764677705;4895.73073480962;4982.825601103944;5097.898042039138;3412.8805491807666;3511.4206155983975;3527.94708079379;3532;3534.169470174507;516.2694786876602;605.4006533531772;613.055893923362;621.1862460177182;635.1679300116862;554.4427850010794;557.2783245696833;601.0533409879457;655.8589903170841;707.7098389660215;9880.209583233323;9991.500424978722;10036;10038.598456061822;10070.647527336509;557.6263903184876;629.222909706512;661.5732852310233;702.3398005874564;755.8903958926035;4668.649851261169;4726.432828060655;4885.812047425795;4939.234418665113;4963.5780958618925;77183;91233.54383228041;98177;111118.44440777744;112883.43558282156;64058;92724;96698.516507417;97376.51311743396;98691.50654246683;63065.68467157726;64898;87109;87398;88065.99999999872;9603.606838629803;9860.750083569917;10005.54975026111;10040.899591003996;10063.496825158567;48208;48708.5129148704;48778;49573.504264956886;50322.49677503324;70667.64666176842;72582;73516;73901.26098738944;74113.25886741064;12716.682082948;12883.770840370933;12905.290209038592;12942.223466592035;13283.070185086952;14307.64230894236;14671.779923301372;14845.554633361016;14944.925275373553;15193.594515278584;13309.741180202447;13930;14018.789718154032;14502.1298722077;14552.199629020506;13673.589792306248;13853.515126970507;13907.235102069484;14040.78938815939;14295.499657511937;13293.20240785556;13718.314084295545;13788.103773254707;14054.156750594997;14147.858521414653;10944.452777361259;11034.913026901679;11232.719182020515;11447.942760286145;11502;10815.56737730482;11183.72040698989;11626;11805;11832.467538960595 11:31:54 INFO - PROCESS | 7627 | __end_tp_report 11:31:54 INFO - PROCESS | 7627 | __start_cc_report 11:31:54 INFO - PROCESS | 7627 | _x_x_mozilla_cycle_collect,943 11:31:54 INFO - PROCESS | 7627 | __end_cc_report 11:31:54 INFO - PROCESS | 7627 | __startTimestamp1465497114424__endTimestamp 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | ------- Summary: start ------- 11:31:54 INFO - PROCESS | 7627 | Number of tests: 6 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#0] dojo.html Cycles:165 Average:5364.57 Median:5586.30 stddev:621.90 (11.1%) stddev-sans-first:598.24 11:31:54 INFO - PROCESS | 7627 | Values: 3114.9 3123.8 3135.0 3138.6 3188.2 5256.6 5322.9 5362.9 5433.4 5472.9 5356.3 5410.6 5429.5 5437.3 5470.7 4856.5 4886.8 4940.1 4953.7 5056.0 4959.1 4966.0 5005.0 5008.0 5029.2 4789.5 4832.1 4852.3 4941.4 4947.0 4852.2 4861.3 4882.9 4929.2 4979.8 4887.2 4916.9 4922.5 4928.6 4973.5 5242.4 5367.1 5389.3 5454.6 5455.7 5872.2 5903.3 5920.7 5926.8 5930.2 5952.4 5953.9 5958.4 5974.9 5977.2 5273.9 5353.5 5397.6 5400.9 5487.0 5967.6 5972.3 5977.3 5977.4 5978.5 5463.5 5763.1 5766.2 5773.4 5773.7 5670.3 5733.8 5739.9 5742.7 5753.7 5690.0 5736.3 5736.7 5740.2 5742.1 5558.6 5668.3 5704.4 5739.0 5740.1 4318.9 4349.3 4351.0 4392.8 4395.3 3895.3 3915.6 3919.2 3929.4 3961.8 5300.2 5366.1 5420.4 5452.1 5499.3 5717.9 5750.2 5771.7 5773.1 5826.9 5426.5 5428.8 5436.1 5441.1 5447.5 4677.5 4770.4 4811.1 4831.6 4849.3 6054.8 6059.5 6061.1 6069.5 6100.5 5862.1 5880.1 5881.4 5885.4 5885.6 5747.0 5783.7 5816.9 5856.5 6054.7 5639.3 5642.9 5647.7 5648.6 5666.1 5678.1 5709.1 5737.1 5739.4 5743.1 5435.4 5552.5 5574.1 5597.4 5662.2 5666.2 5691.0 5691.3 5693.2 5703.9 5428.0 5565.0 5634.6 5640.2 5647.8 5647.6 5697.3 5699.1 5755.8 5765.5 5586.3 5592.3 5593.5 5599.2 5646.6 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#1] ext.html Cycles:180 Average:61236.32 Median:23251.40 stddev:121424.13 (522.2%) stddev-sans-first:121679.49 11:31:54 INFO - PROCESS | 7627 | Values: 629.7 630.7 634.4 647.3 648.8 31240.2 42450.8 43876.3 43916.3 48097.3 45293.5 45735.8 45740.0 45743.3 45775.3 8792.8 8934.2 8939.9 8965.1 8977.5 8700.1 8824.7 8841.8 8854.1 8933.4 8958.2 8997.8 8998.9 9004.6 9011.0 8904.5 8953.7 8968.7 8969.8 8972.1 8847.1 8912.4 8926.9 8928.2 8936.3 42705.1 43082.1 43154.6 43204.6 43215.6 3742.3 3807.6 3932.5 4004.8 4299.2 30994.0 31490.4 31725.4 31756.5 31899.0 3994.3 4180.9 4231.2 4265.6 4278.1 355364.0 357054.0 358983.0 359101.0 359266.0 59846.0 60450.0 60509.4 60517.7 60539.4 62075.4 62346.7 62442.4 62518.0 62574.4 16816.0 17027.9 17035.9 17049.0 17057.7 12912.6 13045.3 13051.0 13061.7 13071.4 16082.4 17833.6 17851.3 18053.7 18111.5 5990.6 6178.6 6216.2 6271.6 6424.2 915.5 987.7 996.8 1066.5 1080.3 32135.8 32391.4 32439.5 32460.0 32493.4 1078.8 1104.6 1107.3 1116.5 1137.8 16357.9 16827.7 16893.0 16895.8 16930.8 568823.0 571855.0 572371.0 572389.0 572966.0 58230.7 58595.7 58628.4 58871.7 58902.4 1264.6 1354.8 1363.4 1365.6 1390.2 29805.4 34165.3 34194.8 34298.8 34580.7 50738.0 50739.5 51001.0 51151.0 51230.5 413653.0 415672.0 415904.0 416486.0 418075.0 27996.0 28653.4 28934.7 29022.9 29032.0 49305.8 49358.8 49922.8 50616.0 50916.2 41036.8 41870.0 42123.4 42685.4 43041.6 41488.0 41703.4 42147.8 42257.1 42463.6 41317.0 41705.0 41859.4 42155.6 42271.6 35165.5 37284.4 37328.6 37999.4 38220.6 28491.4 29127.9 29150.3 29220.9 29374.0 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#2] jquery.html Cycles:180 Average:28460.24 Median:384.67 stddev:79748.96 (20731.7%) stddev-sans-first:79944.81 11:31:54 INFO - PROCESS | 7627 | Values: 380.4 381.1 388.2 392.8 406.3 17291.6 18770.3 19154.1 19163.2 19190.2 16969.3 17816.1 18421.3 18811.0 18860.5 5201.7 5323.0 5380.5 5386.6 5579.4 5537.5 5719.6 5726.3 5757.9 5761.2 5234.4 5364.3 5691.5 5696.7 5706.6 5226.5 5250.4 5275.1 5275.3 5277.1 4861.1 5114.6 5123.2 5156.5 5163.9 21455.8 21945.1 22325.9 22380.7 22415.1 2117.3 2201.4 2218.6 2278.5 2318.7 9383.7 10566.6 12035.7 12532.4 12798.6 1758.6 1815.2 1888.2 1902.7 1915.4 77143.6 77223.0 77492.6 78055.6 78692.0 10141.8 10518.8 10802.9 10893.0 11192.9 15369.9 15406.5 15416.7 15424.8 15468.1 7733.2 8021.4 8032.6 8130.4 8148.4 7601.7 7670.8 7722.9 7729.9 7807.8 4576.3 4657.2 4662.4 4666.0 4788.2 1927.9 1968.6 2005.6 2019.4 2036.2 873.2 929.3 946.6 988.4 1089.7 17430.7 17551.3 17968.6 18762.4 19153.7 937.9 940.7 979.2 1023.1 1049.7 10388.7 10595.4 10668.9 10744.5 10778.5 472806.0 475527.0 488478.0 489682.0 491702.0 68088.7 96872.0 98029.5 98090.0 98414.0 978.3 997.9 1008.8 1036.3 1037.0 16928.4 17724.1 17732.6 17783.5 17854.6 36069.8 40661.8 40974.8 41414.8 41697.1 51819.5 53607.5 56847.7 56985.0 57253.1 7995.6 8172.7 8215.3 8267.7 8279.5 9070.8 12710.8 13062.2 13130.1 13740.7 11719.2 12020.7 12070.5 12192.9 12297.9 11755.5 11820.4 11845.9 11953.9 12294.3 12057.3 12102.2 12124.5 12246.8 12363.3 8101.6 8260.3 8279.7 8530.8 8884.4 9576.0 10239.8 11347.4 11740.1 11878.6 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#3] mootools.html Cycles:180 Average:5656.99 Median:4831.93 stddev:3179.78 (65.8%) stddev-sans-first:3171.86 11:31:54 INFO - PROCESS | 7627 | Values: 1303.0 1461.0 1484.3 1593.6 1739.1 8195.1 8503.4 8537.3 8726.3 8736.0 8477.2 8656.0 8662.0 8663.4 8677.3 1886.5 1944.1 1945.5 2257.2 2269.3 2290.6 2353.0 2354.6 2361.7 2364.1 2271.8 2272.3 2292.8 2293.8 2314.6 1908.6 2192.9 2241.5 2275.9 2276.3 2258.6 2291.1 2297.5 2306.5 2308.5 8484.3 8545.6 8562.3 8572.2 8573.6 4974.7 5101.4 5109.8 5111.4 5120.5 3035.4 3134.4 3324.6 3341.9 3348.4 1018.3 1025.5 1033.7 1034.6 1036.7 11782.8 11807.6 11811.7 11820.2 11821.6 4533.9 4599.7 4745.3 4747.7 4761.2 10143.4 10161.6 10168.9 10185.9 10218.0 5212.8 5275.1 5278.0 5286.0 5289.9 4587.3 4723.8 4726.9 4804.2 4859.7 3885.7 3913.0 3975.3 4019.6 4046.4 1221.5 1231.4 1244.8 1259.2 1266.1 973.9 977.5 982.5 989.8 1018.0 5624.6 5774.4 5815.2 5832.1 5941.9 970.3 985.9 990.4 1005.4 1043.4 3804.0 3864.7 4015.1 4021.8 4267.4 10292.9 10498.4 10627.9 10644.9 10647.3 10401.6 10487.2 10511.6 10517.9 10519.7 7499.3 7854.7 8028.4 8045.3 8073.6 5955.3 6009.1 6022.5 6167.0 6208.9 9596.7 9687.0 9996.2 9997.0 10017.3 8478.5 9566.0 10024.8 10059.9 10121.5 7385.6 7602.0 7626.7 7642.9 7654.6 7957.4 8202.1 8206.3 8207.1 8220.0 7298.6 7318.4 7344.9 7382.9 7450.7 7177.5 7190.1 7384.8 7479.5 7485.0 6634.8 6785.5 6890.7 6907.1 7025.8 5139.5 5195.9 5233.2 5245.0 5358.3 5137.7 5144.1 5197.2 5251.4 5289.0 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#4] prototype.html Cycles:180 Average:4471.06 Median:5024.17 stddev:1306.61 (26.0%) stddev-sans-first:1272.25 11:31:54 INFO - PROCESS | 7627 | Values: 301.6 316.5 319.5 320.8 324.7 5286.4 5330.9 5345.9 5386.3 5397.9 5043.3 5132.0 5265.2 5295.5 5297.9 4059.8 4091.0 4101.9 4103.1 4103.9 4087.4 4098.5 4110.8 4117.6 4120.2 3920.9 3931.6 3944.5 3998.5 3999.2 3968.0 3977.8 3986.5 4005.3 4039.3 3499.7 3506.6 3517.9 3523.6 3537.8 4901.0 5070.1 5083.3 5102.5 5106.6 4541.5 4544.5 4559.0 4560.9 4561.4 5371.8 5400.5 5400.7 5425.0 5434.3 3800.5 3853.9 3861.8 3890.3 3895.3 5595.7 5613.6 5620.9 5654.5 5655.9 3988.4 3997.9 4032.1 4035.2 4041.8 3989.8 4026.4 4083.7 4100.7 4125.8 4562.9 4580.8 4593.8 4616.3 4638.8 5459.7 5463.0 5464.5 5480.8 5508.8 1328.2 1361.8 1391.8 1393.4 1415.0 875.7 898.1 910.8 913.0 915.7 4715.7 4748.3 4764.9 4785.2 4800.8 5005.5 5014.3 5030.3 5039.4 5046.8 4574.5 4739.9 4741.7 4775.9 4777.4 2665.9 2668.8 2676.4 2697.0 2700.8 5115.2 5162.0 5168.5 5192.9 5213.5 4820.6 5066.2 5104.9 5107.9 5143.2 5114.8 5124.5 5131.5 5132.9 5162.8 4945.7 5000.1 5004.2 5018.0 5030.9 4911.6 4966.9 4972.3 5257.0 5701.4 5837.4 5852.8 5857.7 5902.4 5907.3 3982.8 3988.2 3992.5 3996.6 4011.4 5347.8 5398.7 5715.5 5724.8 5730.7 5311.3 5466.4 5490.7 5497.5 5521.6 5470.0 5504.3 5600.5 5602.7 5610.2 5167.3 5356.4 5370.0 5426.7 5450.9 5497.8 5513.0 5535.3 5566.7 5570.9 5390.0 5391.2 5424.3 5425.8 5428.0 11:31:54 INFO - PROCESS | 7627 | 11:31:54 INFO - PROCESS | 7627 | [#5] yui.html Cycles:180 Average:19398.71 Median:26509.20 stddev:26577.33 (100.3%) stddev-sans-first:26614.98 11:31:54 INFO - PROCESS | 7627 | Values: 744.0 747.9 764.6 768.2 777.6 14849.6 15065.8 15120.5 15875.8 16182.8 14354.4 14466.8 14515.8 14520.9 14686.8 658.4 782.1 794.3 810.3 813.7 803.9 808.8 809.1 809.1 809.2 849.1 852.8 854.1 854.5 854.6 692.0 839.2 851.8 852.1 860.0 604.8 606.1 606.8 607.2 607.4 15136.0 15144.5 15161.7 15170.3 15173.2 14687.8 14954.4 15014.5 15045.2 15174.2 11775.9 11937.8 12206.6 12412.7 12472.2 3876.6 3905.7 4004.3 4071.8 4082.6 58846.0 59305.7 59905.4 59990.4 60121.0 11530.4 11580.0 11788.8 11862.9 12327.1 21719.5 21874.9 21885.6 21888.7 21890.5 8445.6 8708.7 8783.9 8785.2 8806.3 4810.4 4870.2 4895.7 4982.8 5097.9 3412.9 3511.4 3527.9 3532.0 3534.2 516.3 605.4 613.1 621.2 635.2 554.4 557.3 601.1 655.9 707.7 9880.2 9991.5 10036.0 10038.6 10070.6 557.6 629.2 661.6 702.3 755.9 4668.6 4726.4 4885.8 4939.2 4963.6 77183.0 91233.5 98177.0 111118.4 112883.4 64058.0 92724.0 96698.5 97376.5 98691.5 63065.7 64898.0 87109.0 87398.0 88066.0 9603.6 9860.8 10005.5 10040.9 10063.5 48208.0 48708.5 48778.0 49573.5 50322.5 70667.6 72582.0 73516.0 73901.3 74113.3 12716.7 12883.8 12905.3 12942.2 13283.1 14307.6 14671.8 14845.6 14944.9 15193.6 13309.7 13930.0 14018.8 14502.1 14552.2 13673.6 13853.5 13907.2 14040.8 14295.5 13293.2 13718.3 13788.1 14054.2 14147.9 10944.5 11034.9 11232.7 11447.9 11502.0 10815.6 11183.7 11626.0 11805.0 11832.5 11:31:54 INFO - PROCESS | 7627 | -------- Summary: end -------- 11:31:54 INFO - PROCESS | 7627 | 11:31:55 INFO - TEST-INFO | 7627: exit 0 11:31:55 INFO - TEST-OK | dromaeo_css | took 1114364ms 11:31:55 INFO - TEST-START | kraken 11:31:55 INFO - operating with platform_type : linux_ 11:31:55 INFO - Initialising browser for kraken test... 11:31:55 INFO - TEST-INFO | started process 7809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDyinma/profile http://localhost:50659/getInfo.html) 11:31:59 INFO - PROCESS | 7809 | __metrics Screen width/height:1600/1200 11:31:59 INFO - PROCESS | 7809 | colorDepth:24 11:31:59 INFO - PROCESS | 7809 | Browser inner width/height: 1024/697 11:31:59 INFO - PROCESS | 7809 | __metrics 11:32:00 ERROR - PROCESS | 7809 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:32:00 INFO - PROCESS | 7809 | console.error: PushService: 11:32:00 INFO - PROCESS | 7809 | stateChangeProcessEnqueue: Error transitioning state 11:32:00 INFO - PROCESS | 7809 | UnknownError 11:32:01 INFO - TEST-INFO | 7809: exit 0 11:32:01 INFO - Browser initialized. 11:32:01 INFO - Running cycle 1/1 for kraken test... 11:32:01 INFO - TEST-INFO | started process 7891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDyinma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:13 INFO - PROCESS | 7891 | RSS: Main: 177332224 11:32:13 INFO - PROCESS | 7891 | 11:32:15 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50659/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:16 INFO - PROCESS | 7891 | RSS: Main: 235147264 11:32:16 INFO - PROCESS | 7891 | 11:32:19 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50659/tests/kraken/driver.html?testName=audio-dft) 11:32:20 INFO - PROCESS | 7891 | RSS: Main: 224714752 11:32:20 INFO - PROCESS | 7891 | 11:32:23 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50659/tests/kraken/driver.html?testName=audio-fft) 11:32:23 INFO - PROCESS | 7891 | RSS: Main: 289574912 11:32:23 INFO - PROCESS | 7891 | 11:32:25 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50659/tests/kraken/driver.html?testName=audio-oscillator) 11:32:26 INFO - PROCESS | 7891 | RSS: Main: 199868416 11:32:26 INFO - PROCESS | 7891 | 11:32:28 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:29 INFO - PROCESS | 7891 | RSS: Main: 204627968 11:32:29 INFO - PROCESS | 7891 | 11:32:32 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50659/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:32 INFO - PROCESS | 7891 | RSS: Main: 240082944 11:32:32 INFO - PROCESS | 7891 | 11:32:36 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50659/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:36 INFO - PROCESS | 7891 | RSS: Main: 240521216 11:32:36 INFO - PROCESS | 7891 | 11:32:39 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50659/tests/kraken/driver.html?testName=json-parse-financial) 11:32:40 INFO - PROCESS | 7891 | RSS: Main: 240775168 11:32:40 INFO - PROCESS | 7891 | 11:32:41 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:42 INFO - PROCESS | 7891 | RSS: Main: 223678464 11:32:42 INFO - PROCESS | 7891 | 11:32:44 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:44 INFO - PROCESS | 7891 | RSS: Main: 228876288 11:32:44 INFO - PROCESS | 7891 | 11:32:46 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:47 INFO - PROCESS | 7891 | RSS: Main: 236892160 11:32:47 INFO - PROCESS | 7891 | 11:32:50 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:50 INFO - PROCESS | 7891 | RSS: Main: 238768128 11:32:50 INFO - PROCESS | 7891 | 11:32:53 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:53 INFO - PROCESS | 7891 | RSS: Main: 237453312 11:32:53 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | Cycle 1(1): loaded http://localhost:50659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50659/tests/kraken/driver.html?testName=ai-astar) 11:32:55 INFO - PROCESS | 7891 | RSS: Main: 280010752 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | __start_tp_report 11:32:55 INFO - PROCESS | 7891 | _x_x_mozilla_page_load 11:32:55 INFO - PROCESS | 7891 | _x_x_mozilla_page_load_details 11:32:55 INFO - PROCESS | 7891 | |i|pagename|runs| 11:32:55 INFO - PROCESS | 7891 | |0;ai-astar;111;106;110;109;110;111;110;111;109;109 11:32:55 INFO - PROCESS | 7891 | |1;audio-beat-detection;152;125;126;182;136;129;157;132;156;132 11:32:55 INFO - PROCESS | 7891 | |2;audio-dft;159;160;162;161;160;160;161;162;161;161 11:32:55 INFO - PROCESS | 7891 | |3;audio-fft;74;75;75;122;74;74;73;75;108;74 11:32:55 INFO - PROCESS | 7891 | |4;audio-oscillator;84;85;115;85;86;86;125;86;85;132 11:32:55 INFO - PROCESS | 7891 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;116 11:32:55 INFO - PROCESS | 7891 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;146;146 11:32:55 INFO - PROCESS | 7891 | |7;imaging-desaturate;94;94;95;95;95;95;94;94;95;95 11:32:55 INFO - PROCESS | 7891 | |8;json-parse-financial;56;58;56;56;56;56;57;56;55;54 11:32:55 INFO - PROCESS | 7891 | |9;json-stringify-tinderbox;63;63;64;63;64;65;64;63;63;63 11:32:55 INFO - PROCESS | 7891 | |10;stanford-crypto-aes;81;79;79;80;81;80;80;80;132;80 11:32:55 INFO - PROCESS | 7891 | |11;stanford-crypto-ccm;136;124;122;119;119;120;126;130;140;134 11:32:55 INFO - PROCESS | 7891 | |12;stanford-crypto-pbkdf2;159;160;160;161;162;164;163;162;158;158 11:32:55 INFO - PROCESS | 7891 | |13;stanford-crypto-sha256-iterative;66;64;63;61;63;64;65;62;62;61 11:32:55 INFO - PROCESS | 7891 | __end_tp_report 11:32:55 INFO - PROCESS | 7891 | __start_cc_report 11:32:55 INFO - PROCESS | 7891 | _x_x_mozilla_cycle_collect,1640 11:32:55 INFO - PROCESS | 7891 | __end_cc_report 11:32:55 INFO - PROCESS | 7891 | __startTimestamp1465497175885__endTimestamp 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | ------- Summary: start ------- 11:32:55 INFO - PROCESS | 7891 | Number of tests: 14 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.51 (1.4%) stddev-sans-first:1.51 11:32:55 INFO - PROCESS | 7891 | Values: 111.0 106.0 110.0 109.0 110.0 111.0 110.0 111.0 109.0 109.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:144.00 stddev:18.46 (12.8%) stddev-sans-first:19.27 11:32:55 INFO - PROCESS | 7891 | Values: 152.0 125.0 126.0 182.0 136.0 129.0 157.0 132.0 156.0 132.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.78 11:32:55 INFO - PROCESS | 7891 | Values: 159.0 160.0 162.0 161.0 160.0 160.0 161.0 162.0 161.0 161.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#3] audio-fft Cycles:10 Average:82.40 Median:74.00 stddev:17.51 (23.7%) stddev-sans-first:18.30 11:32:55 INFO - PROCESS | 7891 | Values: 74.0 75.0 75.0 122.0 74.0 74.0 73.0 75.0 108.0 74.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.14 (22.5%) stddev-sans-first:19.72 11:32:55 INFO - PROCESS | 7891 | Values: 84.0 85.0 115.0 85.0 86.0 86.0 125.0 86.0 85.0 132.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:32:55 INFO - PROCESS | 7891 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:32:55 INFO - PROCESS | 7891 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:32:55 INFO - PROCESS | 7891 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.12 11:32:55 INFO - PROCESS | 7891 | Values: 56.0 58.0 56.0 56.0 56.0 56.0 57.0 56.0 55.0 54.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 11:32:55 INFO - PROCESS | 7891 | Values: 63.0 63.0 64.0 63.0 64.0 65.0 64.0 63.0 63.0 63.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:80.00 stddev:16.46 (20.6%) stddev-sans-first:17.39 11:32:55 INFO - PROCESS | 7891 | Values: 81.0 79.0 79.0 80.0 81.0 80.0 80.0 80.0 132.0 80.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:7.60 (5.9%) stddev-sans-first:7.33 11:32:55 INFO - PROCESS | 7891 | Values: 136.0 124.0 122.0 119.0 119.0 120.0 126.0 130.0 140.0 134.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.50 stddev:2.06 (1.3%) stddev-sans-first:2.09 11:32:55 INFO - PROCESS | 7891 | Values: 159.0 160.0 160.0 161.0 162.0 164.0 163.0 162.0 158.0 158.0 11:32:55 INFO - PROCESS | 7891 | 11:32:55 INFO - PROCESS | 7891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.66 (2.6%) stddev-sans-first:1.39 11:32:55 INFO - PROCESS | 7891 | Values: 66.0 64.0 63.0 61.0 63.0 64.0 65.0 62.0 62.0 61.0 11:32:55 INFO - PROCESS | 7891 | -------- Summary: end -------- 11:32:55 INFO - PROCESS | 7891 | 11:32:56 INFO - TEST-INFO | 7891: exit 0 11:32:56 INFO - TEST-OK | kraken | took 61647ms 11:32:56 INFO - SUITE-END | took 1176s 11:32:57 INFO - Completed test suite (00:19:36) 11:32:57 INFO - javascript benchmark 11:32:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.906552803416, 3123.7500999920007, 3134.9843250783742, 3138.591983042204, 3188.155138888195, 5256.553192978592, 5322.946770532293, 5362.919556206655, 5433.375161856387, 5472.9179062314, 5356.250124982495, 5410.56715462763, 5429.484199001088, 5437.265969094171, 5470.7264636768205, 4856.5143485651415, 4886.780094895738, 4940.086084074458, 4953.678010929278, 5056.0, 4959.107360675077, 4965.950340496603, 5004.9749751251375, 5007.974960125212, 5029.195328747401, 4789.497102804207, 4832.057748738997, 4852.296417019547, 4941.407031156248, 4946.975265123688, 4852.2479015752615, 4861.295112208745, 4882.853514394574, 4929.2113261878285, 4979.8008079676765, 4887.218045112801, 4916.918277978839, 4922.507749225048, 4928.6303527235605, 4973.502649734997, 5242.397124330712, 5367.114426119686, 5389.299391079174, 5454.563634909197, 5455.727213639342, 5872.17789509469, 5903.291605007426, 5920.703964801743, 5926.7925622603, 5930.199423077873, 5952.375000624916, 5953.851153721192, 5958.40415958405, 5974.940250597482, 5977.193078934331, 5273.947260527384, 5353.544948679367, 5397.62216644835, 5400.91898621521, 5486.972565137228, 5967.641941483438, 5972.25346831646, 5977.282726072899, 5977.372375900555, 5978.461938425563, 5463.535599474089, 5763.106718458645, 5766.163906233656, 5773.422657734277, 5773.711314434261, 5670.262865827499, 5733.827985160452, 5739.885202295931, 5742.655440673573, 5753.712314384264, 5690.0, 5736.282964629421, 5736.655800651891, 5740.167675687086, 5742.109972954198, 5558.555315574744, 5668.319801623831, 5704.372519022904, 5739.0, 5740.081586946152, 4318.892027699333, 4349.26062569364, 4351.0, 4392.846250381285, 4395.252807022814, 3895.2793733159456, 3915.5888631693833, 3919.235749028969, 3929.430232616312, 3961.801909904493, 5300.2049692546425, 5366.060939335601, 5420.403755586883, 5452.100403433468, 5499.340079190522, 5717.885642287214, 5750.2237197978575, 5771.711414429262, 5773.105168698775, 5826.941730582725, 5426.511613954763, 5428.75570599324, 5436.130219164915, 5441.075017247077, 5447.53695935842, 4677.508861569486, 4770.427548694179, 4811.133995880775, 4831.613470922318, 4849.321095046696, 6054.788082417094, 6059.515238780887, 6061.060535616986, 6069.484093851984, 6100.48145907594, 5862.149988251595, 5880.059190529495, 5881.441263080001, 5885.3820348864465, 5885.646861188342, 5746.971265143815, 5783.681897495678, 5816.883662326814, 5856.531477481876, 6054.697265136813, 5639.295088113986, 5642.88714225705, 5647.717614119196, 5648.604597678123, 5666.121751128581, 5678.119891416837, 5709.143628455765, 5737.08206686928, 5739.397363276963, 5743.10981797822, 5435.429279925551, 5552.500274975271, 5574.136008918624, 5597.384287728428, 5662.235598194191, 5666.2350582670815, 5690.971545142414, 5691.288588926384, 5693.231413759089, 5703.942960570341, 5427.972860135832, 5564.972175139261, 5634.605577609528, 5640.210370548045, 5647.774089036392, 5647.604667673223, 5697.3448053474385, 5699.145128230799, 5755.7697692093525, 5765.509931655856, 5586.301712285965, 5592.3009623797025, 5593.468620481048, 5599.244102046335, 5646.604737668324], "value": 5322.06145718065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.7229219143579, 630.6909614289, 634.3529599808196, 647.3494138390917, 648.8021153548167, 31240.21899452512, 42450.787746061265, 43876.341854872124, 43916.341254881205, 48097.278540821826, 45293.547064529346, 45735.77132114335, 45740.0, 45743.313850292274, 45775.31337029939, 8792.78018049549, 8934.195922366986, 8939.910600894005, 8965.058668839743, 8977.46135231885, 8700.129987001312, 8824.735257942271, 8841.778955526099, 8854.114588541159, 8933.419327743675, 8958.193762561368, 8997.77505562363, 8998.86501702475, 9004.639814407416, 9011.0, 8904.51025193614, 8953.6866209683, 8968.68609598661, 8969.820603587892, 8972.05793391691, 8847.115288471166, 8912.420692654956, 8926.86609700855, 8928.24109950655, 8936.285097192209, 42705.1458970822, 43082.13835723268, 43154.56845431537, 43204.567954320366, 43215.56784432147, 3742.326381251401, 3807.619238076198, 3932.488776459071, 4004.8197831097377, 4299.226139294926, 30994.0, 31490.37019259602, 31725.36549269025, 31756.523652145235, 31899.0, 3994.2610617035944, 4180.937285940683, 4231.217224813419, 4265.594768496988, 4278.101598664284, 355364.0, 357054.0, 358983.0, 359101.0, 359265.9999999974, 59846.0, 60450.0, 60509.39490605125, 60517.69741151354, 60539.39460605426, 62075.37924620786, 62346.688266558376, 62442.375576244565, 62518.0, 62574.37425625685, 16816.0, 17027.91486042562, 17035.914820426067, 17049.0, 17057.658846822993, 12912.612621621367, 13045.282509462071, 13051.0, 13061.738765224833, 13071.41178646963, 16082.35670573164, 17833.643327133643, 17851.304126108, 18053.7291940621, 18111.547211319823, 5990.5507086968655, 6178.62928224308, 6216.222972128484, 6271.62370257786, 6424.16485856845, 915.514777168102, 987.7086259553449, 996.785691076422, 1066.5040756048475, 1080.2816127275273, 32135.839320803712, 32391.35217295641, 32439.513407298437, 32460.0, 32493.35013299768, 1078.7842431513573, 1104.5857803323754, 1107.2858006585707, 1116.4752566293828, 1137.766757814646, 16357.918210408872, 16827.74758378625, 16893.0, 16895.83104168967, 16930.76529877968, 568823.0, 571855.0, 572371.0, 572389.0, 572966.0, 58230.7088464555, 58595.70702146462, 58628.41371586315, 58871.70564147238, 58902.41097589055, 1264.5574049082932, 1354.8306461692289, 1363.400103954257, 1365.5630198336635, 1390.242317936727, 29805.403891922473, 34165.31669366549, 34194.82902585471, 34298.828505858306, 34580.65419345875, 50738.0, 50739.49260507496, 51001.0, 51151.0, 51230.487695124066, 413653.0, 415672.0, 415904.0, 416486.0, 418075.0, 27996.0, 28653.426931461672, 28934.710652894042, 29022.854885725435, 29032.0, 49305.75347123241, 49358.75320623374, 49922.75038624783, 50616.0, 50916.23625645544, 41036.79481602692, 41870.0, 42123.368149478396, 42685.35971960485, 43041.569584303754, 41488.0, 41703.374449382674, 42147.7892610535, 42257.140428849845, 42463.57536424596, 41317.0, 41704.95737606584, 41859.372109417774, 42155.57844421516, 42271.57728422799, 35165.47251791174, 37284.44073338848, 37328.62671373251, 37999.430008550444, 38220.61779382282, 28491.43017139687, 29127.85436072806, 29150.27124321909, 29220.853895730386, 29374.0], "value": 20285.627880367956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.40086863190476, 381.10250360401255, 388.23905145914006, 392.8350092960956, 406.29913399386044, 17291.567710807238, 18770.343037993673, 19154.13806378713, 19163.233470661173, 19190.23239070439, 16969.3212271509, 17816.109194540255, 18421.263149474005, 18811.0, 18860.528486787836, 5201.713905735173, 5322.973385133069, 5380.515753582177, 5386.649867758583, 5579.38626751057, 5537.473939975716, 5719.628224165437, 5726.255586773735, 5757.942420575803, 5761.193432919395, 5234.42421333653, 5364.275822763935, 5691.459311365414, 5696.743646535916, 5706.572007099463, 5226.52961233487, 5250.396204436501, 5275.0768615492325, 5275.28783614211, 5277.076511610453, 4861.149298872683, 5114.616403769732, 5123.231515272739, 5156.535911767922, 5163.922541161885, 21455.785442145534, 21945.122195112337, 22325.888370558205, 22380.664290035664, 22415.103395864146, 2117.3224568138203, 2201.438633148553, 2218.556288742258, 2278.544291141778, 2318.6637937499136, 9383.671571494964, 10566.577336906514, 12035.699107522381, 12532.436040378205, 12798.552050678181, 1758.6394789068338, 1815.1922394534438, 1888.2352647177777, 1902.657521646103, 1915.415798181554, 77143.61428192822, 77223.0, 77492.61253693752, 78055.60972195103, 78692.0, 10141.847872281922, 10518.842217366746, 10802.891971080346, 10893.0, 11192.888071119347, 15369.923150384177, 15406.460773872861, 15416.691666166615, 15424.768628470581, 15468.07191568487, 7733.188015258429, 8021.438499305109, 8032.638531266107, 8130.390220733469, 8148.429609927367, 7601.695932162762, 7670.7698769037015, 7722.922770772333, 7729.922700773032, 7807.80480487981, 4576.290674945389, 4657.184992626277, 4662.417197850269, 4665.9766701166955, 4788.209945359046, 1927.88432694036, 1968.6456437841039, 2005.6189324028387, 2019.414369832732, 2036.175348983664, 873.1879352202512, 929.330881765128, 946.5598496699068, 988.4415305352453, 1089.6894385100368, 17430.738538921927, 17551.29794808219, 17968.550786230186, 18762.372062332826, 19153.712694309597, 937.9296552758434, 940.7459985803931, 979.2373727290848, 1023.1150055202196, 1049.6916902714927, 10388.688339349832, 10595.364278143335, 10668.946655266674, 10744.520294649785, 10778.461076946121, 472806.0, 475527.0, 488478.0, 489682.0, 491702.0, 68088.6595567019, 96872.0, 98029.50985245028, 98090.0, 98414.0, 978.2907392140784, 997.9351342162736, 1008.7629407089328, 1036.2746077745608, 1036.9637062702768, 16928.40750573724, 17724.113794309975, 17732.645347093243, 17783.46649600514, 17854.642907142043, 36069.819650901576, 40661.79669101635, 40974.79512602418, 41414.792926035174, 41697.100321299855, 51819.481805181465, 53607.46392536181, 56847.71576142093, 56985.0, 57253.141202881154, 7995.560244186626, 8172.713955011546, 8215.34277257806, 8267.710630127916, 8279.461834980948, 9070.818583628423, 12710.809337859755, 13062.216267024009, 13130.080894337687, 13740.725185496434, 11719.238249513754, 12020.699482513008, 12070.517179312728, 12192.939035304767, 12297.877021230031, 11755.47100380502, 11820.408979550815, 11845.881541184477, 11953.940230298793, 12294.323812190058, 12057.336846473178, 12102.152849300464, 12124.454399552218, 12246.816297755362, 12363.258204507758, 8101.594920254081, 8260.339172866277, 8279.668813247403, 8530.829383412422, 8884.378093533649, 9576.0, 10239.795204095728, 11347.432628368713, 11740.119491038036, 11878.584249551224], "value": 9022.735460419755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.9674258143539, 1461.0211158523791, 1484.3172140815225, 1593.5936336234258, 1739.0782885070917, 8195.098539160688, 8503.404761666687, 8537.31701463883, 8726.301895848334, 8736.0, 8477.152284771535, 8656.047834738174, 8662.0, 8663.39356245063, 8677.349198810083, 1886.4812176651394, 1944.057132290838, 1945.5136215946013, 2257.16484900587, 2269.296518079401, 2290.633498640218, 2353.047015958531, 2354.5526349993534, 2361.6929799126174, 2364.148906393697, 2271.7955384015436, 2272.284230467406, 2292.793648571628, 2293.839431239814, 2314.5718042162252, 1908.6182763447366, 2192.8793916334594, 2241.5180736141724, 2275.9317220483413, 2276.271593090212, 2258.5934531784274, 2291.083566573384, 2297.4600968772324, 2306.5041016181603, 2308.5036717105736, 8484.278836298921, 8545.615447304886, 8562.272206862424, 8572.185642363966, 8573.614187361583, 4974.701517908937, 5101.362329708786, 5109.795608175668, 5111.386633603955, 5120.539151476385, 3035.3777475617444, 3134.3731253749343, 3324.6010478742705, 3341.9498707519406, 3348.4475061614803, 1018.3431686562126, 1025.4718819807806, 1033.6743925663468, 1034.57065317893, 1036.7243899640293, 11782.764344713143, 11807.645770626896, 11811.704707382298, 11820.23168494045, 11821.586244481401, 4533.909321813545, 4599.67802253839, 4745.2882067690125, 4747.667663263538, 4761.214399624093, 10143.442110683836, 10161.644342447978, 10168.949155254177, 10185.898141018642, 10218.0, 5212.843614691566, 5275.076861549213, 5278.049951008856, 5285.973570132125, 5289.947100528945, 4587.3348364486965, 4723.83466578675, 4726.881827954328, 4804.2073057945045, 4859.65982381237, 3885.7279990400966, 3912.9608703912595, 3975.3241948868763, 4019.5980401960155, 4046.352583586612, 1221.4686611324103, 1231.4335405713293, 1244.8132780082879, 1259.2192840438986, 1266.0567876931746, 973.8782652168479, 977.4672803322064, 982.4743762087392, 989.8020395920845, 1017.9796404071877, 5624.606277560613, 5774.422557744192, 5815.244018277597, 5832.096025116114, 5941.881162376728, 970.3110791338088, 985.9112679858847, 990.3958585262984, 1005.3816902604846, 1043.3896170740202, 3803.9619603804163, 3864.729468937204, 4015.13674559971, 4021.758694478282, 4267.4025636410925, 10292.948535257276, 10498.422586757802, 10627.893721062845, 10644.89355106439, 10647.30792498485, 10401.58393664245, 10487.161027117812, 10511.632092876713, 10517.894821051692, 10519.684409467729, 7499.287567680953, 7854.6858125674335, 8028.394321135796, 8045.275925166763, 8073.6366863491285, 5955.255593050869, 6009.128676341818, 6022.52448150206, 6167.044108163242, 6208.875822483435, 9596.66411675588, 9687.0, 9996.150327222267, 9996.950015249877, 10017.298789084985, 8478.533680647624, 9565.952170239105, 10024.799504009734, 10059.943705910773, 10121.493925303852, 7385.630718464163, 7602.0, 7626.694932202871, 7642.885356719765, 7654.578998155155, 7957.403194760532, 8202.056763472277, 8206.302464290364, 8207.138250483613, 8220.0, 7298.598577078099, 7318.414526837733, 7344.889826652711, 7382.889256661047, 7450.6647200875, 7177.461690373348, 7190.06529151207, 7384.778456646309, 7479.513831600929, 7485.0, 6634.767783127568, 6785.491088168308, 6890.655467226718, 6907.13660792401, 7025.789226323219, 5139.511746384088, 5195.948040519546, 5233.241180028798, 5244.9737751310995, 5358.276632654698, 5137.691738495702, 5144.125498665161, 5197.168453047494, 5251.3960894496095, 5289.021531016774], "value": 4538.979617246668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6169464779728, 316.4872905892454, 319.48881789137397, 320.83156342919966, 324.704518887812, 5286.418493965665, 5330.89338213236, 5345.919811202825, 5386.326709161355, 5397.892042159159, 5043.268726034723, 5131.974340128303, 5265.157574788034, 5295.523402893738, 5297.947020529803, 4059.7564146151326, 4090.9590904091024, 4101.8974525636795, 4103.13834094839, 4103.8563650272245, 4087.386891966214, 4098.4876890388705, 4110.794460276989, 4117.608827161415, 4120.217158739845, 3920.9411858822, 3931.5871833457504, 3944.5463771666195, 3998.5401678806875, 3999.1601763629674, 3967.960320396788, 3977.801109944491, 3986.5216174059155, 4005.2790497710403, 4039.333509970851, 3499.725178633883, 3506.6493350664987, 3517.8944631661093, 3523.6300188480354, 3537.8231088445473, 4900.975495122501, 5070.138076526962, 5083.288339632454, 5102.464241254652, 5106.64253502255, 4541.477730061019, 4544.454665440136, 4558.977205113986, 4560.931586026212, 4561.361409402686, 5371.75827087782, 5400.513953744182, 5400.702961337125, 5425.02349577076, 5434.2935418395355, 3800.5439347278502, 3853.9036524087123, 3861.826217820205, 3890.3191941410423, 3895.2793733159456, 5595.692236927008, 5613.578981576357, 5620.91568626471, 5654.519365853907, 5655.886882262332, 3988.3818008208773, 3997.920041599152, 4032.1330913853662, 4035.1727895781296, 4041.8383264669083, 3989.7606143631474, 4026.4362989181536, 4083.734557253769, 4100.712950093465, 4125.752454852718, 4562.908741825145, 4580.770961451914, 4593.816247350135, 4616.28447590624, 4638.793913582493, 5459.727013649302, 5462.9726851365485, 5464.480874316933, 5480.80767692926, 5508.834734957958, 1328.1566205459603, 1361.8433880103717, 1391.7773156294945, 1393.4426229508076, 1415.0, 875.6978842299396, 898.0615257056392, 910.7905181808088, 912.9911447850163, 915.7298596913793, 4715.693479923794, 4748.311494833299, 4764.904701905943, 4785.210440277385, 4800.8477965288075, 5005.499450054966, 5014.267224362731, 5030.308784800114, 5039.420466646309, 5046.848594542096, 4574.519675434098, 4739.881502962385, 4741.668083234141, 4775.928361074587, 4777.355057067321, 2665.893364265408, 2668.7731542818688, 2676.424568717735, 2697.0, 2700.837949723023, 5115.18157094863, 5162.038425398325, 5168.457311982263, 5192.948070519322, 5213.504717051874, 4820.558175124081, 5066.238899799618, 5104.923426148611, 5107.87230319245, 5143.168339587031, 5114.820981265638, 5124.461931497213, 5131.486211567521, 5132.897342053213, 5162.793488260428, 4945.727984960861, 5000.099962014411, 5004.2493625956395, 5018.021485810232, 5030.874228144326, 4911.557959783637, 4966.900661986668, 4972.328735620789, 5257.0, 5701.4298570142655, 5837.357890632112, 5852.824415267549, 5857.677827719346, 5902.380250073852, 5907.32065812437, 3982.78094704794, 3988.202359528164, 3992.461017762565, 3996.620321069494, 4011.4383986242533, 5347.78608855657, 5398.652835242175, 5715.457031581993, 5724.8282551523525, 5730.74211660468, 5311.309529761106, 5466.398696143341, 5490.725463726878, 5497.532709719719, 5521.641093328921, 5470.0, 5504.311961004874, 5600.523955463668, 5602.747876345656, 5610.18652295423, 5167.250748641351, 5356.437574054824, 5369.97315013438, 5426.67439953604, 5450.920230069998, 5497.790486093053, 5512.972435137799, 5535.25274087993, 5566.666000040011, 5570.916436253378, 5389.973050134724, 5391.191321301836, 5424.267723857387, 5425.83344580917, 5427.99582077317], "value": 4053.8538901792044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.0067509874317, 747.932686058255, 764.5794812852929, 768.1703759939267, 777.6383981448627, 14849.554513364603, 15065.849341506582, 15120.546383608496, 15875.761863572041, 16182.75725864113, 14354.354054067566, 14466.782998255034, 14515.782263266059, 14520.927395363035, 14686.779698304534, 658.4271683635244, 782.0654318089885, 794.3287921706149, 810.2626609785096, 813.6785969542027, 803.8753993131074, 808.7856717969743, 809.0534075132109, 809.0857331215718, 809.2150613904532, 849.0617867256685, 852.7527017165015, 854.1202561361807, 854.4830377621543, 854.5855260198798, 691.9688614012382, 839.1859895900966, 851.7913111287712, 852.109545524928, 859.9914000859974, 604.7550741949517, 606.0727087556046, 606.7845914700262, 607.1803065861096, 607.3622696169004, 15136.0, 15144.54566363011, 15161.696766064617, 15170.31733571992, 15173.24133793317, 14687.779683304652, 14954.40182392703, 15014.549563513112, 15045.172515511642, 15174.241287935669, 11775.88224117765, 11937.761244775143, 12206.572769953009, 12412.689682757913, 12472.189307694971, 3876.573576906538, 3905.6875449963936, 4004.3392840181336, 4071.7760523171214, 4082.632563069338, 58846.0, 59305.7034714828, 59905.40094599042, 59990.40009599892, 60121.0, 11530.365829879269, 11580.0, 11788.764224715458, 11862.88137118635, 12327.137100403064, 21719.457013574785, 21874.89062554677, 21885.562288754136, 21888.671669924963, 21890.45273868166, 8445.57772111392, 8708.738737837875, 8783.868241976375, 8785.165409286108, 8806.25146862511, 4810.39870016248, 4870.220764677705, 4895.73073480962, 4982.825601103944, 5097.898042039138, 3412.8805491807666, 3511.4206155983975, 3527.94708079379, 3532.0, 3534.169470174507, 516.2694786876602, 605.4006533531772, 613.055893923362, 621.1862460177182, 635.1679300116862, 554.4427850010794, 557.2783245696833, 601.0533409879457, 655.8589903170841, 707.7098389660215, 9880.209583233323, 9991.500424978722, 10036.0, 10038.598456061822, 10070.647527336509, 557.6263903184876, 629.222909706512, 661.5732852310233, 702.3398005874564, 755.8903958926035, 4668.649851261169, 4726.432828060655, 4885.812047425795, 4939.234418665113, 4963.5780958618925, 77183.0, 91233.54383228041, 98177.0, 111118.44440777744, 112883.43558282156, 64058.0, 92724.0, 96698.516507417, 97376.51311743396, 98691.50654246683, 63065.68467157726, 64898.0, 87109.0, 87398.0, 88065.99999999872, 9603.606838629803, 9860.750083569917, 10005.54975026111, 10040.899591003996, 10063.496825158567, 48208.0, 48708.5129148704, 48778.0, 49573.504264956886, 50322.49677503324, 70667.64666176842, 72582.0, 73516.0, 73901.26098738944, 74113.25886741064, 12716.682082948, 12883.770840370933, 12905.290209038592, 12942.223466592035, 13283.070185086952, 14307.64230894236, 14671.779923301372, 14845.554633361016, 14944.925275373553, 15193.594515278584, 13309.741180202447, 13930.0, 14018.789718154032, 14502.1298722077, 14552.199629020506, 13673.589792306248, 13853.515126970507, 13907.235102069484, 14040.78938815939, 14295.499657511937, 13293.20240785556, 13718.314084295545, 13788.103773254707, 14054.156750594997, 14147.858521414653, 10944.452777361259, 11034.913026901679, 11232.719182020515, 11447.942760286145, 11502.0, 10815.56737730482, 11183.72040698989, 11626.0, 11805.0, 11832.467538960595], "value": 7426.286733523137, "unit": "score"}], "name": "dromaeo_css", "value": 7145.655267521305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 182.0, 136.0, 129.0, 157.0, 132.0, 156.0, 132.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 122.0, 74.0, 74.0, 73.0, 75.0, 108.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 85.0, 86.0, 86.0, 125.0, 86.0, 85.0, 132.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 55.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 63.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 80.0, 81.0, 80.0, 80.0, 80.0, 132.0, 80.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 124.0, 122.0, 119.0, 119.0, 120.0, 126.0, 130.0, 140.0, 134.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 161.0, 162.0, 164.0, 163.0, 162.0, 158.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 61.0, 63.0, 64.0, 65.0, 62.0, 62.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1505.0, "alertThreshold": 2.0}]} 11:32:57 INFO - Return code: 0 11:32:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:57 ERROR - # TBPL SUCCESS # 11:32:57 INFO - Running post-action listener: _resource_record_post_action 11:32:57 INFO - ##### 11:32:57 INFO - ##### Finished run-tests step (success) 11:32:57 INFO - ##### 11:32:57 INFO - Running post-run listener: _resource_record_post_run 11:32:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 458752; Write bytes: 548282368; Read time: 68; Write time: 619320 11:32:57 INFO - TinderboxPrint: CPU usage
13.3% 11:32:57 INFO - TinderboxPrint: I/O read bytes / time
458,752 / 68 11:32:57 INFO - TinderboxPrint: I/O write bytes / time
548,282,368 / 619,320 11:32:57 INFO - TinderboxPrint: CPU idle
8,263.5 (86.7%) 11:32:57 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 11:32:57 INFO - TinderboxPrint: Swap in / out
0 / 0 11:32:57 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 255619072; Read time: 0; Write time: 303828 11:32:57 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 458752; Write bytes: 292077568; Read time: 68; Write time: 315484 11:32:57 INFO - Running post-run listener: _upload_blobber_files 11:32:57 INFO - Blob upload gear active. 11:32:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:57 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:32:57 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32:57 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:58 INFO - (blobuploader) - INFO - Done attempting. 11:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:59 INFO - (blobuploader) - INFO - Done attempting. 11:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:03 INFO - (blobuploader) - INFO - Done attempting. 11:33:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:03 INFO - Return code: 0 11:33:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b53c9f647df8e39419b1cd058cf96cff1ba2217d8f1a6f7dc7faffbe4c66231a2521e3c7275e22d3dc897f885c0257b92fda779578b30a31b7daf6ede780c834", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1d0c07adaf449133d6fa7518289e2330371b2f874df3a708488f22fc3d5b842bf414ff488555c29c319ff49b5485c8219d9dc1525c78e2887eaf4377fdc23f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2f80eec6f0181f99dc873e71d96ea8ea5e930e4b139ccfa7f97cf8cc1c2f422f59d8765d1b68574567e0518ac406d7def6094e8326c4fe517deb5a919ef9e53"} 11:33:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:03 INFO - Contents: 11:33:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b53c9f647df8e39419b1cd058cf96cff1ba2217d8f1a6f7dc7faffbe4c66231a2521e3c7275e22d3dc897f885c0257b92fda779578b30a31b7daf6ede780c834", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1d0c07adaf449133d6fa7518289e2330371b2f874df3a708488f22fc3d5b842bf414ff488555c29c319ff49b5485c8219d9dc1525c78e2887eaf4377fdc23f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2f80eec6f0181f99dc873e71d96ea8ea5e930e4b139ccfa7f97cf8cc1c2f422f59d8765d1b68574567e0518ac406d7def6094e8326c4fe517deb5a919ef9e53"} 11:33:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:03 INFO - Copying logs to upload dir... 11:33:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.782771 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 11:33:03.731871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 11:33:03.735740) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b53c9f647df8e39419b1cd058cf96cff1ba2217d8f1a6f7dc7faffbe4c66231a2521e3c7275e22d3dc897f885c0257b92fda779578b30a31b7daf6ede780c834", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1d0c07adaf449133d6fa7518289e2330371b2f874df3a708488f22fc3d5b842bf414ff488555c29c319ff49b5485c8219d9dc1525c78e2887eaf4377fdc23f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2f80eec6f0181f99dc873e71d96ea8ea5e930e4b139ccfa7f97cf8cc1c2f422f59d8765d1b68574567e0518ac406d7def6094e8326c4fe517deb5a919ef9e53"} build_url:https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b53c9f647df8e39419b1cd058cf96cff1ba2217d8f1a6f7dc7faffbe4c66231a2521e3c7275e22d3dc897f885c0257b92fda779578b30a31b7daf6ede780c834", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1d0c07adaf449133d6fa7518289e2330371b2f874df3a708488f22fc3d5b842bf414ff488555c29c319ff49b5485c8219d9dc1525c78e2887eaf4377fdc23f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2f80eec6f0181f99dc873e71d96ea8ea5e930e4b139ccfa7f97cf8cc1c2f422f59d8765d1b68574567e0518ac406d7def6094e8326c4fe517deb5a919ef9e53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 11:33:03.765322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:33:03.765662) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465495945.999397-1885590891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:33:03.848630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 11:33:03.848962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 11:33:03.849287) ========= ========= Total master_lag: 0.18 =========