builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1466003524.79 results: success (0) buildid: 20160615053002 builduid: 1af116f20aec4c3caefbf45348bbf4eb revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.793803) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.794307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.794611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.810428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.810844) ========= 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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 08:12:07-- 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% 61.0M=0s 2016-06-15 08:12:07 (61.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.917361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.917669) ========= 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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.972090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:04.972560) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff --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 bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff --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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 08:12:07,543 truncating revision to first 12 chars 2016-06-15 08:12:07,543 Setting DEBUG logging. 2016-06-15 08:12:07,543 attempt 1/10 2016-06-15 08:12:07,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bac29d6a5639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 08:12:07,857 unpacking tar archive at: fx-team-bac29d6a5639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:05.626460) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:05.626790) ========= script_repo_revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:05.627188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:05.627506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:12:05.636119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-15 08:12:05.636435) ========= /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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:08 INFO - MultiFileLogger online at 20160615 08:12:08 in /builds/slave/test 08:12:08 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 08:12:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:08 INFO - {'append_to_log': False, 08:12:08 INFO - 'base_work_dir': '/builds/slave/test', 08:12:08 INFO - 'blob_upload_branch': 'Fx-Team', 08:12:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:08 INFO - 'branch': 'Fx-Team', 08:12:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:08 INFO - 'config_files': ('talos/linux_config.py',), 08:12:08 INFO - 'default_actions': ('clobber', 08:12:08 INFO - 'read-buildbot-config', 08:12:08 INFO - 'download-and-extract', 08:12:08 INFO - 'populate-webroot', 08:12:08 INFO - 'create-virtualenv', 08:12:08 INFO - 'install', 08:12:08 INFO - 'run-tests'), 08:12:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:08 INFO - 'download_minidump_stackwalk': True, 08:12:08 INFO - 'download_symbols': 'ondemand', 08:12:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:08 INFO - 'installer_path': 'installer.exe', 08:12:08 INFO - 'log_level': 'info', 08:12:08 INFO - 'log_name': 'talos', 08:12:08 INFO - 'log_to_console': True, 08:12:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:08 INFO - 'opt_config_files': (), 08:12:08 INFO - 'pip_index': False, 08:12:08 INFO - 'sps_profile': False, 08:12:08 INFO - 'sps_profile_interval': 0, 08:12:08 INFO - 'suite': 'dromaeojs', 08:12:08 INFO - 'system_bits': '32', 08:12:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:08 INFO - 'title': 'talos-linux64-ix-054', 08:12:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:08 INFO - 'use_talos_json': True, 08:12:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:08 INFO - 'work_dir': 'build'} 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running clobber step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: clobber 08:12:08 INFO - rmtree: /builds/slave/test/build 08:12:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - ##### 08:12:08 INFO - ##### Finished clobber step (success) 08:12:08 INFO - ##### 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running read-buildbot-config step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: read_buildbot_config 08:12:08 INFO - Using buildbot properties: 08:12:08 INFO - { 08:12:08 INFO - "project": "", 08:12:08 INFO - "product": "firefox", 08:12:08 INFO - "script_repo_revision": "production", 08:12:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:12:08 INFO - "repository": "", 08:12:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:12:08 INFO - "buildid": "20160615053002", 08:12:08 INFO - "pgo_build": "True", 08:12:08 INFO - "basedir": "/builds/slave/test", 08:12:08 INFO - "buildnumber": 805, 08:12:08 INFO - "slavename": "talos-linux64-ix-054", 08:12:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:12:08 INFO - "platform": "ubuntu64_hw", 08:12:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:12:08 INFO - "branch": "fx-team", 08:12:08 INFO - "repo_path": "integration/fx-team", 08:12:08 INFO - "revision": "bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff", 08:12:08 INFO - "stage_platform": "linux64-pgo", 08:12:08 INFO - "builduid": "1af116f20aec4c3caefbf45348bbf4eb", 08:12:08 INFO - "slavebuilddir": "test" 08:12:08 INFO - } 08:12:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - ##### 08:12:08 INFO - ##### Finished read-buildbot-config step (success) 08:12:08 INFO - ##### 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running download-and-extract step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: download_and_extract 08:12:08 INFO - mkdir: /builds/slave/test/build/tests 08:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:08 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:09 INFO - Downloaded 1361 bytes. 08:12:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:12:09 INFO - Using the following test package requirements: 08:12:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:12:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:12:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'jsshell-linux-x86_64.zip'], 08:12:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:12:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:12:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:12:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:12:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:12:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:09 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:10 INFO - Downloaded 24221178 bytes. 08:12:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:12:11 INFO - Return code: 0 08:12:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:11 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:13 INFO - Downloaded 24221178 bytes. 08:12:13 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'] 08:12:13 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 08:12:14 INFO - Return code: 0 08:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:14 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:15 INFO - Downloaded 14405384 bytes. 08:12:15 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'] 08:12:15 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 08:12:15 INFO - Return code: 0 08:12:15 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')]} 08:12:15 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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 08:12:24 INFO - Downloaded 59402892 bytes. 08:12:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:12:24 INFO - mkdir: /builds/slave/test/properties 08:12:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:24 INFO - Contents: 08:12:24 INFO - build_url:https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:12:25 INFO - Running post-action listener: _resource_record_post_action 08:12:25 INFO - Running post-action listener: set_extra_try_arguments 08:12:25 INFO - ##### 08:12:25 INFO - ##### Finished download-and-extract step (success) 08:12:25 INFO - ##### 08:12:25 INFO - ##### 08:12:25 INFO - ##### Running populate-webroot step. 08:12:25 INFO - ##### 08:12:25 INFO - Running pre-action listener: _resource_record_pre_action 08:12:25 INFO - Running main action method: populate_webroot 08:12:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:25 INFO - '--tppagecycles', 08:12:25 INFO - '7'], 08:12:25 INFO - 'tests': ['tsvgm']}}, 08:12:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['damp', 'tps']}, 08:12:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'tests': ['damp', 'tps']}, 08:12:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['dromaeo_dom']}, 08:12:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['basic_compositor_video']}, 08:12:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:12:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['a11yr', 08:12:25 INFO - 'ts_paint', 08:12:25 INFO - 'tpaint', 08:12:25 INFO - 'sessionrestore', 08:12:25 INFO - 'sessionrestore_no_auto_restore', 08:12:25 INFO - 'tabpaint']}, 08:12:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['tsvgx', 08:12:25 INFO - 'tsvgr_opacity', 08:12:25 INFO - 'tart', 08:12:25 INFO - 'tscrollx', 08:12:25 INFO - 'cart']}, 08:12:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:25 INFO - 'tsvgr_opacity', 08:12:25 INFO - 'tart', 08:12:25 INFO - 'tscrollx', 08:12:25 INFO - 'cart']}, 08:12:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'talos_options': ['--disable-e10s'], 08:12:25 INFO - 'tests': ['tp5o']}, 08:12:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'tests': ['tp5o']}, 08:12:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'talos_options': ['--disable-e10s', 08:12:25 INFO - '--xperf_path', 08:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:25 INFO - 'tests': ['tp5n']}, 08:12:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:25 INFO - 'talos_options': ['--xperf_path', 08:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:25 INFO - 'tests': ['tp5n']}}, 08:12:25 INFO - 'talos.zip': {'path': '', 08:12:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:25 INFO - Running post-action listener: _resource_record_post_action 08:12:25 INFO - ##### 08:12:25 INFO - ##### Finished populate-webroot step (success) 08:12:25 INFO - ##### 08:12:25 INFO - ##### 08:12:25 INFO - ##### Running create-virtualenv step. 08:12:25 INFO - ##### 08:12:25 INFO - Running pre-action listener: _resource_record_pre_action 08:12:25 INFO - Running main action method: create_virtualenv 08:12:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:25 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 08:12:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:25 INFO - Using real prefix '/usr' 08:12:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:28 INFO - Installing pip.................done. 08:12:28 INFO - Return code: 0 08:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:28 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:28 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 08:12:28 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 08:12:28 INFO - Using env: {'DISPLAY': ':0', 08:12:28 INFO - 'HOME': '/home/cltbld', 08:12:28 INFO - 'LANG': 'en_US.UTF-8', 08:12:28 INFO - 'LANGUAGE': 'en_US:en', 08:12:28 INFO - 'LOGNAME': 'cltbld', 08:12:28 INFO - 'MAIL': '/var/mail/cltbld', 08:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:28 INFO - 'MOZ_NO_REMOTE': '1', 08:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:28 INFO - 'NO_EM_RESTART': '1', 08:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:28 INFO - 'PWD': '/builds/slave/test', 08:12:28 INFO - 'SHELL': '/bin/bash', 08:12:28 INFO - 'SHLVL': '1', 08:12:28 INFO - 'TERM': 'linux', 08:12:28 INFO - 'TMOUT': '86400', 08:12:28 INFO - 'USER': 'cltbld', 08:12:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:28 INFO - '_': '/tools/buildbot/bin/python'} 08:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:28 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 08:12:28 INFO - Cleaning up... 08:12:28 INFO - Return code: 0 08:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:28 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:28 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 08:12:28 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 08:12:28 INFO - Using env: {'DISPLAY': ':0', 08:12:28 INFO - 'HOME': '/home/cltbld', 08:12:28 INFO - 'LANG': 'en_US.UTF-8', 08:12:28 INFO - 'LANGUAGE': 'en_US:en', 08:12:28 INFO - 'LOGNAME': 'cltbld', 08:12:28 INFO - 'MAIL': '/var/mail/cltbld', 08:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:28 INFO - 'MOZ_NO_REMOTE': '1', 08:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:28 INFO - 'NO_EM_RESTART': '1', 08:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:28 INFO - 'PWD': '/builds/slave/test', 08:12:28 INFO - 'SHELL': '/bin/bash', 08:12:28 INFO - 'SHLVL': '1', 08:12:28 INFO - 'TERM': 'linux', 08:12:28 INFO - 'TMOUT': '86400', 08:12:28 INFO - 'USER': 'cltbld', 08:12:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:28 INFO - '_': '/tools/buildbot/bin/python'} 08:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:28 INFO - Downloading/unpacking psutil>=3.1.1 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:30 INFO - Installing collected packages: psutil 08:12:30 INFO - Running setup.py install for psutil 08:12:30 INFO - building 'psutil._psutil_linux' extension 08:12:30 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 08:12:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:12:31 INFO - building 'psutil._psutil_posix' extension 08:12:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:12:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:31 INFO - Successfully installed psutil 08:12:31 INFO - Cleaning up... 08:12:31 INFO - Return code: 0 08:12:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:31 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:31 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 08:12:31 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 08:12:31 INFO - Using env: {'DISPLAY': ':0', 08:12:31 INFO - 'HOME': '/home/cltbld', 08:12:31 INFO - 'LANG': 'en_US.UTF-8', 08:12:31 INFO - 'LANGUAGE': 'en_US:en', 08:12:31 INFO - 'LOGNAME': 'cltbld', 08:12:31 INFO - 'MAIL': '/var/mail/cltbld', 08:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:31 INFO - 'MOZ_NO_REMOTE': '1', 08:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:31 INFO - 'NO_EM_RESTART': '1', 08:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:31 INFO - 'PWD': '/builds/slave/test', 08:12:31 INFO - 'SHELL': '/bin/bash', 08:12:31 INFO - 'SHLVL': '1', 08:12:31 INFO - 'TERM': 'linux', 08:12:31 INFO - 'TMOUT': '86400', 08:12:31 INFO - 'USER': 'cltbld', 08:12:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:31 INFO - '_': '/tools/buildbot/bin/python'} 08:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:12:31 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 08:12:31 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 08:12:31 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 08:12:31 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 08:12:31 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 08:12:31 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 08:12:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:12:33 INFO - Installing collected packages: mozsystemmonitor 08:12:33 INFO - Running setup.py install for mozsystemmonitor 08:12:33 INFO - Successfully installed mozsystemmonitor 08:12:33 INFO - Cleaning up... 08:12:33 INFO - Return code: 0 08:12:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:12:33 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')]} 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 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')]} 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:33 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 08:12:33 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 08:12:33 INFO - Using env: {'DISPLAY': ':0', 08:12:33 INFO - 'HOME': '/home/cltbld', 08:12:33 INFO - 'LANG': 'en_US.UTF-8', 08:12:33 INFO - 'LANGUAGE': 'en_US:en', 08:12:33 INFO - 'LOGNAME': 'cltbld', 08:12:33 INFO - 'MAIL': '/var/mail/cltbld', 08:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:33 INFO - 'MOZ_NO_REMOTE': '1', 08:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:33 INFO - 'NO_EM_RESTART': '1', 08:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:33 INFO - 'PWD': '/builds/slave/test', 08:12:33 INFO - 'SHELL': '/bin/bash', 08:12:33 INFO - 'SHLVL': '1', 08:12:33 INFO - 'TERM': 'linux', 08:12:33 INFO - 'TMOUT': '86400', 08:12:33 INFO - 'USER': 'cltbld', 08:12:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:33 INFO - '_': '/tools/buildbot/bin/python'} 08:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:12:33 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 08:12:33 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 08:12:33 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 08:12:33 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 08:12:33 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 08:12:33 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 08:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:36 INFO - warning: no files found matching '*.txt' 08:12:36 INFO - no previously-included directories found matching 'build' 08:12:36 INFO - no previously-included directories found matching 'dist' 08:12:36 INFO - no previously-included directories found matching '.git*' 08:12:36 INFO - Installing collected packages: jsonschema, functools32 08:12:36 INFO - Running setup.py install for functools32 08:12:36 INFO - warning: no files found matching '*.txt' 08:12:36 INFO - no previously-included directories found matching 'build' 08:12:36 INFO - no previously-included directories found matching 'dist' 08:12:36 INFO - no previously-included directories found matching '.git*' 08:12:36 INFO - Successfully installed jsonschema functools32 08:12:36 INFO - Cleaning up... 08:12:36 INFO - Return code: 0 08:12:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:36 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')]} 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 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')]} 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:36 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:36 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 08:12:36 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 08:12:36 INFO - Using env: {'DISPLAY': ':0', 08:12:36 INFO - 'HOME': '/home/cltbld', 08:12:36 INFO - 'LANG': 'en_US.UTF-8', 08:12:36 INFO - 'LANGUAGE': 'en_US:en', 08:12:36 INFO - 'LOGNAME': 'cltbld', 08:12:36 INFO - 'MAIL': '/var/mail/cltbld', 08:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:36 INFO - 'MOZ_NO_REMOTE': '1', 08:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:36 INFO - 'NO_EM_RESTART': '1', 08:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:36 INFO - 'PWD': '/builds/slave/test', 08:12:36 INFO - 'SHELL': '/bin/bash', 08:12:36 INFO - 'SHLVL': '1', 08:12:36 INFO - 'TERM': 'linux', 08:12:36 INFO - 'TMOUT': '86400', 08:12:36 INFO - 'USER': 'cltbld', 08:12:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:36 INFO - '_': '/tools/buildbot/bin/python'} 08:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:38 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 08:12:39 INFO - Downloading docopt-0.6.1.tar.gz 08:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:39 INFO - Running setup.py install for blobuploader 08:12:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:39 INFO - Running setup.py install for requests 08:12:39 INFO - Running setup.py install for docopt 08:12:39 INFO - Successfully installed blobuploader requests docopt 08:12:39 INFO - Cleaning up... 08:12:39 INFO - Return code: 0 08:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:39 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')]} 08:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:39 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')]} 08:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:39 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:39 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 08:12:39 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 08:12:39 INFO - Using env: {'DISPLAY': ':0', 08:12:39 INFO - 'HOME': '/home/cltbld', 08:12:39 INFO - 'LANG': 'en_US.UTF-8', 08:12:39 INFO - 'LANGUAGE': 'en_US:en', 08:12:39 INFO - 'LOGNAME': 'cltbld', 08:12:39 INFO - 'MAIL': '/var/mail/cltbld', 08:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:39 INFO - 'MOZ_NO_REMOTE': '1', 08:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:39 INFO - 'NO_EM_RESTART': '1', 08:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:39 INFO - 'PWD': '/builds/slave/test', 08:12:39 INFO - 'SHELL': '/bin/bash', 08:12:39 INFO - 'SHLVL': '1', 08:12:39 INFO - 'TERM': 'linux', 08:12:39 INFO - 'TMOUT': '86400', 08:12:39 INFO - 'USER': 'cltbld', 08:12:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:39 INFO - '_': '/tools/buildbot/bin/python'} 08:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:39 INFO - Running setup.py (path:/tmp/pip-pW2Sld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:40 INFO - Running setup.py (path:/tmp/pip-y0zq5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:40 INFO - Running setup.py (path:/tmp/pip-dpWTrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:40 INFO - Running setup.py (path:/tmp/pip-lIvYEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:40 INFO - Running setup.py (path:/tmp/pip-dEZKZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:40 INFO - Running setup.py (path:/tmp/pip-x6yz_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:40 INFO - Running setup.py (path:/tmp/pip-Dn_xIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:40 INFO - Running setup.py (path:/tmp/pip-iT2M1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:40 INFO - Running setup.py (path:/tmp/pip-7bT2ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:40 INFO - Running setup.py (path:/tmp/pip-0y0qXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:40 INFO - Running setup.py (path:/tmp/pip-NqLKt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:40 INFO - Running setup.py (path:/tmp/pip-YobFVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:40 INFO - Running setup.py (path:/tmp/pip-rEiwRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:40 INFO - Running setup.py (path:/tmp/pip-ZA4qj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:40 INFO - Running setup.py (path:/tmp/pip-d99bMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:41 INFO - Running setup.py (path:/tmp/pip-7R_1qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:41 INFO - Running setup.py (path:/tmp/pip-czkLwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:41 INFO - Running setup.py install for manifestparser 08:12:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozcrash 08:12:41 INFO - Running setup.py install for mozdebug 08:12:41 INFO - Running setup.py install for mozdevice 08:12:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozfile 08:12:41 INFO - Running setup.py install for mozhttpd 08:12:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozinfo 08:12:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozInstall 08:12:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozleak 08:12:42 INFO - Running setup.py install for mozlog 08:12:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for moznetwork 08:12:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozprocess 08:12:42 INFO - Running setup.py install for mozprofile 08:12:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozrunner 08:12:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozscreenshot 08:12:42 INFO - Running setup.py install for moztest 08:12:42 INFO - Running setup.py install for mozversion 08:12:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:42 INFO - Cleaning up... 08:12:42 INFO - Return code: 0 08:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:42 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')]} 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 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')]} 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:42 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 08:12:42 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 08:12:43 INFO - Using env: {'DISPLAY': ':0', 08:12:43 INFO - 'HOME': '/home/cltbld', 08:12:43 INFO - 'LANG': 'en_US.UTF-8', 08:12:43 INFO - 'LANGUAGE': 'en_US:en', 08:12:43 INFO - 'LOGNAME': 'cltbld', 08:12:43 INFO - 'MAIL': '/var/mail/cltbld', 08:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:43 INFO - 'MOZ_NO_REMOTE': '1', 08:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:43 INFO - 'NO_EM_RESTART': '1', 08:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:43 INFO - 'PWD': '/builds/slave/test', 08:12:43 INFO - 'SHELL': '/bin/bash', 08:12:43 INFO - 'SHLVL': '1', 08:12:43 INFO - 'TERM': 'linux', 08:12:43 INFO - 'TMOUT': '86400', 08:12:43 INFO - 'USER': 'cltbld', 08:12:43 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:43 INFO - '_': '/tools/buildbot/bin/python'} 08:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:43 INFO - Running setup.py (path:/tmp/pip-nPQmoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:43 INFO - Running setup.py (path:/tmp/pip-H5WJQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:43 INFO - Running setup.py (path:/tmp/pip-dw1Aed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:43 INFO - Running setup.py (path:/tmp/pip-ygeR3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:43 INFO - Running setup.py (path:/tmp/pip-LcfMbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:43 INFO - Running setup.py (path:/tmp/pip-AdpjKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:43 INFO - Running setup.py (path:/tmp/pip-fIjm3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 INFO - Running setup.py (path:/tmp/pip-DPTJ1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:43 INFO - Running setup.py (path:/tmp/pip-5bdWoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Running setup.py (path:/tmp/pip-mI7NcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Running setup.py (path:/tmp/pip-E6gj0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:44 INFO - Running setup.py (path:/tmp/pip-SNRUBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:44 INFO - Running setup.py (path:/tmp/pip-weNm3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:44 INFO - Running setup.py (path:/tmp/pip-6UlYpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:44 INFO - Running setup.py (path:/tmp/pip-kFniqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:44 INFO - Running setup.py (path:/tmp/pip-aHlFYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:44 INFO - Running setup.py (path:/tmp/pip-I0kgqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:44 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)) 08:12:44 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)) 08:12:44 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)) 08:12:44 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)) 08:12:44 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)) 08:12:44 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)) 08:12:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:44 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 08:12:44 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 08:12:44 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 08:12:44 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 08:12:44 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 08:12:44 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 08:12:46 INFO - Downloading blessings-1.6.tar.gz 08:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:46 INFO - Installing collected packages: blessings 08:12:46 INFO - Running setup.py install for blessings 08:12:46 INFO - Successfully installed blessings 08:12:46 INFO - Cleaning up... 08:12:46 INFO - Return code: 0 08:12:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:46 INFO - Reading from file tmpfile_stdout 08:12:46 INFO - Current package versions: 08:12:46 INFO - argparse == 1.2.1 08:12:46 INFO - blessings == 1.6 08:12:46 INFO - blobuploader == 1.2.4 08:12:46 INFO - docopt == 0.6.1 08:12:46 INFO - functools32 == 3.2.3-2 08:12:46 INFO - jsonschema == 2.5.1 08:12:46 INFO - manifestparser == 1.1 08:12:46 INFO - mozInstall == 1.12 08:12:46 INFO - mozcrash == 0.17 08:12:46 INFO - mozdebug == 0.1 08:12:46 INFO - mozdevice == 0.48 08:12:46 INFO - mozfile == 1.2 08:12:46 INFO - mozhttpd == 0.7 08:12:46 INFO - mozinfo == 0.9 08:12:46 INFO - mozleak == 0.1 08:12:46 INFO - mozlog == 3.2 08:12:46 INFO - moznetwork == 0.27 08:12:46 INFO - mozprocess == 0.22 08:12:46 INFO - mozprofile == 0.28 08:12:46 INFO - mozrunner == 6.11 08:12:46 INFO - mozscreenshot == 0.1 08:12:46 INFO - mozsystemmonitor == 0.3 08:12:46 INFO - moztest == 0.7 08:12:46 INFO - mozversion == 1.4 08:12:46 INFO - psutil == 3.1.1 08:12:46 INFO - requests == 1.2.3 08:12:46 INFO - wsgiref == 0.1.2 08:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:46 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')]} 08:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 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')]} 08:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:46 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 08:12:46 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 08:12:46 INFO - Using env: {'DISPLAY': ':0', 08:12:46 INFO - 'HOME': '/home/cltbld', 08:12:46 INFO - 'LANG': 'en_US.UTF-8', 08:12:46 INFO - 'LANGUAGE': 'en_US:en', 08:12:46 INFO - 'LOGNAME': 'cltbld', 08:12:46 INFO - 'MAIL': '/var/mail/cltbld', 08:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:46 INFO - 'MOZ_NO_REMOTE': '1', 08:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:46 INFO - 'NO_EM_RESTART': '1', 08:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:46 INFO - 'PWD': '/builds/slave/test', 08:12:46 INFO - 'SHELL': '/bin/bash', 08:12:46 INFO - 'SHLVL': '1', 08:12:46 INFO - 'TERM': 'linux', 08:12:46 INFO - 'TMOUT': '86400', 08:12:46 INFO - 'USER': 'cltbld', 08:12:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:46 INFO - '_': '/tools/buildbot/bin/python'} 08:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:46 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)) 08:12:46 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)) 08:12:46 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)) 08:12:46 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)) 08:12:46 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)) 08:12:46 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)) 08:12:47 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)) 08:12:47 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)) 08:12:47 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)) 08:12:47 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)) 08:12:47 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)) 08:12:47 INFO - Cleaning up... 08:12:47 INFO - Return code: 0 08:12:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:47 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:47 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 08:12:47 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 08:12:47 INFO - Using env: {'DISPLAY': ':0', 08:12:47 INFO - 'HOME': '/home/cltbld', 08:12:47 INFO - 'LANG': 'en_US.UTF-8', 08:12:47 INFO - 'LANGUAGE': 'en_US:en', 08:12:47 INFO - 'LOGNAME': 'cltbld', 08:12:47 INFO - 'MAIL': '/var/mail/cltbld', 08:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:47 INFO - 'MOZ_NO_REMOTE': '1', 08:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:47 INFO - 'NO_EM_RESTART': '1', 08:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:47 INFO - 'PWD': '/builds/slave/test', 08:12:47 INFO - 'SHELL': '/bin/bash', 08:12:47 INFO - 'SHLVL': '1', 08:12:47 INFO - 'TERM': 'linux', 08:12:47 INFO - 'TMOUT': '86400', 08:12:47 INFO - 'USER': 'cltbld', 08:12:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:47 INFO - '_': '/tools/buildbot/bin/python'} 08:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:47 INFO - Cleaning up... 08:12:47 INFO - Return code: 0 08:12:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:47 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 0x7fd9dd336f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', '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 08:12:47 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 08:12:47 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 08:12:47 INFO - Using env: {'DISPLAY': ':0', 08:12:47 INFO - 'HOME': '/home/cltbld', 08:12:47 INFO - 'LANG': 'en_US.UTF-8', 08:12:47 INFO - 'LANGUAGE': 'en_US:en', 08:12:47 INFO - 'LOGNAME': 'cltbld', 08:12:47 INFO - 'MAIL': '/var/mail/cltbld', 08:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:47 INFO - 'MOZ_NO_REMOTE': '1', 08:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:47 INFO - 'NO_EM_RESTART': '1', 08:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:47 INFO - 'PWD': '/builds/slave/test', 08:12:47 INFO - 'SHELL': '/bin/bash', 08:12:47 INFO - 'SHLVL': '1', 08:12:47 INFO - 'TERM': 'linux', 08:12:47 INFO - 'TMOUT': '86400', 08:12:47 INFO - 'USER': 'cltbld', 08:12:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:47 INFO - '_': '/tools/buildbot/bin/python'} 08:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:47 INFO - Downloading/unpacking flake8 08: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 08: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 08: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 08: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 08: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 08: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 08:12:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:12:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:12:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:50 INFO - no previously-included directories found matching 'docs/_build' 08:12:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:12:50 INFO - Running setup.py install for pep8 08:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:50 INFO - no previously-included directories found matching 'docs/_build' 08:12:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:12:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:12:50 INFO - Cleaning up... 08:12:50 INFO - Return code: 0 08:12:50 INFO - Running post-action listener: _resource_record_post_action 08:12:50 INFO - Running post-action listener: _start_resource_monitoring 08:12:50 INFO - Starting resource monitoring. 08:12:50 INFO - ##### 08:12:50 INFO - ##### Finished create-virtualenv step (success) 08:12:50 INFO - ##### 08:12:50 INFO - ##### 08:12:50 INFO - ##### Running install step. 08:12:50 INFO - ##### 08:12:50 INFO - Running pre-action listener: _resource_record_pre_action 08:12:50 INFO - Running main action method: install 08:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:50 INFO - Reading from file tmpfile_stdout 08:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:50 INFO - Reading from file tmpfile_stdout 08:12:50 INFO - Output received: 08:12:50 INFO - Usage: mozinstall [options] installer 08:12:50 INFO - Options: 08:12:50 INFO - -h, --help show this help message and exit 08:12:50 INFO - -d DEST, --destination=DEST 08:12:50 INFO - Directory to install application into. [default: 08:12:50 INFO - "/builds/slave/test"] 08:12:50 INFO - --app=APP Application being installed. [default: firefox] 08:12:50 INFO - mkdir: /builds/slave/test/build/application 08:12:50 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'] 08:12:50 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 08:13:07 INFO - Reading from file tmpfile_stdout 08:13:07 INFO - Output received: 08:13:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:07 INFO - Running post-action listener: _resource_record_post_action 08:13:07 INFO - ##### 08:13:07 INFO - ##### Finished install step (success) 08:13:07 INFO - ##### 08:13:07 INFO - ##### 08:13:07 INFO - ##### Running run-tests step. 08:13:07 INFO - ##### 08:13:07 INFO - Running pre-action listener: _resource_record_pre_action 08:13:07 INFO - Running main action method: run_tests 08:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:07 INFO - Python 2.7.3 08:13:07 INFO - Return code: 0 08:13:07 INFO - grabbing minidump binary from tooltool 08:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11581c0>, '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 0x11590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:13:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:13:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:07 INFO - Return code: 0 08:13:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:13:08 INFO - Return code: 0 08:13:08 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/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:13:08 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/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 08:13:08 INFO - Using env: {'DISPLAY': ':0', 08:13:08 INFO - 'HOME': '/home/cltbld', 08:13:08 INFO - 'LANG': 'en_US.UTF-8', 08:13:08 INFO - 'LANGUAGE': 'en_US:en', 08:13:08 INFO - 'LOGNAME': 'cltbld', 08:13:08 INFO - 'MAIL': '/var/mail/cltbld', 08:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:08 INFO - 'MOZ_NO_REMOTE': '1', 08:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:08 INFO - 'NO_EM_RESTART': '1', 08:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:08 INFO - 'PWD': '/builds/slave/test', 08:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:08 INFO - 'SHELL': '/bin/bash', 08:13:08 INFO - 'SHLVL': '1', 08:13:08 INFO - 'TERM': 'linux', 08:13:08 INFO - 'TMOUT': '86400', 08:13:08 INFO - 'USER': 'cltbld', 08:13:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986', 08:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:08 INFO - '_': '/tools/buildbot/bin/python'} 08:13:08 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/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:13:08 INFO - mozversion application_buildid: 20160615053002 08:13:08 INFO - mozversion application_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:13:08 INFO - mozversion application_display_name: Nightly 08:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:08 INFO - mozversion application_name: Firefox 08:13:08 INFO - mozversion application_remotingname: firefox 08:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:13:08 INFO - mozversion application_vendor: Mozilla 08:13:08 INFO - mozversion application_version: 50.0a1 08:13:08 INFO - mozversion platform_buildid: 20160615053002 08:13:08 INFO - mozversion platform_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:13:08 INFO - mozversion platform_version: 50.0a1 08:13:08 INFO - using testdate: 1466003588 08:13:08 INFO - actual date: 1466003588 08:13:08 INFO - starting webserver on 'localhost:55108' 08:13:08 INFO - SUITE-START | Running 2 tests 08:13:08 INFO - TEST-START | dromaeo_css 08:13:08 INFO - operating with platform_type : linux_ 08:13:08 INFO - Initialising browser for dromaeo_css test... 08:13:08 INFO - TEST-INFO | started process 18975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_M6Z_/profile http://localhost:55108/getInfo.html) 08:13:13 INFO - PROCESS | 18975 | __metrics Screen width/height:1600/1200 08:13:13 INFO - PROCESS | 18975 | colorDepth:24 08:13:13 INFO - PROCESS | 18975 | Browser inner width/height: 1024/697 08:13:13 INFO - PROCESS | 18975 | __metrics 08:13:14 INFO - PROCESS | 18975 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:14 INFO - PROCESS | 18975 | console.error: PushService: 08:13:14 INFO - PROCESS | 18975 | stateChangeProcessEnqueue: Error transitioning state 08:13:14 INFO - PROCESS | 18975 | UnknownError 08:13:15 INFO - TEST-INFO | 18975: exit 0 08:13:15 INFO - Browser initialized. 08:13:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:15 INFO - TEST-INFO | started process 19058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_M6Z_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:27 INFO - PROCESS | 19058 | RSS: Main: 177389568 08:13:27 INFO - PROCESS | 19058 | 08:14:18 INFO - PROCESS | 19058 | 1466003658599 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] 08:16:26 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55108/tests/dromaeo/cssquery-ext.html) 08:16:27 INFO - PROCESS | 19058 | RSS: Main: 274771968 08:16:27 INFO - PROCESS | 19058 | 08:19:29 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-ext.html (next: http://localhost:55108/tests/dromaeo/cssquery-jquery.html) 08:19:30 INFO - PROCESS | 19058 | RSS: Main: 265756672 08:19:30 INFO - PROCESS | 19058 | 08:22:32 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55108/tests/dromaeo/cssquery-mootools.html) 08:22:33 INFO - PROCESS | 19058 | RSS: Main: 262492160 08:22:33 INFO - PROCESS | 19058 | 08:25:35 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55108/tests/dromaeo/cssquery-prototype.html) 08:25:35 INFO - PROCESS | 19058 | RSS: Main: 264888320 08:25:35 INFO - PROCESS | 19058 | 08:28:38 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55108/tests/dromaeo/cssquery-yui.html) 08:28:39 INFO - PROCESS | 19058 | RSS: Main: 238628864 08:28:39 INFO - PROCESS | 19058 | 08:31:41 INFO - PROCESS | 19058 | Cycle 1(1): loaded http://localhost:55108/tests/dromaeo/cssquery-yui.html (next: http://localhost:55108/tests/dromaeo/cssquery-dojo.html) 08:31:42 INFO - PROCESS | 19058 | RSS: Main: 325648384 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | __start_tp_report 08:31:42 INFO - PROCESS | 19058 | _x_x_mozilla_page_load 08:31:42 INFO - PROCESS | 19058 | _x_x_mozilla_page_load_details 08:31:42 INFO - PROCESS | 19058 | |i|pagename|runs| 08:31:42 INFO - PROCESS | 19058 | |0;dojo.html;3053.0688140117254;3075.246564591675;3090.3510262844793;3119.298157914468;3134.3417882244726;5213.400458947222;5261.579073674106;5266.131088370424;5371.57027437805;5383.219433182187;5273.604479664022;5274.235235890794;5282.683039017652;5301.7084060376765;5354.598405119622;4727.149113159629;4835.661503694742;4848.17581011229;4849.7817598207985;5044.066847633181;4946.356973593428;4966.255061740731;4966.801327946878;5014.548690617844;5046.217836235371;4737.147313483571;4786.497417771118;4790.664653474259;4815.181419158752;4816.422029356482;4772.117158325721;4795.880102997453;4868.805247790084;4886.731229782396;4915.090708218991;4652.674312798105;4830.3237546743485;4859.41686997559;4869.8782530436665;4900.485449027872;5273.920891186635;5335.759890804884;5354.196870469422;5442.482964118442;5448.182772584105;5717.685527295997;5747.540196784247;5754.769809207627;5778.24882765242;5784.855378615526;5609.1305847593685;5629.493345598916;5821.67980761058;5839.270091238595;5845.678487683176;5280.867978300574;5342.198670199501;5384.273123128328;5387.084195686703;5387.515123638891;5854.063349864001;5877.118432235199;5880.7353669085;5883.264591926009;5890.1164825276555;5443.319585051869;5457.126859702428;5482.91775623366;5661.971690141523;5667.1499275108235;5627.493525582717;5630.183623374588;5650.886982260332;5668.744906479218;5675.3757086720425;5592.384837667853;5607.355154157242;5610.943890561124;5611.214429979725;5618.4662457066515;5478.260434841325;5597.8600534986135;5611.859703507445;5661.745221465044;5688.601797874109;4363.127374525107;4382.627476664456;4391.802368893407;4391.956080439155;4429.379886815848;3930.783806890591;3949.5260568731937;3952.1898010907694;3985.20295940813;3995.7402768819934;5227.372715274191;5230.764615592308;5322.494363035506;5370.355557333067;5374.731263436813;5729.713514324267;5742.109972954198;5744.971275143597;5745.454181852718;5794.971025144847;5385.703786291713;5393.217983392465;5393.6763794172475;5396.757145928443;5397.676139431646;4830.275458681226;4899.461059283476;4927.285543596158;4950.8267210647455;4953.380827396575;5943.435373639497;5950.137230101611;5954.3152537458745;5960.940390596039;5962.761489540369;5556.472135147154;5722.313322401338;5735.913961290667;5736.282964629421;5738.454846789548;5773.22061521706;5794.246747922912;5806.5645076618575;5844.649321040752;5845.736941837713;5544.500994910316;5547.140193270049;5551.833444996657;5552.500274975271;5567.582431317748;5509.752061157177;5611.80358687444;5702;5706.771729130788;5711.714414279352;5565.916511252415;5592.049351610155;5598.440155984369;5609.074502707008;5642.830715078554;5502.614816962774;5530.723463826712;5542.944570554404;5549.694766787704;5551.139573366135;5317.202419637086;5354.464553544614;5385.946140538701;5476.288082549243;5540.556755459473;5587.776488940397;5594.049011668108;5594.552435805044;5598;5608.943910560843;5414.756335964812;5419.756110975094;5420.322459692538;5422.674639521641;5424.620276580759 08:31:42 INFO - PROCESS | 19058 | |1;ext.html;584.3659629302207;612.6967151260127;638.1448858529573;639.96800159992;642.6369101457676;31953.52069718953;35669.10827229314;35706.46440303398;35728.82135589318;41771.37342939858;40923.18153636925;46067.769661151644;46077.769611151896;46122.07755844881;46199;8808;9065.59204835784;9066.320025998044;9066.727998160033;9072.31957603179;8763.824723505526;8848.955755221215;8858.202761751441;8859.379843410963;8860.6012729427;8884.822303553925;8907.242884354837;8910.376273660846;8917.019127895926;8919;8887.466751994869;8889.022207557164;8911;8930.062343453974;8940.642374305053;8891.822163556693;8998.640054397816;9003;9006.1894429501;9007.729768106967;42666;42948.57051429508;43109.78445107755;43155.784221079004;43206.783966080286;3428.6057103433177;3963.583823698499;3976.622220889011;4125.566815484361;4227.112306415656;32735.345293094004;32848.50727239093;33081;33251;33753.32493350144;4447.799849006802;4494.4606647202545;4498.457828203549;4514.774261286922;4645.047765208158;327075;327384.9999999976;327524.9999999976;327688;328020;59759.70120149371;59870.70064649649;60318;60333;60351.698241508515;35473.82263088668;36468;36485;38459.23081538353;64187.679061604395;17147.914260428617;17192.22634981429;17217.225224864913;17301.480955571355;17307.480775576754;11930.343831089373;12028.63914082579;12043.15697901156;12048.096392770578;12065.396730163457;19678;19924;19966.30117945865;19971.60056798885;20020.799792001893;6859.897101543481;6938.757143499954;6961.199462061826;7098.858022839514;7352.014955961968;952.842780941137;971.9416834989923;1021.6616232734992;1124.9268797528298;1126.6845283320683;32192.83903580514;32953.3409331812;33055;33090.66909330924;33564.49653255203;1108.2408550143016;1111.0778054215143;1122.6239209864787;1154.2670404293167;1172.513406936129;16691.49925502237;17232.655346892992;17352.479425617;17402.303907843798;17669.469915902544;479136;483188;487515;489079;489735;61411;61918.38081619216;62073.689631551555;62129.68935155295;62309.68845155745;1224.12475080318;1290.3096843188848;1341.349445518942;1374.9344258199776;1382.4470211915313;31148.22129446782;35328.11679708028;35446.29107417889;35463.290734185684;35735.82132089323;51675.483245167066;52176.21735673892;52397;52466.73766631143;52493.47506524886;395021;399127;399388;400022;400032;28700.352060296358;29390.85304573549;29517.409651807273;29655;29655.85172074126;50290;50356.74821625868;50361.49638503568;51896.221556675926;52090.73954630354;42160.1567968645;42464.57535424606;42474;43460.348094779234;43482.34776478419;41314;41933.79033104937;42156.78921605372;42500.57499424966;42977.3553396693;41436.1712765749;42177;42427.7878610605;43127.568724312354;43265.567344326155;36636.45045324269;37990.43014354732;38016.619833801306;38759.418608721455;39062.4140637885;28609.28476788097;28612.284692882844;28785.136445906657;28844;29128.7087129126 08:31:42 INFO - PROCESS | 19058 | |2;jquery.html;372.8676319906435;377.8431207263315;382.16496954155156;387.54850599052105;401.66862338570684;14998.100113993141;16318.673626527463;17939;19114.235430582776;19655.803441965578;16684.499465016037;18065.63868722628;18841.43475695728;18874.62250754984;18978.525536861587;5540.612157148991;5762.82711518653;5787.594868359217;5811.302643682764;5816;3737.2338670572603;5248.42267350593;5362.544183744387;5642.379338272786;5669.09294512878;5660.660360378391;5729.398413166599;5731.570132240078;5734.827955161351;5752.309722833266;5658.405867383927;5723.255976723041;5723.914141287884;5736.741846616891;5742.397048309909;5514.503694667499;5525.254090697785;5539.058360078796;5542.279503664538;5544.889102217933;20247.392578222676;21492.462688432915;21679.24122655715;22327.77672223273;22518.77481225183;2064.9793502064936;2136.2629892686996;2166.555856049506;2453.6196889482158;2492.4018235623503;9055.909440905572;9269.582868770922;9329.860052099157;9649.179819715333;11648.767024659459;1763.8765286429955;1776.600264940391;1786.222992998037;1846.2522678315304;1906.9713954290696;51479.22781158286;62460;78061;78412.60793695995;79059;10015.949920250352;10308.989746999414;10376;10620.575176992988;10914.945425272981;14069;14076.859231407554;14080.014398991972;14134.787978180335;14174.503892363924;7384.889226661604;7415.8146046349275;7423.703051877865;7527.209642987407;7555.055618047744;6903.827404314932;7010.334018268256;7082.256363081905;7110.822229444202;7126.714931402789;4349.608535231781;4394.8242070317465;4459.955400446019;4536.886577835515;4568.794404251817;1692.5007122898774;1764.2149243586737;1774.7160454327245;1811.2845426056633;1815.9273629054953;425.2600475173176;427.48061105756034;433.9002029533162;926.5043201886958;1050.8318669012922;11072.889271107348;11106.50020749052;11159.832602510969;11165.162612804072;11505;443.63843467573827;446.4709319456455;446.8168051099034;454.9226631472658;468.75624675169405;5782.855428614318;6025.427584379477;6050.152978583002;6124.785632502841;6171.814845554641;459796;462689;464324;464944;475521;92883.07116928745;95702.52148739212;96622.51688741652;96835;97229.5138524317;450.34474839109015;451.109059607273;452.35313501692235;455.5922449407828;457.22956817761514;10312.027203139638;10319.638812641522;10341.9482902585;10428.165746740395;10436.791264174826;37253.441198382585;38631.42052869153;39459.60540394559;39821;41438.37842432426;46473.302900457194;56536.43463565312;57042.7147864258;57220.42779572151;57298.7135064322;8206.917930820855;8247.505149690798;8269.83460330802;8499.107593702573;8515.616797244264;12255.32595707209;13284.136531125447;13287.06990510655;13386.330683465592;13464.528741494001;11762.117841161777;11805.645830625095;11848.111391645489;11878.168528203289;11994.880051199376;11261.155413343868;11385.146114041314;11557.133215009077;11857.703557410789;11896.643100706646;11608.6517404478;11757.529698811952;11868.58459953932;11914.940425297818;12201;8066.7579972600915;8203.79490512718;8208.794780130305;8253.050899146676;8312.584370781316;10674.35953842772;11633.243839150427;11903.82144267854;12124.181372793799;12136.089793265364 08:31:42 INFO - PROCESS | 19058 | |3;mootools.html;1320.716046050099;1437.1520802726388;1488.4641529049543;1601.2314089237166;1746.8602511799058;8002.759917202478;8292.502449853006;8325.125861784509;8573.614187361569;8585.742427727178;8329.66681332746;8454.661813527468;8515.489070655765;8517.403781735282;8523.872141917876;1982.3260091568864;2168.392850002002;2187.2454003368853;2225.810806081477;2226.9888650556722;2249.089118906845;2262.536180083079;2263.7057182566246;2264.920727774528;2267.036509483471;2168.121910626191;2187.9343619691435;2190.3428971308545;2205.151016858505;2211.7456492503325;1919.3378284491828;2130.8401869859745;2131.1049359269145;2184.432047667618;2187.5406164705273;2148.828093752496;2156.051337411534;2159.6436587962967;2178.575177840322;2179.182806447582;8606.182412670787;8706.434081784664;8729.694460693845;8758;8778.166074223003;4826;4983.900321993576;4987.600991920638;4990.176620857555;4994.400671919393;3107.5338699195077;3130.7182353588287;3169.9841500792577;3197.1527545200543;3203.4073696366245;1004.3622299839582;1011.0647650922867;1025.8512515685259;1033.41095575522;1035.3735989726258;11511.36687482188;11573.18987670855;11662.358570278631;11682.41587920609;11725.237859539102;4296.656267498593;4297.333913243452;4421.005273813366;4427.22523558376;4437.356583295404;9763.463009534544;9776.413415195111;9782.75543111428;9790.118889299998;9808.460534670661;4952.133376659142;4982.451930287665;4991.825286114969;4992.350994370709;5003.399592048978;4175.144095460423;4445.755483448376;4589.151007063704;4617.930731039037;4674.252119660838;3668.724845636588;3757.1546402059316;3783.8675646352244;3822.9044273893373;3865.536135663682;1117.4468638024068;1118.8209886418297;1129.76274982253;1132.1791701016862;1156.0982433701727;891.5675897189858;939.727479031087;957.9042095790504;966.7003228999033;967.4002118686459;5503.981763373788;5505.256790333334;5618.747156377973;5635.5773317001385;6072.605280656743;914.1863741270275;924.075924075924;957.7414098193589;985.7979114281555;1006.6476733143488;4163.39630753539;4242.193983143193;4246.171996460661;4282.8715138545895;4298.806553705028;10644.467776611138;11006.944965275123;11015.339079655247;11020.228583999044;11022.669319920415;10772.622958196425;10864.34813911152;10897.564097436172;10909.945450272857;10912.072473839813;8000.6399712011935;8160.224778646019;8328.167183281623;8330.333573314121;8333.16668333174;6159.876802464015;6176.258848938156;6214.130021796862;6215.471684906653;6233.470155036873;9911.752206194902;9922;10034.598616055277;10063.295569310078;10070.748231294276;9737.123658870736;10362.896371036495;10409;10423.791524169626;10450.16398688088;6703.865922681422;7091.539049961736;7280;7353;7516.5114267572435;8513.91486085156;8573.914260857311;8619.569021549023;8621.482711037357;8640;7524.51090679126;7651.081870175614;7757.263060009516;7889.0927543333255;7950.7217247396065;7434.107907051189;7464.552126872405;7501.324880760758;7559.470837041575;7650.540967541965;6939.653017349214;7020.403265722471;7021.68402421882;7029.156501219886;7042.43660507148;4949.331840201527;4966.751662416792;5073.594112471067;5166.844994650167;5176.352955880515;5312.681239125664;5366.356037275552;5422.810201642924;5498.147787093007;5563.582731295088 08:31:42 INFO - PROCESS | 19058 | |4;prototype.html;314.05939212059883;314.28813736885957;315.0501238765124;318.59697482684425;320.03349883352274;5361.525580465369;5378.757955891984;5395.190721391793;5402;5420.105682562373;5293.68237905725;5294.338207724035;5374.596905232103;5381.165919282507;5390.032638087099;3967.662748666367;4005.7381924693773;4102.856400025999;4127.133302006582;4151.169766046788;4084.4281800547947;4100.405441211023;4103;4123.670106391482;4129.752214867102;3952.901177470572;4119.979400102995;4134.173165366924;4142.917141657165;4150.584941505856;4005.9599404006026;4055.472788537501;4072.1855628874346;4080.2655522006025;4088.672906167514;3615.6384361563632;3616.367135751233;3623.221007483404;3630.6369363063745;3635.5273814404222;5136;5159;5179.870503237412;5218.478152184789;5233.712145831978;4552.499225085238;4703.847557348471;4709.62323014158;4714.151452738506;4729.645276604234;5480.424555421663;5496.230527726121;5504.4770746778995;5510.283663123809;5516.593268716491;4002.4590532645143;4008.5590585035625;4011.292377645078;4016.357382818764;4037.8290295814177;5566.666000040011;5712.742926568314;5728.971355143198;5735.512481439083;5736.311642602873;4064;4077.16527562598;4093.5292441369625;4095.6313931746286;4101.933497290726;4130.760771768458;4154.709170358106;4155.252054630135;4178.373244013423;4181.017460896687;4595.839145629954;4648.140094082605;4681.227597446451;4714.4342678878065;4766.213574760126;5482.972585137049;5491.176323551419;5499.587530935196;5501.587380946445;5509.173623956359;1425.2731107135435;1425.8930580206527;1433.0112222566395;1437.6549628089183;1439.5820117184564;863.179979019921;937.2033771294346;945.4894357047255;960.4045491794992;967.9128878400978;5215.5486921147;5239.528442440199;5274.841754747364;5348.064088784447;5353.732313384316;5634.52106570946;5640.858978525488;5645.379008309083;5649.700568869101;5650.943490565041;5111.032252582782;5270.8155214567305;5291.497307755757;5298.443663415363;5309.681419114865;2977.449171903205;3010.6537748159244;3025.714071519639;3026.9848650756603;3033.6511301200203;5661.493561554686;5836.2412886325355;5858.970705146447;5860.267466566679;5868.178455016301;5564.693941833157;5739.253896993364;5744.885102297931;5751.338596061423;5773.682447465346;5752.9137062943255;5774.855628609403;5786.276715410574;5825.621334613322;5835.132757517554;5407.432219617041;5513.834584962297;5522.5581953442825;5563;5591.21722958778;5535.446455354432;5536.4186760389575;5546.75039623226;5548.3619383769765;5581.6930068846605;5779.537636988946;5793.131030345482;5829.329627092939;5833.154192641959;5840.13115802939;3949.9012524687114;4060.2390374545594;4065.2885744993914;4080.7551546906093;4081.8163182657445;5551.611387202857;5566.137248726453;5586.581006424453;5589.608727389043;5613.775448981995;5336.973315133399;5351.929614077278;5487.655524396549;5516.531094856982;5563.8887222256135;5534.39121696605;5536.501714845684;5549.861253468695;5550.861228469321;5556;5251.606129540376;5452.400235974119;5470.589705772003;5476.835694929158;5495.2856128703015;5556.72216389187;5572.582056345871;5583.972080139573;5592.608517403743;5614.550835933197;5439.972800135974;5447.237386765777;5452.563794896319;5459.2629994950175;5490.176473529003 08:31:42 INFO - PROCESS | 19058 | |5;yui.html;757.7840315510077;775.4571799740183;787.3307688464805;790;827.20175031095;14845;15651.21743912804;15681;15877.841221587809;15891.523254302376;14158.929205353985;15110.924445377785;15320.616984575392;15445.691086178269;15502.844971550281;656.4682607088274;770.4953255617579;788.1645455816838;799.568233154099;799.7560743973086;802.3420794948145;815.3314282288526;816.8815521749343;817.3951276055706;818.0633175014605;845.530730444603;848.3298194426427;848.7284069097891;848.8641817309232;848.9023762267326;682.2563405887581;817.4155478832663;834.0575150080431;840.0171798995191;843.843888880559;620.6245221640887;620.9348018458043;621.1211136242212;621.183144165421;622.0824284180842;14832.406703731838;14840;14873.776893346609;14884.851151488454;14897.925510372486;13588.93205533976;13669.179849209078;13911.443542258297;14048.43806247749;14074.155550666992;12694.42875070624;12720;12754.298513581749;12857.164284321489;12887.484500619965;4459.197344477992;4483.587669884008;4492.887677808081;4541.568550987651;4583.656225783079;71778;71886.92169617407;71898;71906.99999999948;71931.28068719298;11070.225084244186;11267.887321126847;11305.434728263554;11449.255798373079;11752.70618234551;19829.702554461695;19837.702434463496;19907.905065221552;19937.501562460766;20000.499987500138;8306.127856574973;8337.916620833714;8466.449680770731;8467.661293548312;8808.339374546935;4353.25994580922;4495.325701144854;4649.837255696035;4707.223308154116;4864.95135048645;3172.6510083890753;3245.513173024018;3273.8363081845814;3274.1159886830424;3290.407726609233;564.3453593831218;576.2451188942415;578.1212556913468;578.6296770067161;579.5913880714087;548.4926443040172;645.7642960319449;657.0669649098292;681.117952251835;686.2451303566038;8715.825683486295;9428.95285523568;9638.325317227867;9692.903070969342;9721.805563888682;549.6344930621173;634.7048622390611;637.5314144104079;655.4003087175277;683.8392977650249;4251.404803327537;4269.146170765859;4309.418228539107;4471.577023187419;4506.143832671782;110427;112002;112356;113355.43322283335;114758;85031.5748421254;86281;86643;93968;97589.51205244071;66349;92421.07578924125;92500.53749731208;92872.53563732139;95682.52158739301;10092.444915529422;10408.583656653649;10451.477426128511;10612.787744245226;10678.62624808128;53871.73064134654;54070;54085.459145408044;54189.729051354494;56307.71846140743;50731.49268507268;69648.95526567004;76124.23875761172;82340;86384.56807715922;13225.206487610774;13389.732205356033;13530.526431575241;13884.652883677989;14008.929955350159;15101.546953591409;15175.772363414337;15440.922795386401;15892;16000.119993400474;14396;14528.491502797351;14683;14747.631309216926;14969.476068337555;12845.807312890127;12926.418311175832;13249.735005300034;13253.469861205444;13267.270300133585;13529.391177397238;13757.793180314437;13983.650408739455;14004.229767362893;14104.36530356157;11385.231285793061;11394.430278485877;11695.298282103102;11757.176997610086;11960.222585531912;11294.94352528232;11597.883178010552;11771.941140294244;11831;11891.28652280866 08:31:42 INFO - PROCESS | 19058 | __end_tp_report 08:31:42 INFO - PROCESS | 19058 | __start_cc_report 08:31:42 INFO - PROCESS | 19058 | _x_x_mozilla_cycle_collect,930 08:31:42 INFO - PROCESS | 19058 | __end_cc_report 08:31:42 INFO - PROCESS | 19058 | __startTimestamp1466004702086__endTimestamp 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | ------- Summary: start ------- 08:31:42 INFO - PROCESS | 19058 | Number of tests: 6 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#0] dojo.html Cycles:165 Average:5286.98 Median:5443.32 stddev:587.71 (10.8%) stddev-sans-first:562.78 08:31:42 INFO - PROCESS | 19058 | Values: 3053.1 3075.2 3090.4 3119.3 3134.3 5213.4 5261.6 5266.1 5371.6 5383.2 5273.6 5274.2 5282.7 5301.7 5354.6 4727.1 4835.7 4848.2 4849.8 5044.1 4946.4 4966.3 4966.8 5014.5 5046.2 4737.1 4786.5 4790.7 4815.2 4816.4 4772.1 4795.9 4868.8 4886.7 4915.1 4652.7 4830.3 4859.4 4869.9 4900.5 5273.9 5335.8 5354.2 5442.5 5448.2 5717.7 5747.5 5754.8 5778.2 5784.9 5609.1 5629.5 5821.7 5839.3 5845.7 5280.9 5342.2 5384.3 5387.1 5387.5 5854.1 5877.1 5880.7 5883.3 5890.1 5443.3 5457.1 5482.9 5662.0 5667.1 5627.5 5630.2 5650.9 5668.7 5675.4 5592.4 5607.4 5610.9 5611.2 5618.5 5478.3 5597.9 5611.9 5661.7 5688.6 4363.1 4382.6 4391.8 4392.0 4429.4 3930.8 3949.5 3952.2 3985.2 3995.7 5227.4 5230.8 5322.5 5370.4 5374.7 5729.7 5742.1 5745.0 5745.5 5795.0 5385.7 5393.2 5393.7 5396.8 5397.7 4830.3 4899.5 4927.3 4950.8 4953.4 5943.4 5950.1 5954.3 5960.9 5962.8 5556.5 5722.3 5735.9 5736.3 5738.5 5773.2 5794.2 5806.6 5844.6 5845.7 5544.5 5547.1 5551.8 5552.5 5567.6 5509.8 5611.8 5702.0 5706.8 5711.7 5565.9 5592.0 5598.4 5609.1 5642.8 5502.6 5530.7 5542.9 5549.7 5551.1 5317.2 5354.5 5385.9 5476.3 5540.6 5587.8 5594.0 5594.6 5598.0 5608.9 5414.8 5419.8 5420.3 5422.7 5424.6 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#1] ext.html Cycles:180 Average:57194.22 Median:42158.47 stddev:108044.93 (256.3%) stddev-sans-first:108264.42 08:31:42 INFO - PROCESS | 19058 | Values: 584.4 612.7 638.1 640.0 642.6 31953.5 35669.1 35706.5 35728.8 41771.4 40923.2 46067.8 46077.8 46122.1 46199.0 8808.0 9065.6 9066.3 9066.7 9072.3 8763.8 8849.0 8858.2 8859.4 8860.6 8884.8 8907.2 8910.4 8917.0 8919.0 8887.5 8889.0 8911.0 8930.1 8940.6 8891.8 8998.6 9003.0 9006.2 9007.7 42666.0 42948.6 43109.8 43155.8 43206.8 3428.6 3963.6 3976.6 4125.6 4227.1 32735.3 32848.5 33081.0 33251.0 33753.3 4447.8 4494.5 4498.5 4514.8 4645.0 327075.0 327385.0 327525.0 327688.0 328020.0 59759.7 59870.7 60318.0 60333.0 60351.7 35473.8 36468.0 36485.0 38459.2 64187.7 17147.9 17192.2 17217.2 17301.5 17307.5 11930.3 12028.6 12043.2 12048.1 12065.4 19678.0 19924.0 19966.3 19971.6 20020.8 6859.9 6938.8 6961.2 7098.9 7352.0 952.8 971.9 1021.7 1124.9 1126.7 32192.8 32953.3 33055.0 33090.7 33564.5 1108.2 1111.1 1122.6 1154.3 1172.5 16691.5 17232.7 17352.5 17402.3 17669.5 479136.0 483188.0 487515.0 489079.0 489735.0 61411.0 61918.4 62073.7 62129.7 62309.7 1224.1 1290.3 1341.3 1374.9 1382.4 31148.2 35328.1 35446.3 35463.3 35735.8 51675.5 52176.2 52397.0 52466.7 52493.5 395021.0 399127.0 399388.0 400022.0 400032.0 28700.4 29390.9 29517.4 29655.0 29655.9 50290.0 50356.7 50361.5 51896.2 52090.7 42160.2 42464.6 42474.0 43460.3 43482.3 41314.0 41933.8 42156.8 42500.6 42977.4 41436.2 42177.0 42427.8 43127.6 43265.6 36636.5 37990.4 38016.6 38759.4 39062.4 28609.3 28612.3 28785.1 28844.0 29128.7 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#2] jquery.html Cycles:180 Average:27118.01 Median:2391.75 stddev:76940.86 (3216.9%) stddev-sans-first:77130.50 08:31:42 INFO - PROCESS | 19058 | Values: 372.9 377.8 382.2 387.5 401.7 14998.1 16318.7 17939.0 19114.2 19655.8 16684.5 18065.6 18841.4 18874.6 18978.5 5540.6 5762.8 5787.6 5811.3 5816.0 3737.2 5248.4 5362.5 5642.4 5669.1 5660.7 5729.4 5731.6 5734.8 5752.3 5658.4 5723.3 5723.9 5736.7 5742.4 5514.5 5525.3 5539.1 5542.3 5544.9 20247.4 21492.5 21679.2 22327.8 22518.8 2065.0 2136.3 2166.6 2453.6 2492.4 9055.9 9269.6 9329.9 9649.2 11648.8 1763.9 1776.6 1786.2 1846.3 1907.0 51479.2 62460.0 78061.0 78412.6 79059.0 10015.9 10309.0 10376.0 10620.6 10914.9 14069.0 14076.9 14080.0 14134.8 14174.5 7384.9 7415.8 7423.7 7527.2 7555.1 6903.8 7010.3 7082.3 7110.8 7126.7 4349.6 4394.8 4460.0 4536.9 4568.8 1692.5 1764.2 1774.7 1811.3 1815.9 425.3 427.5 433.9 926.5 1050.8 11072.9 11106.5 11159.8 11165.2 11505.0 443.6 446.5 446.8 454.9 468.8 5782.9 6025.4 6050.2 6124.8 6171.8 459796.0 462689.0 464324.0 464944.0 475521.0 92883.1 95702.5 96622.5 96835.0 97229.5 450.3 451.1 452.4 455.6 457.2 10312.0 10319.6 10341.9 10428.2 10436.8 37253.4 38631.4 39459.6 39821.0 41438.4 46473.3 56536.4 57042.7 57220.4 57298.7 8206.9 8247.5 8269.8 8499.1 8515.6 12255.3 13284.1 13287.1 13386.3 13464.5 11762.1 11805.6 11848.1 11878.2 11994.9 11261.2 11385.1 11557.1 11857.7 11896.6 11608.7 11757.5 11868.6 11914.9 12201.0 8066.8 8203.8 8208.8 8253.1 8312.6 10674.4 11633.2 11903.8 12124.2 12136.1 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#3] mootools.html Cycles:180 Average:5671.64 Median:4959.44 stddev:3260.65 (65.7%) stddev-sans-first:3253.40 08:31:42 INFO - PROCESS | 19058 | Values: 1320.7 1437.2 1488.5 1601.2 1746.9 8002.8 8292.5 8325.1 8573.6 8585.7 8329.7 8454.7 8515.5 8517.4 8523.9 1982.3 2168.4 2187.2 2225.8 2227.0 2249.1 2262.5 2263.7 2264.9 2267.0 2168.1 2187.9 2190.3 2205.2 2211.7 1919.3 2130.8 2131.1 2184.4 2187.5 2148.8 2156.1 2159.6 2178.6 2179.2 8606.2 8706.4 8729.7 8758.0 8778.2 4826.0 4983.9 4987.6 4990.2 4994.4 3107.5 3130.7 3170.0 3197.2 3203.4 1004.4 1011.1 1025.9 1033.4 1035.4 11511.4 11573.2 11662.4 11682.4 11725.2 4296.7 4297.3 4421.0 4427.2 4437.4 9763.5 9776.4 9782.8 9790.1 9808.5 4952.1 4982.5 4991.8 4992.4 5003.4 4175.1 4445.8 4589.2 4617.9 4674.3 3668.7 3757.2 3783.9 3822.9 3865.5 1117.4 1118.8 1129.8 1132.2 1156.1 891.6 939.7 957.9 966.7 967.4 5504.0 5505.3 5618.7 5635.6 6072.6 914.2 924.1 957.7 985.8 1006.6 4163.4 4242.2 4246.2 4282.9 4298.8 10644.5 11006.9 11015.3 11020.2 11022.7 10772.6 10864.3 10897.6 10909.9 10912.1 8000.6 8160.2 8328.2 8330.3 8333.2 6159.9 6176.3 6214.1 6215.5 6233.5 9911.8 9922.0 10034.6 10063.3 10070.7 9737.1 10362.9 10409.0 10423.8 10450.2 6703.9 7091.5 7280.0 7353.0 7516.5 8513.9 8573.9 8619.6 8621.5 8640.0 7524.5 7651.1 7757.3 7889.1 7950.7 7434.1 7464.6 7501.3 7559.5 7650.5 6939.7 7020.4 7021.7 7029.2 7042.4 4949.3 4966.8 5073.6 5166.8 5176.4 5312.7 5366.4 5422.8 5498.1 5563.6 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#4] prototype.html Cycles:180 Average:4650.03 Median:5368.06 stddev:1359.18 (25.3%) stddev-sans-first:1323.46 08:31:42 INFO - PROCESS | 19058 | Values: 314.1 314.3 315.1 318.6 320.0 5361.5 5378.8 5395.2 5402.0 5420.1 5293.7 5294.3 5374.6 5381.2 5390.0 3967.7 4005.7 4102.9 4127.1 4151.2 4084.4 4100.4 4103.0 4123.7 4129.8 3952.9 4120.0 4134.2 4142.9 4150.6 4006.0 4055.5 4072.2 4080.3 4088.7 3615.6 3616.4 3623.2 3630.6 3635.5 5136.0 5159.0 5179.9 5218.5 5233.7 4552.5 4703.8 4709.6 4714.2 4729.6 5480.4 5496.2 5504.5 5510.3 5516.6 4002.5 4008.6 4011.3 4016.4 4037.8 5566.7 5712.7 5729.0 5735.5 5736.3 4064.0 4077.2 4093.5 4095.6 4101.9 4130.8 4154.7 4155.3 4178.4 4181.0 4595.8 4648.1 4681.2 4714.4 4766.2 5483.0 5491.2 5499.6 5501.6 5509.2 1425.3 1425.9 1433.0 1437.7 1439.6 863.2 937.2 945.5 960.4 967.9 5215.5 5239.5 5274.8 5348.1 5353.7 5634.5 5640.9 5645.4 5649.7 5650.9 5111.0 5270.8 5291.5 5298.4 5309.7 2977.4 3010.7 3025.7 3027.0 3033.7 5661.5 5836.2 5859.0 5860.3 5868.2 5564.7 5739.3 5744.9 5751.3 5773.7 5752.9 5774.9 5786.3 5825.6 5835.1 5407.4 5513.8 5522.6 5563.0 5591.2 5535.4 5536.4 5546.8 5548.4 5581.7 5779.5 5793.1 5829.3 5833.2 5840.1 3949.9 4060.2 4065.3 4080.8 4081.8 5551.6 5566.1 5586.6 5589.6 5613.8 5337.0 5351.9 5487.7 5516.5 5563.9 5534.4 5536.5 5549.9 5550.9 5556.0 5251.6 5452.4 5470.6 5476.8 5495.3 5556.7 5572.6 5584.0 5592.6 5614.6 5440.0 5447.2 5452.6 5459.3 5490.2 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - PROCESS | 19058 | [#5] yui.html Cycles:180 Average:20528.96 Median:4477.58 stddev:29090.61 (649.7%) stddev-sans-first:29134.33 08:31:42 INFO - PROCESS | 19058 | Values: 757.8 775.5 787.3 790.0 827.2 14845.0 15651.2 15681.0 15877.8 15891.5 14158.9 15110.9 15320.6 15445.7 15502.8 656.5 770.5 788.2 799.6 799.8 802.3 815.3 816.9 817.4 818.1 845.5 848.3 848.7 848.9 848.9 682.3 817.4 834.1 840.0 843.8 620.6 620.9 621.1 621.2 622.1 14832.4 14840.0 14873.8 14884.9 14897.9 13588.9 13669.2 13911.4 14048.4 14074.2 12694.4 12720.0 12754.3 12857.2 12887.5 4459.2 4483.6 4492.9 4541.6 4583.7 71778.0 71886.9 71898.0 71907.0 71931.3 11070.2 11267.9 11305.4 11449.3 11752.7 19829.7 19837.7 19907.9 19937.5 20000.5 8306.1 8337.9 8466.4 8467.7 8808.3 4353.3 4495.3 4649.8 4707.2 4865.0 3172.7 3245.5 3273.8 3274.1 3290.4 564.3 576.2 578.1 578.6 579.6 548.5 645.8 657.1 681.1 686.2 8715.8 9429.0 9638.3 9692.9 9721.8 549.6 634.7 637.5 655.4 683.8 4251.4 4269.1 4309.4 4471.6 4506.1 110427.0 112002.0 112356.0 113355.4 114758.0 85031.6 86281.0 86643.0 93968.0 97589.5 66349.0 92421.1 92500.5 92872.5 95682.5 10092.4 10408.6 10451.5 10612.8 10678.6 53871.7 54070.0 54085.5 54189.7 56307.7 50731.5 69649.0 76124.2 82340.0 86384.6 13225.2 13389.7 13530.5 13884.7 14008.9 15101.5 15175.8 15440.9 15892.0 16000.1 14396.0 14528.5 14683.0 14747.6 14969.5 12845.8 12926.4 13249.7 13253.5 13267.3 13529.4 13757.8 13983.7 14004.2 14104.4 11385.2 11394.4 11695.3 11757.2 11960.2 11294.9 11597.9 11771.9 11831.0 11891.3 08:31:42 INFO - PROCESS | 19058 | -------- Summary: end -------- 08:31:42 INFO - PROCESS | 19058 | 08:31:42 INFO - TEST-INFO | 19058: exit 0 08:31:42 INFO - TEST-OK | dromaeo_css | took 1113939ms 08:31:42 INFO - TEST-START | kraken 08:31:42 INFO - operating with platform_type : linux_ 08:31:42 INFO - Initialising browser for kraken test... 08:31:42 INFO - TEST-INFO | started process 19246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOG6OPG/profile http://localhost:55108/getInfo.html) 08:31:46 INFO - PROCESS | 19246 | __metrics Screen width/height:1600/1200 08:31:46 INFO - PROCESS | 19246 | colorDepth:24 08:31:46 INFO - PROCESS | 19246 | Browser inner width/height: 1024/697 08:31:46 INFO - PROCESS | 19246 | __metrics 08:31:47 INFO - PROCESS | 19246 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:48 INFO - PROCESS | 19246 | console.error: PushService: 08:31:48 INFO - PROCESS | 19246 | stateChangeProcessEnqueue: Error transitioning state 08:31:48 INFO - PROCESS | 19246 | UnknownError 08:31:48 INFO - TEST-INFO | 19246: exit 0 08:31:48 INFO - Browser initialized. 08:31:48 INFO - Running cycle 1/1 for kraken test... 08:31:48 INFO - TEST-INFO | started process 19329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOG6OPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:00 INFO - PROCESS | 19329 | RSS: Main: 174338048 08:32:00 INFO - PROCESS | 19329 | 08:32:03 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55108/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:04 INFO - PROCESS | 19329 | RSS: Main: 233267200 08:32:04 INFO - PROCESS | 19329 | 08:32:06 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55108/tests/kraken/driver.html?testName=audio-dft) 08:32:07 INFO - PROCESS | 19329 | RSS: Main: 221581312 08:32:07 INFO - PROCESS | 19329 | 08:32:10 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55108/tests/kraken/driver.html?testName=audio-fft) 08:32:11 INFO - PROCESS | 19329 | RSS: Main: 286994432 08:32:11 INFO - PROCESS | 19329 | 08:32:13 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55108/tests/kraken/driver.html?testName=audio-oscillator) 08:32:13 INFO - PROCESS | 19329 | RSS: Main: 197066752 08:32:13 INFO - PROCESS | 19329 | 08:32:16 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:16 INFO - PROCESS | 19329 | RSS: Main: 201863168 08:32:16 INFO - PROCESS | 19329 | 08:32:19 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55108/tests/kraken/driver.html?testName=imaging-darkroom) 08:32:20 INFO - PROCESS | 19329 | RSS: Main: 237584384 08:32:20 INFO - PROCESS | 19329 | 08:32:23 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55108/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:24 INFO - PROCESS | 19329 | RSS: Main: 238198784 08:32:24 INFO - PROCESS | 19329 | 08:32:27 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55108/tests/kraken/driver.html?testName=json-parse-financial) 08:32:27 INFO - PROCESS | 19329 | RSS: Main: 238133248 08:32:27 INFO - PROCESS | 19329 | 08:32:29 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:30 INFO - PROCESS | 19329 | RSS: Main: 225767424 08:32:30 INFO - PROCESS | 19329 | 08:32:31 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:32 INFO - PROCESS | 19329 | RSS: Main: 228732928 08:32:32 INFO - PROCESS | 19329 | 08:32:34 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:35 INFO - PROCESS | 19329 | RSS: Main: 238133248 08:32:35 INFO - PROCESS | 19329 | 08:32:37 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:38 INFO - PROCESS | 19329 | RSS: Main: 239915008 08:32:38 INFO - PROCESS | 19329 | 08:32:41 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:41 INFO - PROCESS | 19329 | RSS: Main: 240316416 08:32:41 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | Cycle 1(1): loaded http://localhost:55108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55108/tests/kraken/driver.html?testName=ai-astar) 08:32:43 INFO - PROCESS | 19329 | RSS: Main: 283459584 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | __start_tp_report 08:32:43 INFO - PROCESS | 19329 | _x_x_mozilla_page_load 08:32:43 INFO - PROCESS | 19329 | _x_x_mozilla_page_load_details 08:32:43 INFO - PROCESS | 19329 | |i|pagename|runs| 08:32:43 INFO - PROCESS | 19329 | |0;ai-astar;112;104;110;112;108;110;109;109;111;109 08:32:43 INFO - PROCESS | 19329 | |1;audio-beat-detection;151;129;133;176;137;128;152;125;157;133 08:32:43 INFO - PROCESS | 19329 | |2;audio-dft;160;159;160;159;159;161;162;162;160;161 08:32:43 INFO - PROCESS | 19329 | |3;audio-fft;83;75;75;122;76;77;72;75;101;73 08:32:43 INFO - PROCESS | 19329 | |4;audio-oscillator;85;86;114;85;85;86;116;86;85;127 08:32:43 INFO - PROCESS | 19329 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;116;117;116 08:32:43 INFO - PROCESS | 19329 | |6;imaging-darkroom;146;145;146;146;147;146;145;146;147;146 08:32:43 INFO - PROCESS | 19329 | |7;imaging-desaturate;95;95;95;95;95;95;96;97;94;95 08:32:43 INFO - PROCESS | 19329 | |8;json-parse-financial;54;54;53;56;55;54;56;54;55;55 08:32:43 INFO - PROCESS | 19329 | |9;json-stringify-tinderbox;63;63;64;62;63;62;63;63;63;64 08:32:43 INFO - PROCESS | 19329 | |10;stanford-crypto-aes;80;79;79;80;81;82;86;86;111;85 08:32:43 INFO - PROCESS | 19329 | |11;stanford-crypto-ccm;138;132;127;128;131;122;129;125;150;130 08:32:43 INFO - PROCESS | 19329 | |12;stanford-crypto-pbkdf2;162;166;162;170;167;159;159;159;165;160 08:32:43 INFO - PROCESS | 19329 | |13;stanford-crypto-sha256-iterative;64;62;64;64;63;63;64;61;61;61 08:32:43 INFO - PROCESS | 19329 | __end_tp_report 08:32:43 INFO - PROCESS | 19329 | __start_cc_report 08:32:43 INFO - PROCESS | 19329 | _x_x_mozilla_cycle_collect,1642 08:32:43 INFO - PROCESS | 19329 | __end_cc_report 08:32:43 INFO - PROCESS | 19329 | __startTimestamp1466004763648__endTimestamp 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | ------- Summary: start ------- 08:32:43 INFO - PROCESS | 19329 | Number of tests: 14 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.32 (2.1%) stddev-sans-first:2.26 08:32:43 INFO - PROCESS | 19329 | Values: 112.0 104.0 110.0 112.0 108.0 110.0 109.0 109.0 111.0 109.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:144.00 stddev:16.34 (11.3%) stddev-sans-first:17.01 08:32:43 INFO - PROCESS | 19329 | Values: 151.0 129.0 133.0 176.0 137.0 128.0 152.0 125.0 157.0 133.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 08:32:43 INFO - PROCESS | 19329 | Values: 160.0 159.0 160.0 159.0 159.0 161.0 162.0 162.0 160.0 161.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:16.13 (21.5%) stddev-sans-first:17.11 08:32:43 INFO - PROCESS | 19329 | Values: 83.0 75.0 75.0 122.0 76.0 77.0 72.0 75.0 101.0 73.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.55 (19.5%) stddev-sans-first:17.12 08:32:43 INFO - PROCESS | 19329 | Values: 85.0 86.0 114.0 85.0 85.0 86.0 116.0 86.0 85.0 127.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:32:43 INFO - PROCESS | 19329 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:32:43 INFO - PROCESS | 19329 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 08:32:43 INFO - PROCESS | 19329 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 97.0 94.0 95.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 08:32:43 INFO - PROCESS | 19329 | Values: 54.0 54.0 53.0 56.0 55.0 54.0 56.0 54.0 55.0 55.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 08:32:43 INFO - PROCESS | 19329 | Values: 63.0 63.0 64.0 62.0 63.0 62.0 63.0 63.0 63.0 64.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:81.50 stddev:9.57 (11.7%) stddev-sans-first:9.99 08:32:43 INFO - PROCESS | 19329 | Values: 80.0 79.0 79.0 80.0 81.0 82.0 86.0 86.0 111.0 85.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.50 stddev:7.87 (6.0%) stddev-sans-first:7.95 08:32:43 INFO - PROCESS | 19329 | Values: 138.0 132.0 127.0 128.0 131.0 122.0 129.0 125.0 150.0 130.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:3.90 (2.4%) stddev-sans-first:4.12 08:32:43 INFO - PROCESS | 19329 | Values: 162.0 166.0 162.0 170.0 167.0 159.0 159.0 159.0 165.0 160.0 08:32:43 INFO - PROCESS | 19329 | 08:32:43 INFO - PROCESS | 19329 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.50 stddev:1.34 (2.1%) stddev-sans-first:1.33 08:32:43 INFO - PROCESS | 19329 | Values: 64.0 62.0 64.0 64.0 63.0 63.0 64.0 61.0 61.0 61.0 08:32:43 INFO - PROCESS | 19329 | -------- Summary: end -------- 08:32:43 INFO - PROCESS | 19329 | 08:32:44 INFO - TEST-INFO | 19329: exit 0 08:32:44 INFO - TEST-OK | kraken | took 61812ms 08:32:44 INFO - SUITE-END | took 1175s 08:32:44 INFO - Completed test suite (00:19:35) 08:32:44 INFO - javascript benchmark 08:32:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.0688140117254, 3075.246564591675, 3090.3510262844793, 3119.298157914468, 3134.3417882244726, 5213.400458947222, 5261.579073674106, 5266.131088370424, 5371.57027437805, 5383.219433182187, 5273.604479664022, 5274.235235890794, 5282.683039017652, 5301.7084060376765, 5354.598405119622, 4727.149113159629, 4835.661503694742, 4848.17581011229, 4849.7817598207985, 5044.066847633181, 4946.356973593428, 4966.255061740731, 4966.801327946878, 5014.548690617844, 5046.217836235371, 4737.147313483571, 4786.497417771118, 4790.664653474259, 4815.181419158752, 4816.422029356482, 4772.117158325721, 4795.880102997453, 4868.805247790084, 4886.731229782396, 4915.090708218991, 4652.674312798105, 4830.3237546743485, 4859.41686997559, 4869.8782530436665, 4900.485449027872, 5273.920891186635, 5335.759890804884, 5354.196870469422, 5442.482964118442, 5448.182772584105, 5717.685527295997, 5747.540196784247, 5754.769809207627, 5778.24882765242, 5784.855378615526, 5609.1305847593685, 5629.493345598916, 5821.67980761058, 5839.270091238595, 5845.678487683176, 5280.867978300574, 5342.198670199501, 5384.273123128328, 5387.084195686703, 5387.515123638891, 5854.063349864001, 5877.118432235199, 5880.7353669085, 5883.264591926009, 5890.1164825276555, 5443.319585051869, 5457.126859702428, 5482.91775623366, 5661.971690141523, 5667.1499275108235, 5627.493525582717, 5630.183623374588, 5650.886982260332, 5668.744906479218, 5675.3757086720425, 5592.384837667853, 5607.355154157242, 5610.943890561124, 5611.214429979725, 5618.4662457066515, 5478.260434841325, 5597.8600534986135, 5611.859703507445, 5661.745221465044, 5688.601797874109, 4363.127374525107, 4382.627476664456, 4391.802368893407, 4391.956080439155, 4429.379886815848, 3930.783806890591, 3949.5260568731937, 3952.1898010907694, 3985.20295940813, 3995.7402768819934, 5227.372715274191, 5230.764615592308, 5322.494363035506, 5370.355557333067, 5374.731263436813, 5729.713514324267, 5742.109972954198, 5744.971275143597, 5745.454181852718, 5794.971025144847, 5385.703786291713, 5393.217983392465, 5393.6763794172475, 5396.757145928443, 5397.676139431646, 4830.275458681226, 4899.461059283476, 4927.285543596158, 4950.8267210647455, 4953.380827396575, 5943.435373639497, 5950.137230101611, 5954.3152537458745, 5960.940390596039, 5962.761489540369, 5556.472135147154, 5722.313322401338, 5735.913961290667, 5736.282964629421, 5738.454846789548, 5773.22061521706, 5794.246747922912, 5806.5645076618575, 5844.649321040752, 5845.736941837713, 5544.500994910316, 5547.140193270049, 5551.833444996657, 5552.500274975271, 5567.582431317748, 5509.752061157177, 5611.80358687444, 5702.0, 5706.771729130788, 5711.714414279352, 5565.916511252415, 5592.049351610155, 5598.440155984369, 5609.074502707008, 5642.830715078554, 5502.614816962774, 5530.723463826712, 5542.944570554404, 5549.694766787704, 5551.139573366135, 5317.202419637086, 5354.464553544614, 5385.946140538701, 5476.288082549243, 5540.556755459473, 5587.776488940397, 5594.049011668108, 5594.552435805044, 5598.0, 5608.943910560843, 5414.756335964812, 5419.756110975094, 5420.322459692538, 5422.674639521641, 5424.620276580759], "value": 5248.24982903791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.3659629302207, 612.6967151260127, 638.1448858529573, 639.96800159992, 642.6369101457676, 31953.52069718953, 35669.10827229314, 35706.46440303398, 35728.82135589318, 41771.37342939858, 40923.18153636925, 46067.769661151644, 46077.769611151896, 46122.07755844881, 46199.0, 8808.0, 9065.59204835784, 9066.320025998044, 9066.727998160033, 9072.31957603179, 8763.824723505526, 8848.955755221215, 8858.202761751441, 8859.379843410963, 8860.6012729427, 8884.822303553925, 8907.242884354837, 8910.376273660846, 8917.019127895926, 8919.0, 8887.466751994869, 8889.022207557164, 8911.0, 8930.062343453974, 8940.642374305053, 8891.822163556693, 8998.640054397816, 9003.0, 9006.1894429501, 9007.729768106967, 42666.0, 42948.57051429508, 43109.78445107755, 43155.784221079004, 43206.783966080286, 3428.6057103433177, 3963.583823698499, 3976.622220889011, 4125.566815484361, 4227.112306415656, 32735.345293094004, 32848.50727239093, 33081.0, 33251.0, 33753.32493350144, 4447.799849006802, 4494.4606647202545, 4498.457828203549, 4514.774261286922, 4645.047765208158, 327075.0, 327384.9999999976, 327524.9999999976, 327688.0, 328020.0, 59759.70120149371, 59870.70064649649, 60318.0, 60333.0, 60351.698241508515, 35473.82263088668, 36468.0, 36485.0, 38459.23081538353, 64187.679061604395, 17147.914260428617, 17192.22634981429, 17217.225224864913, 17301.480955571355, 17307.480775576754, 11930.343831089373, 12028.63914082579, 12043.15697901156, 12048.096392770578, 12065.396730163457, 19678.0, 19924.0, 19966.30117945865, 19971.60056798885, 20020.799792001893, 6859.897101543481, 6938.757143499954, 6961.199462061826, 7098.858022839514, 7352.014955961968, 952.842780941137, 971.9416834989923, 1021.6616232734992, 1124.9268797528298, 1126.6845283320683, 32192.83903580514, 32953.3409331812, 33055.0, 33090.66909330924, 33564.49653255203, 1108.2408550143016, 1111.0778054215143, 1122.6239209864787, 1154.2670404293167, 1172.513406936129, 16691.49925502237, 17232.655346892992, 17352.479425617, 17402.303907843798, 17669.469915902544, 479136.0, 483188.0, 487515.0, 489079.0, 489735.0, 61411.0, 61918.38081619216, 62073.689631551555, 62129.68935155295, 62309.68845155745, 1224.12475080318, 1290.3096843188848, 1341.349445518942, 1374.9344258199776, 1382.4470211915313, 31148.22129446782, 35328.11679708028, 35446.29107417889, 35463.290734185684, 35735.82132089323, 51675.483245167066, 52176.21735673892, 52397.0, 52466.73766631143, 52493.47506524886, 395021.0, 399127.0, 399388.0, 400022.0, 400032.0, 28700.352060296358, 29390.85304573549, 29517.409651807273, 29655.0, 29655.85172074126, 50290.0, 50356.74821625868, 50361.49638503568, 51896.221556675926, 52090.73954630354, 42160.1567968645, 42464.57535424606, 42474.0, 43460.348094779234, 43482.34776478419, 41314.0, 41933.79033104937, 42156.78921605372, 42500.57499424966, 42977.3553396693, 41436.1712765749, 42177.0, 42427.7878610605, 43127.568724312354, 43265.567344326155, 36636.45045324269, 37990.43014354732, 38016.619833801306, 38759.418608721455, 39062.4140637885, 28609.28476788097, 28612.284692882844, 28785.136445906657, 28844.0, 29128.7087129126], "value": 20128.291079973857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8676319906435, 377.8431207263315, 382.16496954155156, 387.54850599052105, 401.66862338570684, 14998.100113993141, 16318.673626527463, 17939.0, 19114.235430582776, 19655.803441965578, 16684.499465016037, 18065.63868722628, 18841.43475695728, 18874.62250754984, 18978.525536861587, 5540.612157148991, 5762.82711518653, 5787.594868359217, 5811.302643682764, 5816.0, 3737.2338670572603, 5248.42267350593, 5362.544183744387, 5642.379338272786, 5669.09294512878, 5660.660360378391, 5729.398413166599, 5731.570132240078, 5734.827955161351, 5752.309722833266, 5658.405867383927, 5723.255976723041, 5723.914141287884, 5736.741846616891, 5742.397048309909, 5514.503694667499, 5525.254090697785, 5539.058360078796, 5542.279503664538, 5544.889102217933, 20247.392578222676, 21492.462688432915, 21679.24122655715, 22327.77672223273, 22518.77481225183, 2064.9793502064936, 2136.2629892686996, 2166.555856049506, 2453.6196889482158, 2492.4018235623503, 9055.909440905572, 9269.582868770922, 9329.860052099157, 9649.179819715333, 11648.767024659459, 1763.8765286429955, 1776.600264940391, 1786.222992998037, 1846.2522678315304, 1906.9713954290696, 51479.22781158286, 62460.0, 78061.0, 78412.60793695995, 79059.0, 10015.949920250352, 10308.989746999414, 10376.0, 10620.575176992988, 10914.945425272981, 14069.0, 14076.859231407554, 14080.014398991972, 14134.787978180335, 14174.503892363924, 7384.889226661604, 7415.8146046349275, 7423.703051877865, 7527.209642987407, 7555.055618047744, 6903.827404314932, 7010.334018268256, 7082.256363081905, 7110.822229444202, 7126.714931402789, 4349.608535231781, 4394.8242070317465, 4459.955400446019, 4536.886577835515, 4568.794404251817, 1692.5007122898774, 1764.2149243586737, 1774.7160454327245, 1811.2845426056633, 1815.9273629054953, 425.2600475173176, 427.48061105756034, 433.9002029533162, 926.5043201886958, 1050.8318669012922, 11072.889271107348, 11106.50020749052, 11159.832602510969, 11165.162612804072, 11505.0, 443.63843467573827, 446.4709319456455, 446.8168051099034, 454.9226631472658, 468.75624675169405, 5782.855428614318, 6025.427584379477, 6050.152978583002, 6124.785632502841, 6171.814845554641, 459796.0, 462689.0, 464324.0, 464944.0, 475521.0, 92883.07116928745, 95702.52148739212, 96622.51688741652, 96835.0, 97229.5138524317, 450.34474839109015, 451.109059607273, 452.35313501692235, 455.5922449407828, 457.22956817761514, 10312.027203139638, 10319.638812641522, 10341.9482902585, 10428.165746740395, 10436.791264174826, 37253.441198382585, 38631.42052869153, 39459.60540394559, 39821.0, 41438.37842432426, 46473.302900457194, 56536.43463565312, 57042.7147864258, 57220.42779572151, 57298.7135064322, 8206.917930820855, 8247.505149690798, 8269.83460330802, 8499.107593702573, 8515.616797244264, 12255.32595707209, 13284.136531125447, 13287.06990510655, 13386.330683465592, 13464.528741494001, 11762.117841161777, 11805.645830625095, 11848.111391645489, 11878.168528203289, 11994.880051199376, 11261.155413343868, 11385.146114041314, 11557.133215009077, 11857.703557410789, 11896.643100706646, 11608.6517404478, 11757.529698811952, 11868.58459953932, 11914.940425297818, 12201.0, 8066.7579972600915, 8203.79490512718, 8208.794780130305, 8253.050899146676, 8312.584370781316, 10674.35953842772, 11633.243839150427, 11903.82144267854, 12124.181372793799, 12136.089793265364], "value": 8038.173294147486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.716046050099, 1437.1520802726388, 1488.4641529049543, 1601.2314089237166, 1746.8602511799058, 8002.759917202478, 8292.502449853006, 8325.125861784509, 8573.614187361569, 8585.742427727178, 8329.66681332746, 8454.661813527468, 8515.489070655765, 8517.403781735282, 8523.872141917876, 1982.3260091568864, 2168.392850002002, 2187.2454003368853, 2225.810806081477, 2226.9888650556722, 2249.089118906845, 2262.536180083079, 2263.7057182566246, 2264.920727774528, 2267.036509483471, 2168.121910626191, 2187.9343619691435, 2190.3428971308545, 2205.151016858505, 2211.7456492503325, 1919.3378284491828, 2130.8401869859745, 2131.1049359269145, 2184.432047667618, 2187.5406164705273, 2148.828093752496, 2156.051337411534, 2159.6436587962967, 2178.575177840322, 2179.182806447582, 8606.182412670787, 8706.434081784664, 8729.694460693845, 8758.0, 8778.166074223003, 4826.0, 4983.900321993576, 4987.600991920638, 4990.176620857555, 4994.400671919393, 3107.5338699195077, 3130.7182353588287, 3169.9841500792577, 3197.1527545200543, 3203.4073696366245, 1004.3622299839582, 1011.0647650922867, 1025.8512515685259, 1033.41095575522, 1035.3735989726258, 11511.36687482188, 11573.18987670855, 11662.358570278631, 11682.41587920609, 11725.237859539102, 4296.656267498593, 4297.333913243452, 4421.005273813366, 4427.22523558376, 4437.356583295404, 9763.463009534544, 9776.413415195111, 9782.75543111428, 9790.118889299998, 9808.460534670661, 4952.133376659142, 4982.451930287665, 4991.825286114969, 4992.350994370709, 5003.399592048978, 4175.144095460423, 4445.755483448376, 4589.151007063704, 4617.930731039037, 4674.252119660838, 3668.724845636588, 3757.1546402059316, 3783.8675646352244, 3822.9044273893373, 3865.536135663682, 1117.4468638024068, 1118.8209886418297, 1129.76274982253, 1132.1791701016862, 1156.0982433701727, 891.5675897189858, 939.727479031087, 957.9042095790504, 966.7003228999033, 967.4002118686459, 5503.981763373788, 5505.256790333334, 5618.747156377973, 5635.5773317001385, 6072.605280656743, 914.1863741270275, 924.075924075924, 957.7414098193589, 985.7979114281555, 1006.6476733143488, 4163.39630753539, 4242.193983143193, 4246.171996460661, 4282.8715138545895, 4298.806553705028, 10644.467776611138, 11006.944965275123, 11015.339079655247, 11020.228583999044, 11022.669319920415, 10772.622958196425, 10864.34813911152, 10897.564097436172, 10909.945450272857, 10912.072473839813, 8000.6399712011935, 8160.224778646019, 8328.167183281623, 8330.333573314121, 8333.16668333174, 6159.876802464015, 6176.258848938156, 6214.130021796862, 6215.471684906653, 6233.470155036873, 9911.752206194902, 9922.0, 10034.598616055277, 10063.295569310078, 10070.748231294276, 9737.123658870736, 10362.896371036495, 10409.0, 10423.791524169626, 10450.16398688088, 6703.865922681422, 7091.539049961736, 7280.0, 7353.0, 7516.5114267572435, 8513.91486085156, 8573.914260857311, 8619.569021549023, 8621.482711037357, 8640.0, 7524.51090679126, 7651.081870175614, 7757.263060009516, 7889.0927543333255, 7950.7217247396065, 7434.107907051189, 7464.552126872405, 7501.324880760758, 7559.470837041575, 7650.540967541965, 6939.653017349214, 7020.403265722471, 7021.68402421882, 7029.156501219886, 7042.43660507148, 4949.331840201527, 4966.751662416792, 5073.594112471067, 5166.844994650167, 5176.352955880515, 5312.681239125664, 5366.356037275552, 5422.810201642924, 5498.147787093007, 5563.582731295088], "value": 4501.491094048527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.05939212059883, 314.28813736885957, 315.0501238765124, 318.59697482684425, 320.03349883352274, 5361.525580465369, 5378.757955891984, 5395.190721391793, 5402.0, 5420.105682562373, 5293.68237905725, 5294.338207724035, 5374.596905232103, 5381.165919282507, 5390.032638087099, 3967.662748666367, 4005.7381924693773, 4102.856400025999, 4127.133302006582, 4151.169766046788, 4084.4281800547947, 4100.405441211023, 4103.0, 4123.670106391482, 4129.752214867102, 3952.901177470572, 4119.979400102995, 4134.173165366924, 4142.917141657165, 4150.584941505856, 4005.9599404006026, 4055.472788537501, 4072.1855628874346, 4080.2655522006025, 4088.672906167514, 3615.6384361563632, 3616.367135751233, 3623.221007483404, 3630.6369363063745, 3635.5273814404222, 5136.0, 5159.0, 5179.870503237412, 5218.478152184789, 5233.712145831978, 4552.499225085238, 4703.847557348471, 4709.62323014158, 4714.151452738506, 4729.645276604234, 5480.424555421663, 5496.230527726121, 5504.4770746778995, 5510.283663123809, 5516.593268716491, 4002.4590532645143, 4008.5590585035625, 4011.292377645078, 4016.357382818764, 4037.8290295814177, 5566.666000040011, 5712.742926568314, 5728.971355143198, 5735.512481439083, 5736.311642602873, 4064.0, 4077.16527562598, 4093.5292441369625, 4095.6313931746286, 4101.933497290726, 4130.760771768458, 4154.709170358106, 4155.252054630135, 4178.373244013423, 4181.017460896687, 4595.839145629954, 4648.140094082605, 4681.227597446451, 4714.4342678878065, 4766.213574760126, 5482.972585137049, 5491.176323551419, 5499.587530935196, 5501.587380946445, 5509.173623956359, 1425.2731107135435, 1425.8930580206527, 1433.0112222566395, 1437.6549628089183, 1439.5820117184564, 863.179979019921, 937.2033771294346, 945.4894357047255, 960.4045491794992, 967.9128878400978, 5215.5486921147, 5239.528442440199, 5274.841754747364, 5348.064088784447, 5353.732313384316, 5634.52106570946, 5640.858978525488, 5645.379008309083, 5649.700568869101, 5650.943490565041, 5111.032252582782, 5270.8155214567305, 5291.497307755757, 5298.443663415363, 5309.681419114865, 2977.449171903205, 3010.6537748159244, 3025.714071519639, 3026.9848650756603, 3033.6511301200203, 5661.493561554686, 5836.2412886325355, 5858.970705146447, 5860.267466566679, 5868.178455016301, 5564.693941833157, 5739.253896993364, 5744.885102297931, 5751.338596061423, 5773.682447465346, 5752.9137062943255, 5774.855628609403, 5786.276715410574, 5825.621334613322, 5835.132757517554, 5407.432219617041, 5513.834584962297, 5522.5581953442825, 5563.0, 5591.21722958778, 5535.446455354432, 5536.4186760389575, 5546.75039623226, 5548.3619383769765, 5581.6930068846605, 5779.537636988946, 5793.131030345482, 5829.329627092939, 5833.154192641959, 5840.13115802939, 3949.9012524687114, 4060.2390374545594, 4065.2885744993914, 4080.7551546906093, 4081.8163182657445, 5551.611387202857, 5566.137248726453, 5586.581006424453, 5589.608727389043, 5613.775448981995, 5336.973315133399, 5351.929614077278, 5487.655524396549, 5516.531094856982, 5563.8887222256135, 5534.39121696605, 5536.501714845684, 5549.861253468695, 5550.861228469321, 5556.0, 5251.606129540376, 5452.400235974119, 5470.589705772003, 5476.835694929158, 5495.2856128703015, 5556.72216389187, 5572.582056345871, 5583.972080139573, 5592.608517403743, 5614.550835933197, 5439.972800135974, 5447.237386765777, 5452.563794896319, 5459.2629994950175, 5490.176473529003], "value": 4211.941548782712, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7840315510077, 775.4571799740183, 787.3307688464805, 790.0, 827.20175031095, 14845.0, 15651.21743912804, 15681.0, 15877.841221587809, 15891.523254302376, 14158.929205353985, 15110.924445377785, 15320.616984575392, 15445.691086178269, 15502.844971550281, 656.4682607088274, 770.4953255617579, 788.1645455816838, 799.568233154099, 799.7560743973086, 802.3420794948145, 815.3314282288526, 816.8815521749343, 817.3951276055706, 818.0633175014605, 845.530730444603, 848.3298194426427, 848.7284069097891, 848.8641817309232, 848.9023762267326, 682.2563405887581, 817.4155478832663, 834.0575150080431, 840.0171798995191, 843.843888880559, 620.6245221640887, 620.9348018458043, 621.1211136242212, 621.183144165421, 622.0824284180842, 14832.406703731838, 14840.0, 14873.776893346609, 14884.851151488454, 14897.925510372486, 13588.93205533976, 13669.179849209078, 13911.443542258297, 14048.43806247749, 14074.155550666992, 12694.42875070624, 12720.0, 12754.298513581749, 12857.164284321489, 12887.484500619965, 4459.197344477992, 4483.587669884008, 4492.887677808081, 4541.568550987651, 4583.656225783079, 71778.0, 71886.92169617407, 71898.0, 71906.99999999948, 71931.28068719298, 11070.225084244186, 11267.887321126847, 11305.434728263554, 11449.255798373079, 11752.70618234551, 19829.702554461695, 19837.702434463496, 19907.905065221552, 19937.501562460766, 20000.499987500138, 8306.127856574973, 8337.916620833714, 8466.449680770731, 8467.661293548312, 8808.339374546935, 4353.25994580922, 4495.325701144854, 4649.837255696035, 4707.223308154116, 4864.95135048645, 3172.6510083890753, 3245.513173024018, 3273.8363081845814, 3274.1159886830424, 3290.407726609233, 564.3453593831218, 576.2451188942415, 578.1212556913468, 578.6296770067161, 579.5913880714087, 548.4926443040172, 645.7642960319449, 657.0669649098292, 681.117952251835, 686.2451303566038, 8715.825683486295, 9428.95285523568, 9638.325317227867, 9692.903070969342, 9721.805563888682, 549.6344930621173, 634.7048622390611, 637.5314144104079, 655.4003087175277, 683.8392977650249, 4251.404803327537, 4269.146170765859, 4309.418228539107, 4471.577023187419, 4506.143832671782, 110427.0, 112002.0, 112356.0, 113355.43322283335, 114758.0, 85031.5748421254, 86281.0, 86643.0, 93968.0, 97589.51205244071, 66349.0, 92421.07578924125, 92500.53749731208, 92872.53563732139, 95682.52158739301, 10092.444915529422, 10408.583656653649, 10451.477426128511, 10612.787744245226, 10678.62624808128, 53871.73064134654, 54070.0, 54085.459145408044, 54189.729051354494, 56307.71846140743, 50731.49268507268, 69648.95526567004, 76124.23875761172, 82340.0, 86384.56807715922, 13225.206487610774, 13389.732205356033, 13530.526431575241, 13884.652883677989, 14008.929955350159, 15101.546953591409, 15175.772363414337, 15440.922795386401, 15892.0, 16000.119993400474, 14396.0, 14528.491502797351, 14683.0, 14747.631309216926, 14969.476068337555, 12845.807312890127, 12926.418311175832, 13249.735005300034, 13253.469861205444, 13267.270300133585, 13529.391177397238, 13757.793180314437, 13983.650408739455, 14004.229767362893, 14104.36530356157, 11385.231285793061, 11394.430278485877, 11695.298282103102, 11757.176997610086, 11960.222585531912, 11294.94352528232, 11597.883178010552, 11771.941140294244, 11831.0, 11891.28652280866], "value": 7508.5057158415175, "unit": "score"}], "name": "dromaeo_css", "value": 7031.846312143372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 110.0, 112.0, 108.0, 110.0, 109.0, 109.0, 111.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 133.0, 176.0, 137.0, 128.0, 152.0, 125.0, 157.0, 133.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 159.0, 159.0, 161.0, 162.0, 162.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 75.0, 122.0, 76.0, 77.0, 72.0, 75.0, 101.0, 73.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 114.0, 85.0, 85.0, 86.0, 116.0, 86.0, 85.0, 127.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 56.0, 55.0, 54.0, 56.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 81.0, 82.0, 86.0, 86.0, 111.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 127.0, 128.0, 131.0, 122.0, 129.0, 125.0, 150.0, 130.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 170.0, 167.0, 159.0, 159.0, 159.0, 165.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 64.0, 63.0, 63.0, 64.0, 61.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1507.2000000000003, "alertThreshold": 2.0}]} 08:32:44 INFO - Return code: 0 08:32:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:44 INFO - # TBPL SUCCESS # 08:32:44 INFO - Running post-action listener: _resource_record_post_action 08:32:44 INFO - ##### 08:32:44 INFO - ##### Finished run-tests step (success) 08:32:44 INFO - ##### 08:32:44 INFO - Running post-run listener: _resource_record_post_run 08:32:45 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 371486720; Read time: 204; Write time: 279940 08:32:45 INFO - TinderboxPrint: CPU usage
13.2% 08:32:45 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 08:32:45 INFO - TinderboxPrint: I/O write bytes / time
371,486,720 / 279,940 08:32:45 INFO - TinderboxPrint: CPU idle
8,271.8 (86.8%) 08:32:45 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 08:32:45 INFO - TinderboxPrint: Swap in / out
0 / 0 08:32:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78364672; Read time: 0; Write time: 61128 08:32:45 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293122048; Read time: 204; Write time: 218812 08:32:45 INFO - Running post-run listener: _upload_blobber_files 08:32:45 INFO - Blob upload gear active. 08:32:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:45 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 08:32:45 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'] 08:32:45 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 08:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:46 INFO - (blobuploader) - INFO - Done attempting. 08:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:50 INFO - (blobuploader) - INFO - Done attempting. 08:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:50 INFO - (blobuploader) - INFO - Done attempting. 08:32:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:50 INFO - Return code: 0 08:32:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eee7dcd22504a0a0d705a6c231b79394d0f0de6ea5a881ed28c3eae28ba7e8adef8cee14473f248f3684e639eb0514ceefd4d4ecde183854b7f06326e97fbb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fed10b585b9742c48c6ddfdf5db81a98ff2cbe820f54aeb536f352837a01f97911ecac4f7cc226c4ee6a3b2f769fa715b6b367cb5e2ce56fbf149d65d9a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793f20706b73590954c1f214914b24bc3983cacd8c5e868d6ad7cec481b4dea1135e8738f5f1aa8aaee50742a877005122f15548dcfaf00a44ca75d6ab26fe97"} 08:32:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:50 INFO - Contents: 08:32:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eee7dcd22504a0a0d705a6c231b79394d0f0de6ea5a881ed28c3eae28ba7e8adef8cee14473f248f3684e639eb0514ceefd4d4ecde183854b7f06326e97fbb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fed10b585b9742c48c6ddfdf5db81a98ff2cbe820f54aeb536f352837a01f97911ecac4f7cc226c4ee6a3b2f769fa715b6b367cb5e2ce56fbf149d65d9a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793f20706b73590954c1f214914b24bc3983cacd8c5e868d6ad7cec481b4dea1135e8738f5f1aa8aaee50742a877005122f15548dcfaf00a44ca75d6ab26fe97"} 08:32:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:50 INFO - Copying logs to upload dir... 08:32:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.609818 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-15 08:32:48.262877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:48.266721) ========= 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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 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/eee7dcd22504a0a0d705a6c231b79394d0f0de6ea5a881ed28c3eae28ba7e8adef8cee14473f248f3684e639eb0514ceefd4d4ecde183854b7f06326e97fbb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fed10b585b9742c48c6ddfdf5db81a98ff2cbe820f54aeb536f352837a01f97911ecac4f7cc226c4ee6a3b2f769fa715b6b367cb5e2ce56fbf149d65d9a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793f20706b73590954c1f214914b24bc3983cacd8c5e868d6ad7cec481b4dea1135e8738f5f1aa8aaee50742a877005122f15548dcfaf00a44ca75d6ab26fe97"} build_url:https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/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/eee7dcd22504a0a0d705a6c231b79394d0f0de6ea5a881ed28c3eae28ba7e8adef8cee14473f248f3684e639eb0514ceefd4d4ecde183854b7f06326e97fbb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fed10b585b9742c48c6ddfdf5db81a98ff2cbe820f54aeb536f352837a01f97911ecac4f7cc226c4ee6a3b2f769fa715b6b367cb5e2ce56fbf149d65d9a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793f20706b73590954c1f214914b24bc3983cacd8c5e868d6ad7cec481b4dea1135e8738f5f1aa8aaee50742a877005122f15548dcfaf00a44ca75d6ab26fe97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:48.293411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:48.294226) ========= 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=cbe409c6de289db6ac707de3000001d4-1465987343.125366-409032986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:48.376521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:32:48.376886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:32:48.377228) ========= ========= Total master_lag: 0.18 =========