builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1466004064.62 results: success (0) buildid: 20160615053002 builduid: 1af116f20aec4c3caefbf45348bbf4eb revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.621423) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.622201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.622746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.641963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.642320) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 08:21:04-- 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% 56.6M=0s 2016-06-15 08:21:05 (56.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.787372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.787699) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019403 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:04.837366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 08:21:04.837754) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 08:21:05,165 truncating revision to first 12 chars 2016-06-15 08:21:05,165 Setting DEBUG logging. 2016-06-15 08:21:05,165 attempt 1/10 2016-06-15 08:21:05,165 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:21:06,009 unpacking tar archive at: fx-team-bac29d6a5639/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 08:21:06.061171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:06.061530) ========= script_repo_revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:06.061980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:06.062367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:21:06.073223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-15 08:21:06.073674) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:06 INFO - MultiFileLogger online at 20160615 08:21:06 in /builds/slave/test 08:21:06 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:21:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:06 INFO - {'append_to_log': False, 08:21:06 INFO - 'base_work_dir': '/builds/slave/test', 08:21:06 INFO - 'blob_upload_branch': 'Fx-Team', 08:21:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:06 INFO - 'branch': 'Fx-Team', 08:21:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:06 INFO - 'config_files': ('talos/linux_config.py',), 08:21:06 INFO - 'default_actions': ('clobber', 08:21:06 INFO - 'read-buildbot-config', 08:21:06 INFO - 'download-and-extract', 08:21:06 INFO - 'populate-webroot', 08:21:06 INFO - 'create-virtualenv', 08:21:06 INFO - 'install', 08:21:06 INFO - 'run-tests'), 08:21:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:06 INFO - 'download_minidump_stackwalk': True, 08:21:06 INFO - 'download_symbols': 'ondemand', 08:21:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:06 INFO - 'installer_path': 'installer.exe', 08:21:06 INFO - 'log_level': 'info', 08:21:06 INFO - 'log_name': 'talos', 08:21:06 INFO - 'log_to_console': True, 08:21:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:06 INFO - 'opt_config_files': (), 08:21:06 INFO - 'pip_index': False, 08:21:06 INFO - 'sps_profile': False, 08:21:06 INFO - 'sps_profile_interval': 0, 08:21:06 INFO - 'suite': 'dromaeojs', 08:21:06 INFO - 'system_bits': '32', 08:21:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:06 INFO - 'title': 'talos-linux64-ix-033', 08:21:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:06 INFO - 'use_talos_json': True, 08:21:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:06 INFO - 'work_dir': 'build'} 08:21:06 INFO - ##### 08:21:06 INFO - ##### Running clobber step. 08:21:06 INFO - ##### 08:21:06 INFO - Running pre-action listener: _resource_record_pre_action 08:21:06 INFO - Running main action method: clobber 08:21:06 INFO - rmtree: /builds/slave/test/build 08:21:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:06 INFO - Running post-action listener: _resource_record_post_action 08:21:06 INFO - ##### 08:21:06 INFO - ##### Finished clobber step (success) 08:21:06 INFO - ##### 08:21:06 INFO - ##### 08:21:06 INFO - ##### Running read-buildbot-config step. 08:21:06 INFO - ##### 08:21:06 INFO - Running pre-action listener: _resource_record_pre_action 08:21:06 INFO - Running main action method: read_buildbot_config 08:21:06 INFO - Using buildbot properties: 08:21:06 INFO - { 08:21:06 INFO - "project": "", 08:21:06 INFO - "product": "firefox", 08:21:06 INFO - "script_repo_revision": "production", 08:21:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:21:06 INFO - "repository": "", 08:21:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:21:06 INFO - "buildid": "20160615053002", 08:21:06 INFO - "pgo_build": "True", 08:21:06 INFO - "basedir": "/builds/slave/test", 08:21:06 INFO - "buildnumber": 806, 08:21:06 INFO - "slavename": "talos-linux64-ix-033", 08:21:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:21:06 INFO - "platform": "ubuntu64_hw", 08:21:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:21:06 INFO - "branch": "fx-team", 08:21:06 INFO - "repo_path": "integration/fx-team", 08:21:06 INFO - "revision": "bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff", 08:21:06 INFO - "stage_platform": "linux64-pgo", 08:21:06 INFO - "builduid": "1af116f20aec4c3caefbf45348bbf4eb", 08:21:06 INFO - "slavebuilddir": "test" 08:21:06 INFO - } 08:21:06 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:21:06 INFO - Running post-action listener: _resource_record_post_action 08:21:06 INFO - ##### 08:21:06 INFO - ##### Finished read-buildbot-config step (success) 08:21:06 INFO - ##### 08:21:06 INFO - ##### 08:21:06 INFO - ##### Running download-and-extract step. 08:21:06 INFO - ##### 08:21:06 INFO - Running pre-action listener: _resource_record_pre_action 08:21:06 INFO - Running main action method: download_and_extract 08:21:06 INFO - mkdir: /builds/slave/test/build/tests 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:06 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:21:06 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:21:06 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:21:06 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:21:06 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:21:10 INFO - Downloaded 1361 bytes. 08:21:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:10 INFO - Using the following test package requirements: 08:21:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'jsshell-linux-x86_64.zip'], 08:21:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:10 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:21:10 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:21:10 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:21:10 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:21:10 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:21:11 INFO - Downloaded 24221178 bytes. 08:21:11 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:21:11 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:21:12 INFO - Return code: 0 08:21:12 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:21:12 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:21:12 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:21:12 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:21:12 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:21:12 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:21:12 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:21:15 INFO - Downloaded 24221178 bytes. 08:21:15 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:21:15 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:21:17 INFO - Return code: 0 08:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:17 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:21:17 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:21:17 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:21:17 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:21:17 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:21:18 INFO - Downloaded 14405384 bytes. 08:21:18 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:21:18 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:21:18 INFO - Return code: 0 08:21:18 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:21:18 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:21:18 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:21:18 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:21:18 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:21:18 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:21:20 INFO - Downloaded 59402892 bytes. 08:21:20 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:21:20 INFO - mkdir: /builds/slave/test/properties 08:21:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:20 INFO - Contents: 08:21:20 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:21:21 INFO - Running post-action listener: _resource_record_post_action 08:21:21 INFO - Running post-action listener: set_extra_try_arguments 08:21:21 INFO - ##### 08:21:21 INFO - ##### Finished download-and-extract step (success) 08:21:21 INFO - ##### 08:21:21 INFO - ##### 08:21:21 INFO - ##### Running populate-webroot step. 08:21:21 INFO - ##### 08:21:21 INFO - Running pre-action listener: _resource_record_pre_action 08:21:21 INFO - Running main action method: populate_webroot 08:21:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:21 INFO - '--tppagecycles', 08:21:21 INFO - '7'], 08:21:21 INFO - 'tests': ['tsvgm']}}, 08:21:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['damp', 'tps']}, 08:21:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'tests': ['damp', 'tps']}, 08:21:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['dromaeo_dom']}, 08:21:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['basic_compositor_video']}, 08:21:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['a11yr', 08:21:21 INFO - 'ts_paint', 08:21:21 INFO - 'tpaint', 08:21:21 INFO - 'sessionrestore', 08:21:21 INFO - 'sessionrestore_no_auto_restore', 08:21:21 INFO - 'tabpaint']}, 08:21:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['tsvgx', 08:21:21 INFO - 'tsvgr_opacity', 08:21:21 INFO - 'tart', 08:21:21 INFO - 'tscrollx', 08:21:21 INFO - 'cart']}, 08:21:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:21 INFO - 'tsvgr_opacity', 08:21:21 INFO - 'tart', 08:21:21 INFO - 'tscrollx', 08:21:21 INFO - 'cart']}, 08:21:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'talos_options': ['--disable-e10s'], 08:21:21 INFO - 'tests': ['tp5o']}, 08:21:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'tests': ['tp5o']}, 08:21:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'talos_options': ['--disable-e10s', 08:21:21 INFO - '--xperf_path', 08:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:21 INFO - 'tests': ['tp5n']}, 08:21:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:21 INFO - 'talos_options': ['--xperf_path', 08:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:21 INFO - 'tests': ['tp5n']}}, 08:21:21 INFO - 'talos.zip': {'path': '', 08:21:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:21 INFO - Running post-action listener: _resource_record_post_action 08:21:21 INFO - ##### 08:21:21 INFO - ##### Finished populate-webroot step (success) 08:21:21 INFO - ##### 08:21:21 INFO - ##### 08:21:21 INFO - ##### Running create-virtualenv step. 08:21:21 INFO - ##### 08:21:21 INFO - Running pre-action listener: _resource_record_pre_action 08:21:21 INFO - Running main action method: create_virtualenv 08:21:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:21 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:21:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:21 INFO - Using real prefix '/usr' 08:21:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:24 INFO - Installing pip.................done. 08:21:24 INFO - Return code: 0 08:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:24 INFO - Using env: {'DISPLAY': ':0', 08:21:24 INFO - 'HOME': '/home/cltbld', 08:21:24 INFO - 'LANG': 'en_US.UTF-8', 08:21:24 INFO - 'LANGUAGE': 'en_US:en', 08:21:24 INFO - 'LOGNAME': 'cltbld', 08:21:24 INFO - 'MAIL': '/var/mail/cltbld', 08:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:24 INFO - 'MOZ_NO_REMOTE': '1', 08:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:24 INFO - 'NO_EM_RESTART': '1', 08:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:24 INFO - 'PWD': '/builds/slave/test', 08:21:24 INFO - 'SHELL': '/bin/bash', 08:21:24 INFO - 'SHLVL': '1', 08:21:24 INFO - 'TERM': 'linux', 08:21:24 INFO - 'TMOUT': '86400', 08:21:24 INFO - 'USER': 'cltbld', 08:21:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:24 INFO - '_': '/tools/buildbot/bin/python'} 08:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:24 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:21:24 INFO - Cleaning up... 08:21:24 INFO - Return code: 0 08:21:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:21:24 INFO - Using env: {'DISPLAY': ':0', 08:21:24 INFO - 'HOME': '/home/cltbld', 08:21:24 INFO - 'LANG': 'en_US.UTF-8', 08:21:24 INFO - 'LANGUAGE': 'en_US:en', 08:21:24 INFO - 'LOGNAME': 'cltbld', 08:21:24 INFO - 'MAIL': '/var/mail/cltbld', 08:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:24 INFO - 'MOZ_NO_REMOTE': '1', 08:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:24 INFO - 'NO_EM_RESTART': '1', 08:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:24 INFO - 'PWD': '/builds/slave/test', 08:21:24 INFO - 'SHELL': '/bin/bash', 08:21:24 INFO - 'SHLVL': '1', 08:21:24 INFO - 'TERM': 'linux', 08:21:24 INFO - 'TMOUT': '86400', 08:21:24 INFO - 'USER': 'cltbld', 08:21:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:24 INFO - '_': '/tools/buildbot/bin/python'} 08:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:24 INFO - Downloading/unpacking psutil>=3.1.1 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:26 INFO - Installing collected packages: psutil 08:21:26 INFO - Running setup.py install for psutil 08:21:26 INFO - building 'psutil._psutil_linux' extension 08:21:26 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:21:26 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:21:26 INFO - building 'psutil._psutil_posix' extension 08:21:26 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:21:27 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:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:27 INFO - Successfully installed psutil 08:21:27 INFO - Cleaning up... 08:21:27 INFO - Return code: 0 08:21:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:27 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:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:27 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:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:27 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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:27 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:21:27 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:21:27 INFO - Using env: {'DISPLAY': ':0', 08:21:27 INFO - 'HOME': '/home/cltbld', 08:21:27 INFO - 'LANG': 'en_US.UTF-8', 08:21:27 INFO - 'LANGUAGE': 'en_US:en', 08:21:27 INFO - 'LOGNAME': 'cltbld', 08:21:27 INFO - 'MAIL': '/var/mail/cltbld', 08:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:27 INFO - 'MOZ_NO_REMOTE': '1', 08:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:27 INFO - 'NO_EM_RESTART': '1', 08:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:27 INFO - 'PWD': '/builds/slave/test', 08:21:27 INFO - 'SHELL': '/bin/bash', 08:21:27 INFO - 'SHLVL': '1', 08:21:27 INFO - 'TERM': 'linux', 08:21:27 INFO - 'TMOUT': '86400', 08:21:27 INFO - 'USER': 'cltbld', 08:21:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:27 INFO - '_': '/tools/buildbot/bin/python'} 08:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:29 INFO - Installing collected packages: mozsystemmonitor 08:21:29 INFO - Running setup.py install for mozsystemmonitor 08:21:29 INFO - Successfully installed mozsystemmonitor 08:21:29 INFO - Cleaning up... 08:21:29 INFO - Return code: 0 08:21:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:29 INFO - Using env: {'DISPLAY': ':0', 08:21:29 INFO - 'HOME': '/home/cltbld', 08:21:29 INFO - 'LANG': 'en_US.UTF-8', 08:21:29 INFO - 'LANGUAGE': 'en_US:en', 08:21:29 INFO - 'LOGNAME': 'cltbld', 08:21:29 INFO - 'MAIL': '/var/mail/cltbld', 08:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:29 INFO - 'MOZ_NO_REMOTE': '1', 08:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:29 INFO - 'NO_EM_RESTART': '1', 08:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:29 INFO - 'PWD': '/builds/slave/test', 08:21:29 INFO - 'SHELL': '/bin/bash', 08:21:29 INFO - 'SHLVL': '1', 08:21:29 INFO - 'TERM': 'linux', 08:21:29 INFO - 'TMOUT': '86400', 08:21:29 INFO - 'USER': 'cltbld', 08:21:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:29 INFO - '_': '/tools/buildbot/bin/python'} 08:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21: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:21: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:21: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:21: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:21: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:21: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:21:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:32 INFO - warning: no files found matching '*.txt' 08:21:32 INFO - no previously-included directories found matching 'build' 08:21:32 INFO - no previously-included directories found matching 'dist' 08:21:32 INFO - no previously-included directories found matching '.git*' 08:21:32 INFO - Installing collected packages: jsonschema, functools32 08:21:32 INFO - Running setup.py install for functools32 08:21:32 INFO - warning: no files found matching '*.txt' 08:21:32 INFO - no previously-included directories found matching 'build' 08:21:32 INFO - no previously-included directories found matching 'dist' 08:21:32 INFO - no previously-included directories found matching '.git*' 08:21:32 INFO - Successfully installed jsonschema functools32 08:21:32 INFO - Cleaning up... 08:21:32 INFO - Return code: 0 08:21:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:32 INFO - Using env: {'DISPLAY': ':0', 08:21:32 INFO - 'HOME': '/home/cltbld', 08:21:32 INFO - 'LANG': 'en_US.UTF-8', 08:21:32 INFO - 'LANGUAGE': 'en_US:en', 08:21:32 INFO - 'LOGNAME': 'cltbld', 08:21:32 INFO - 'MAIL': '/var/mail/cltbld', 08:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:32 INFO - 'MOZ_NO_REMOTE': '1', 08:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:32 INFO - 'NO_EM_RESTART': '1', 08:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:32 INFO - 'PWD': '/builds/slave/test', 08:21:32 INFO - 'SHELL': '/bin/bash', 08:21:32 INFO - 'SHLVL': '1', 08:21:32 INFO - 'TERM': 'linux', 08:21:32 INFO - 'TMOUT': '86400', 08:21:32 INFO - 'USER': 'cltbld', 08:21:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:32 INFO - '_': '/tools/buildbot/bin/python'} 08:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:35 INFO - Downloading docopt-0.6.1.tar.gz 08:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:35 INFO - Running setup.py install for blobuploader 08:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:35 INFO - Running setup.py install for requests 08:21:35 INFO - Running setup.py install for docopt 08:21:35 INFO - Successfully installed blobuploader requests docopt 08:21:35 INFO - Cleaning up... 08:21:35 INFO - Return code: 0 08:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:35 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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:35 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:21:35 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:21:35 INFO - Using env: {'DISPLAY': ':0', 08:21:35 INFO - 'HOME': '/home/cltbld', 08:21:35 INFO - 'LANG': 'en_US.UTF-8', 08:21:35 INFO - 'LANGUAGE': 'en_US:en', 08:21:35 INFO - 'LOGNAME': 'cltbld', 08:21:35 INFO - 'MAIL': '/var/mail/cltbld', 08:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:35 INFO - 'MOZ_NO_REMOTE': '1', 08:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:35 INFO - 'NO_EM_RESTART': '1', 08:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:35 INFO - 'PWD': '/builds/slave/test', 08:21:35 INFO - 'SHELL': '/bin/bash', 08:21:35 INFO - 'SHLVL': '1', 08:21:35 INFO - 'TERM': 'linux', 08:21:35 INFO - 'TMOUT': '86400', 08:21:35 INFO - 'USER': 'cltbld', 08:21:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:35 INFO - '_': '/tools/buildbot/bin/python'} 08:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:35 INFO - Running setup.py (path:/tmp/pip-g8p5Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:36 INFO - Running setup.py (path:/tmp/pip-glCn6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:36 INFO - Running setup.py (path:/tmp/pip-ikUC4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:36 INFO - Running setup.py (path:/tmp/pip-y32sjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:36 INFO - Running setup.py (path:/tmp/pip-aEHzSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:36 INFO - Running setup.py (path:/tmp/pip-UYSHCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:36 INFO - Running setup.py (path:/tmp/pip-2Ed_nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:36 INFO - Running setup.py (path:/tmp/pip-JEP2nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:36 INFO - Running setup.py (path:/tmp/pip-sOX4jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:36 INFO - Running setup.py (path:/tmp/pip-cgU2j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:36 INFO - Running setup.py (path:/tmp/pip-CwDuez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:36 INFO - Running setup.py (path:/tmp/pip-0rEK5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:36 INFO - Running setup.py (path:/tmp/pip-pvDGzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:36 INFO - Running setup.py (path:/tmp/pip-6ok2Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:36 INFO - Running setup.py (path:/tmp/pip-obagBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:37 INFO - Running setup.py (path:/tmp/pip-rAvIiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:37 INFO - Running setup.py (path:/tmp/pip-RVwNTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:37 INFO - Running setup.py install for manifestparser 08:21:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Running setup.py install for mozcrash 08:21:37 INFO - Running setup.py install for mozdebug 08:21:37 INFO - Running setup.py install for mozdevice 08:21:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Running setup.py install for mozfile 08:21:37 INFO - Running setup.py install for mozhttpd 08:21:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Running setup.py install for mozinfo 08:21:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Running setup.py install for mozInstall 08:21:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:37 INFO - Running setup.py install for mozleak 08:21:38 INFO - Running setup.py install for mozlog 08:21:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Running setup.py install for moznetwork 08:21:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Running setup.py install for mozprocess 08:21:38 INFO - Running setup.py install for mozprofile 08:21:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Running setup.py install for mozrunner 08:21:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Running setup.py install for mozscreenshot 08:21:38 INFO - Running setup.py install for moztest 08:21:38 INFO - Running setup.py install for mozversion 08:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:38 INFO - Cleaning up... 08:21:38 INFO - Return code: 0 08:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:38 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:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 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:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:38 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:21:38 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:21:38 INFO - Using env: {'DISPLAY': ':0', 08:21:38 INFO - 'HOME': '/home/cltbld', 08:21:38 INFO - 'LANG': 'en_US.UTF-8', 08:21:38 INFO - 'LANGUAGE': 'en_US:en', 08:21:38 INFO - 'LOGNAME': 'cltbld', 08:21:38 INFO - 'MAIL': '/var/mail/cltbld', 08:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:38 INFO - 'MOZ_NO_REMOTE': '1', 08:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:38 INFO - 'NO_EM_RESTART': '1', 08:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:38 INFO - 'PWD': '/builds/slave/test', 08:21:38 INFO - 'SHELL': '/bin/bash', 08:21:38 INFO - 'SHLVL': '1', 08:21:38 INFO - 'TERM': 'linux', 08:21:38 INFO - 'TMOUT': '86400', 08:21:38 INFO - 'USER': 'cltbld', 08:21:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:38 INFO - '_': '/tools/buildbot/bin/python'} 08:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:39 INFO - Running setup.py (path:/tmp/pip-hHCXO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:39 INFO - Running setup.py (path:/tmp/pip-ilAfZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:39 INFO - Running setup.py (path:/tmp/pip-knCAF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:39 INFO - Running setup.py (path:/tmp/pip-NBeRaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:39 INFO - Running setup.py (path:/tmp/pip-idx4KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:39 INFO - Running setup.py (path:/tmp/pip-yscXn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:39 INFO - Running setup.py (path:/tmp/pip-N6wE3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:39 INFO - Running setup.py (path:/tmp/pip-wNs7Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:39 INFO - Running setup.py (path:/tmp/pip-pNxlLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:39 INFO - Running setup.py (path:/tmp/pip-1UHmR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:39 INFO - Running setup.py (path:/tmp/pip-z9BN4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:40 INFO - Running setup.py (path:/tmp/pip-H4Ju_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:40 INFO - Running setup.py (path:/tmp/pip-ovqFjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:40 INFO - Running setup.py (path:/tmp/pip-NZ0H2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:40 INFO - Running setup.py (path:/tmp/pip-PwqtR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:40 INFO - Running setup.py (path:/tmp/pip-aBzouk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:40 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:40 INFO - Running setup.py (path:/tmp/pip-Igaaw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:42 INFO - Downloading blessings-1.6.tar.gz 08:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:42 INFO - Installing collected packages: blessings 08:21:42 INFO - Running setup.py install for blessings 08:21:42 INFO - Successfully installed blessings 08:21:42 INFO - Cleaning up... 08:21:42 INFO - Return code: 0 08:21:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:42 INFO - Reading from file tmpfile_stdout 08:21:42 INFO - Current package versions: 08:21:42 INFO - argparse == 1.2.1 08:21:42 INFO - blessings == 1.6 08:21:42 INFO - blobuploader == 1.2.4 08:21:42 INFO - docopt == 0.6.1 08:21:42 INFO - functools32 == 3.2.3-2 08:21:42 INFO - jsonschema == 2.5.1 08:21:42 INFO - manifestparser == 1.1 08:21:42 INFO - mozInstall == 1.12 08:21:42 INFO - mozcrash == 0.17 08:21:42 INFO - mozdebug == 0.1 08:21:42 INFO - mozdevice == 0.48 08:21:42 INFO - mozfile == 1.2 08:21:42 INFO - mozhttpd == 0.7 08:21:42 INFO - mozinfo == 0.9 08:21:42 INFO - mozleak == 0.1 08:21:42 INFO - mozlog == 3.2 08:21:42 INFO - moznetwork == 0.27 08:21:42 INFO - mozprocess == 0.22 08:21:42 INFO - mozprofile == 0.28 08:21:42 INFO - mozrunner == 6.11 08:21:42 INFO - mozscreenshot == 0.1 08:21:42 INFO - mozsystemmonitor == 0.3 08:21:42 INFO - moztest == 0.7 08:21:42 INFO - mozversion == 1.4 08:21:42 INFO - psutil == 3.1.1 08:21:42 INFO - requests == 1.2.3 08:21:42 INFO - wsgiref == 0.1.2 08:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:42 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 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:42 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:21:42 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:21:42 INFO - Using env: {'DISPLAY': ':0', 08:21:42 INFO - 'HOME': '/home/cltbld', 08:21:42 INFO - 'LANG': 'en_US.UTF-8', 08:21:42 INFO - 'LANGUAGE': 'en_US:en', 08:21:42 INFO - 'LOGNAME': 'cltbld', 08:21:42 INFO - 'MAIL': '/var/mail/cltbld', 08:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:42 INFO - 'MOZ_NO_REMOTE': '1', 08:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:42 INFO - 'NO_EM_RESTART': '1', 08:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:42 INFO - 'PWD': '/builds/slave/test', 08:21:42 INFO - 'SHELL': '/bin/bash', 08:21:42 INFO - 'SHLVL': '1', 08:21:42 INFO - 'TERM': 'linux', 08:21:42 INFO - 'TMOUT': '86400', 08:21:42 INFO - 'USER': 'cltbld', 08:21:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:42 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 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:21:43 INFO - Cleaning up... 08:21:43 INFO - Return code: 0 08:21:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:43 INFO - Using env: {'DISPLAY': ':0', 08:21:43 INFO - 'HOME': '/home/cltbld', 08:21:43 INFO - 'LANG': 'en_US.UTF-8', 08:21:43 INFO - 'LANGUAGE': 'en_US:en', 08:21:43 INFO - 'LOGNAME': 'cltbld', 08:21:43 INFO - 'MAIL': '/var/mail/cltbld', 08:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:43 INFO - 'MOZ_NO_REMOTE': '1', 08:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:43 INFO - 'NO_EM_RESTART': '1', 08:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:43 INFO - 'PWD': '/builds/slave/test', 08:21:43 INFO - 'SHELL': '/bin/bash', 08:21:43 INFO - 'SHLVL': '1', 08:21:43 INFO - 'TERM': 'linux', 08:21:43 INFO - 'TMOUT': '86400', 08:21:43 INFO - 'USER': 'cltbld', 08:21:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:43 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:43 INFO - Cleaning up... 08:21:43 INFO - Return code: 0 08:21:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05015b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', '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:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:21:43 INFO - Using env: {'DISPLAY': ':0', 08:21:43 INFO - 'HOME': '/home/cltbld', 08:21:43 INFO - 'LANG': 'en_US.UTF-8', 08:21:43 INFO - 'LANGUAGE': 'en_US:en', 08:21:43 INFO - 'LOGNAME': 'cltbld', 08:21:43 INFO - 'MAIL': '/var/mail/cltbld', 08:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:43 INFO - 'MOZ_NO_REMOTE': '1', 08:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:43 INFO - 'NO_EM_RESTART': '1', 08:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:43 INFO - 'PWD': '/builds/slave/test', 08:21:43 INFO - 'SHELL': '/bin/bash', 08:21:43 INFO - 'SHLVL': '1', 08:21:43 INFO - 'TERM': 'linux', 08:21:43 INFO - 'TMOUT': '86400', 08:21:43 INFO - 'USER': 'cltbld', 08:21:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:43 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 INFO - Downloading/unpacking flake8 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:46 INFO - no previously-included directories found matching 'docs/_build' 08:21:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:46 INFO - Running setup.py install for pep8 08:21:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:46 INFO - no previously-included directories found matching 'docs/_build' 08:21:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:21:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:21:46 INFO - Cleaning up... 08:21:46 INFO - Return code: 0 08:21:46 INFO - Running post-action listener: _resource_record_post_action 08:21:46 INFO - Running post-action listener: _start_resource_monitoring 08:21:46 INFO - Starting resource monitoring. 08:21:46 INFO - ##### 08:21:46 INFO - ##### Finished create-virtualenv step (success) 08:21:46 INFO - ##### 08:21:46 INFO - ##### 08:21:46 INFO - ##### Running install step. 08:21:46 INFO - ##### 08:21:46 INFO - Running pre-action listener: _resource_record_pre_action 08:21:46 INFO - Running main action method: install 08:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:46 INFO - Reading from file tmpfile_stdout 08:21:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:46 INFO - Reading from file tmpfile_stdout 08:21:46 INFO - Output received: 08:21:46 INFO - Usage: mozinstall [options] installer 08:21:46 INFO - Options: 08:21:46 INFO - -h, --help show this help message and exit 08:21:46 INFO - -d DEST, --destination=DEST 08:21:46 INFO - Directory to install application into. [default: 08:21:46 INFO - "/builds/slave/test"] 08:21:46 INFO - --app=APP Application being installed. [default: firefox] 08:21:46 INFO - mkdir: /builds/slave/test/build/application 08:21:46 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:21:46 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:22:05 INFO - Reading from file tmpfile_stdout 08:22:05 INFO - Output received: 08:22:05 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:05 INFO - Running post-action listener: _resource_record_post_action 08:22:05 INFO - ##### 08:22:05 INFO - ##### Finished install step (success) 08:22:05 INFO - ##### 08:22:05 INFO - ##### 08:22:05 INFO - ##### Running run-tests step. 08:22:05 INFO - ##### 08:22:05 INFO - Running pre-action listener: _resource_record_pre_action 08:22:05 INFO - Running main action method: run_tests 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:05 INFO - Python 2.7.3 08:22:05 INFO - Return code: 0 08:22:05 INFO - grabbing minidump binary from tooltool 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:05 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 0x1177010>, '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 0x1177ef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11783a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:05 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:22:05 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:22:05 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:22:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:05 INFO - Return code: 0 08:22:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:06 INFO - Return code: 0 08:22:06 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-033', '--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:22:06 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-033 --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:22:06 INFO - Using env: {'DISPLAY': ':0', 08:22:06 INFO - 'HOME': '/home/cltbld', 08:22:06 INFO - 'LANG': 'en_US.UTF-8', 08:22:06 INFO - 'LANGUAGE': 'en_US:en', 08:22:06 INFO - 'LOGNAME': 'cltbld', 08:22:06 INFO - 'MAIL': '/var/mail/cltbld', 08:22:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:06 INFO - 'MOZ_NO_REMOTE': '1', 08:22:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:06 INFO - 'NO_EM_RESTART': '1', 08:22:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:06 INFO - 'PWD': '/builds/slave/test', 08:22:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:06 INFO - 'SHELL': '/bin/bash', 08:22:06 INFO - 'SHLVL': '1', 08:22:06 INFO - 'TERM': 'linux', 08:22:06 INFO - 'TMOUT': '86400', 08:22:06 INFO - 'USER': 'cltbld', 08:22:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063', 08:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:06 INFO - '_': '/tools/buildbot/bin/python'} 08:22:06 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-033', '--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:22:06 INFO - mozversion application_buildid: 20160615053002 08:22:06 INFO - mozversion application_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:22:06 INFO - mozversion application_display_name: Nightly 08:22:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:06 INFO - mozversion application_name: Firefox 08:22:06 INFO - mozversion application_remotingname: firefox 08:22:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:06 INFO - mozversion application_vendor: Mozilla 08:22:06 INFO - mozversion application_version: 50.0a1 08:22:06 INFO - mozversion platform_buildid: 20160615053002 08:22:06 INFO - mozversion platform_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:22:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:06 INFO - mozversion platform_version: 50.0a1 08:22:06 INFO - using testdate: 1466004126 08:22:06 INFO - actual date: 1466004126 08:22:06 INFO - starting webserver on 'localhost:57939' 08:22:06 INFO - SUITE-START | Running 2 tests 08:22:06 INFO - TEST-START | dromaeo_css 08:22:06 INFO - operating with platform_type : linux_ 08:22:06 INFO - Initialising browser for dromaeo_css test... 08:22:06 INFO - TEST-INFO | started process 16447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNAmK3/profile http://localhost:57939/getInfo.html) 08:22:11 INFO - PROCESS | 16447 | __metrics Screen width/height:1600/1200 08:22:11 INFO - PROCESS | 16447 | colorDepth:24 08:22:11 INFO - PROCESS | 16447 | Browser inner width/height: 1024/697 08:22:11 INFO - PROCESS | 16447 | __metrics 08:22:12 INFO - PROCESS | 16447 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:12 INFO - PROCESS | 16447 | console.error: PushService: 08:22:12 INFO - PROCESS | 16447 | stateChangeProcessEnqueue: Error transitioning state 08:22:12 INFO - PROCESS | 16447 | UnknownError 08:22:13 INFO - TEST-INFO | 16447: exit 0 08:22:13 INFO - Browser initialized. 08:22:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:13 INFO - TEST-INFO | started process 16533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNAmK3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:25 INFO - PROCESS | 16533 | RSS: Main: 177721344 08:22:25 INFO - PROCESS | 16533 | 08:23:16 INFO - PROCESS | 16533 | 1466004196993 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:25:24 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57939/tests/dromaeo/cssquery-ext.html) 08:25:25 INFO - PROCESS | 16533 | RSS: Main: 263929856 08:25:25 INFO - PROCESS | 16533 | 08:28:28 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-ext.html (next: http://localhost:57939/tests/dromaeo/cssquery-jquery.html) 08:28:29 INFO - PROCESS | 16533 | RSS: Main: 266821632 08:28:29 INFO - PROCESS | 16533 | 08:31:30 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57939/tests/dromaeo/cssquery-mootools.html) 08:31:31 INFO - PROCESS | 16533 | RSS: Main: 268218368 08:31:31 INFO - PROCESS | 16533 | 08:34:33 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57939/tests/dromaeo/cssquery-prototype.html) 08:34:34 INFO - PROCESS | 16533 | RSS: Main: 256434176 08:34:34 INFO - PROCESS | 16533 | 08:37:36 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57939/tests/dromaeo/cssquery-yui.html) 08:37:37 INFO - PROCESS | 16533 | RSS: Main: 243986432 08:37:37 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-yui.html (next: http://localhost:57939/tests/dromaeo/cssquery-dojo.html) 08:40:40 INFO - PROCESS | 16533 | RSS: Main: 298614784 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | __start_tp_report 08:40:40 INFO - PROCESS | 16533 | _x_x_mozilla_page_load 08:40:40 INFO - PROCESS | 16533 | _x_x_mozilla_page_load_details 08:40:40 INFO - PROCESS | 16533 | |i|pagename|runs| 08:40:40 INFO - PROCESS | 16533 | |0;dojo.html;3033.0142703621314;3054.0990407829686;3068.447679417704;3078.245829771706;3100.720935115839;5193.195054766513;5225.6603320784125;5303.946960530394;5304.2043693446;5356.892862142755;5194.818181363653;5205.219217117435;5210.791568337271;5214.7653355598995;5264.657797243177;4678.649101317406;4748.8575342739605;4758.072175925696;4762.952370476286;4893.510648935114;4803.135435621587;4829.4687584365865;4844.346013288196;4859.708417494944;4882.43851957026;4730.810767569293;4751.714897106184;4810.855674329776;4814.013127308928;4891.853244402673;4763.714177149347;4782.569568738795;4792.089502994455;4794.976025119887;4873.366462359906;4785.353977213102;4806.49531799163;4815.711057336536;4840.733759643218;4867.075255701406;5160.303359046518;5198.038362902875;5288.338957630296;5289.2859463972645;5352.545033672142;5609;5619.831405057855;5637.182608521783;5654.236678048452;5676.602637815355;5721.199032135504;5728.484436400744;5766.336871259775;5769.942300576982;5770.711464426762;5182.4299327073995;5231.947680523184;5258.395284542288;5258.789648414059;5309.681419114865;5805.216295800013;5810.360860305363;5811.767529298865;5823.097419899922;5823.242978412779;5385.569154467633;5569.331680198402;5576;5576.414476479992;5580.218769372291;5521.337439507285;5629.971850140805;5630.07103827872;5643.068893632587;5646.407127251661;5624.184493248456;5631.859203519863;5633.577481688808;5642.774289028475;5647.6329038613185;5568.665880047129;5583.972080139654;5633.915491267634;5642.379338272869;5651.773929042793;4369.4101296325225;4377.606015458624;4379.802908869108;4397.692161548661;4424.0709451015;3894.5910679378826;3909.5113110861143;3918.0204948762807;3922.8234729437245;3950.071733142709;5151.793928242903;5224.869378265574;5265;5379.085555455582;5413.783448662089;5657.434256574392;5671.064274394761;5684.54523638108;5712.343080545707;5760.423957604206;5317.574594032468;5335.733213339317;5347.2781174541715;5355;5356.7321633918145;4805.807767689324;4899.877503062452;4938.851834444972;4956.10790057793;4990.900181996412;5929.14027466015;5937.228160339215;5937.554683398763;5940.732667029994;5981.581289309794;5716.114002329646;5735.71321433935;5737.282839645044;5739.110437882135;5745.540356771532;5619.662820230799;5692.658440493584;5701.600887937971;5755.3381361144;5901.498372638202;5492.286002819767;5492.340919089735;5493.121100623881;5498.395176530658;5500.559955203654;5531.1426728857095;5551.833444996657;5568.387477377566;5573.888522229614;5624.381318054929;5395;5477.20580515831;5477.260569823023;5535.3634332050715;5565.972170139124;5515.448455154453;5523.088690366205;5524.779008839601;5535.086710692691;5536.141898005815;5309.097453433003;5393.487618676219;5429.809956651498;5443.863903402446;5495.5878309127775;5481.972590137024;5547.861303467445;5549.639273447213;5628.0432326505415;5628.915566266427;5434.184872269191;5436.918446223231;5439.646422982493;5440.455954404528;5488.121900495901 08:40:40 INFO - PROCESS | 16533 | |1;ext.html;613.1660941120076;632.9145565348678;640.7308930249297;651.9511036672251;656.967151642418;30081.548776768366;32940.50589241163;32940.67059329409;33025.66974330256;42000.36999445003;44036.779816100956;45299.320510192374;45362.31956520655;45418.31872521907;45446.318305225366;8785.824283514326;8930.910690893073;8931.598078086468;8933.508657023862;8935.64257429702;8729.563521823915;8828.646854125827;8832.558372081403;8836.204741573258;8836.779080522974;8863.468191908474;8908.910910890872;8909.153630405133;8910.42082264654;8926.152015558511;8812.867806982867;8850;8867.201951824301;8873.11268873114;8874.290056795473;8793.868091978626;8871.86692199611;8871.866921996176;8872.911270887273;8879.778005549848;41985.790071049756;42486;42589.36115958263;42713.57286427127;42715.57284427147;3325.800451972865;3352.798832070084;3468.479728040789;3498.6676265754713;3499.5100685903994;32356.676433235603;32708;32874.83562582196;34009.14977125567;34088;4342.1532801103795;4428;4441.333799930004;4452.933206001912;4457.442819647544;336644.316778417;336824;336999;337487;337766;55763.44236557664;55898.72050639721;56015.43984560184;56035;56443.71778141083;57957;58100.12849807256;58241.70879145577;58259.1740825914;58308.4169158303;13965.511207107906;14972.401103955719;15300;15422.383104675688;15744.527664170093;11914.940425297818;11926.284422934652;12004.099692523096;12022.699432514257;12026.098042646836;14725.116493010453;15514.844851551567;15826.44607438734;15986.360545578047;16008.759868601981;5864.266966629171;6085.513158947274;6101.206843110456;6152.415520525543;6156.722947467375;946.8579713043099;1002.7292630989592;1012.9746756331003;1028.547439126782;1108.4790148630132;32120.518192227137;32497.8392394125;32710.345793084005;32786.18034549108;33315.500267496005;1133.1897693149438;1170.8302296167008;1194.8685644579089;1206.9939650301692;1233.5805826019196;16998.150092495573;17251.482455526355;17273.91363043202;17367.65264694699;17445.21496532659;478748;481262;482197;484946;487224;56520.71739641276;57590.424095758506;57696;57755.13367299494;57850.42149578535;1322.8941684665203;1340.4839136932546;1348.1843484691817;1355.945762169522;1386.646405166676;30466.23834404069;32496.675033249365;32536.83731581327;32782.83608581942;33058;50353;50617.493825061276;50631.49368506268;50745;50746.2388064172;425420;426709;427284;427785;428225;40583;42004.159916802106;42696.35955460733;42789.57210427856;42842.1431571373;38157.80921095377;42890.713278601695;47865;49749.50250497449;53729;38860.80569597247;41823.58176418319;42318.36522452104;42459.363109554;42477.78761106298;39998.60001399949;41221.58778412177;41563.58436415597;41867.81321867789;42089.789551053276;40630.79684601676;40929.1814163721;41092.383614246406;41387.7930610345;42224;36424.63575364318;36640.63359366372;37060.44409333808;37182.25635487221;37775.433368500046;27786;27940.860295698392;28136.29659258535;28225.294367640974;28386 08:40:40 INFO - PROCESS | 16533 | |2;jquery.html;377.9244151169766;385.19878652403;397.5547386926643;400.92382447335024;411.7899871065757;17388.21753021114;18591.628167436644;20328;20485.385438436835;20539.794602053975;18465.815341846577;18592;19185;19527.707084393747;19602.11790469429;5074.314967479389;5271.499207575274;5290.074237008527;5557.277553917985;5906.911396329058;5778.682172480512;5784.739686714108;5796.478316951474;5816.214811000503;5825.941740582603;5513.862153446176;5805;5805.10020946754;5832.387599302076;5838.153467747175;5882.176495290662;5889.1755154278435;5897.20387747655;5911.645301281937;5933.910991335133;5618.129189975561;5758.48173664368;5763.221965034751;5769.596128271022;5769.682667453289;12936.611901642966;13223.272720000492;13232.603021909357;13481.123726957716;13815.309234538334;2145.0668959002883;2154.278316763886;2187.4859408039097;2246.618074927266;2309.2379514760087;9942.353747006422;9944.900550994542;10009.249306302056;10449.425281609509;10533.157347412189;1823.8996855172961;1872.6535590915723;1885.9622807543772;1910.512819231101;1948.0551932312958;68652;71835.28164718338;76048.61975690087;77888.61055694742;79171.60414197893;10848.077913377452;10957.315457712912;11289.830652540219;11324.6036388726;11539.48072336747;15531.22343882824;15539.922300388425;15652.373905043898;15653.373865045498;15682.607934801494;7773.805654858674;7873.488223265469;7903.130655627876;7941.444098913021;8042.437029407885;7359.190489046201;7426.62866856655;7462.216467270967;7540.547567145989;7566.092068951761;4832.34763306949;4836.613070954315;4865.56209941107;4899.265110233422;4921.384826896638;1938.6025864697704;1952.9023548822502;1963.2441510018746;1966.7049942508452;1989.8806071635747;929.9488528130883;1034.5189486888632;1057.6826951914395;1070.9718670076813;1085.4355735017905;19251.22995080181;19481.707774383394;19531.316403925794;19886.204551817766;20088.497787555134;981.4276035231762;989.6981420666622;990.7572644702094;1023.2683631203726;1043.3635482355758;9336.253099752004;10936.890631093587;11093.389863557582;11186.44067796607;11193.66419007431;424983;428293;441340;441532;443064;57304;87584;88372.55813721019;89792;90418.54790726135;960.3325688646463;977.5649835822991;988.8615593816871;990.8959559246175;992.5235886774244;16905.239264232892;17157.142142892557;17204.91397543004;17504.124793760006;17899.910500447415;41465.792671037656;41987.580124198365;42484.575154248065;42554;43185.136297274505;57926;58846;58936.410635894805;60660;60922.17233483003;12144.210626309261;12545.749085018431;12681.365931703562;13013.024023198108;13511.729765404834;13708.794368084287;14245.145291282142;14327.068740531831;14432.783508247594;14828.7775683367;12640.810387844005;12710.36448177606;12756.234625922474;12983;13119.475220991435;12118.333491658044;12479;12481.875181248435;12635.620931372074;13028.478860845838;11841.82237266459;12677.936610316889;13120.278384688934;13184;13368.331583420984;13157.34213289351;13193.076484645982;13210.07529472966;13264.33678316061;13382.732345352844;12686.619401417973;12758.298293593942;12911.806322904977;12971.416286266953;13094.934525327313 08:40:40 INFO - PROCESS | 16533 | |3;mootools.html;1265.2155663488627;1441.7332793433213;1486.9033512821666;1593.8804589655772;1757.1653464604315;8186.386021048423;8581;8597.957010214948;8821.779455513599;8856.690015849446;8519.1906768857;8682.26200772935;8710.128987101287;8715.433496822701;8720.563971801415;1954.2476146683557;2146.399008277685;2221.1448592292004;2256.6050941085286;2283.908643654252;2265.4562904902787;2270.0692715986447;2271.6819645249598;2276.4195130241847;2282.6918366020623;2224.143704673704;2227.855189412683;2253.43664083979;2254.357508110189;2255.1881322723807;1718.8968661880326;2174.8477606567467;2176.5973294940486;2233.0286325448483;2234.4078819112947;2228.665700144975;2234.318532847481;2254.4927391336983;2257.164849005862;2258.006477150065;8265.380096492787;8288.461250018729;8312.085670576233;8323.417360784748;8348.582570871433;4894.045661096087;4998.12532806761;5007.724575148365;5010.248462730583;5015.498450154992;3053.618297712786;3137.8274194919272;3231.2083539532964;3232.739231699639;3241.6272128705264;1035.0684384054337;1035.3703328802333;1074.2426589254558;1082.0423924826507;1096.2381145104155;12089.153759236857;12116.939415302955;12118.515259389615;12142.939285303606;12166.391680415943;4329.718568293051;4391.209582275221;4480.484744254387;4496.550344965477;4503.909921801545;10069.748256293651;10095.141912937335;10098.394096354243;10107.444090575089;10107.64623238183;5020.548150666457;5082.364704411949;5095;5097.413797413271;5098.923516147261;4213.789310534522;4593.379893714373;4672.859814205579;4677.368555244999;4715.363425937523;3756.8121593920196;3767.773933563995;3868.709846761504;3870.612938706107;3890.280298144796;1092.5848177692585;1112.282577737371;1117.6982214801958;1137.0448822988565;1170.7716995185856;804.7022601637315;868.561376504861;898.9280857531381;899.4288626722079;938.7653086728318;5847.210626565445;5906.143609176645;5911.881762364728;5981.461668449861;6065.514758819284;916.7387294621001;938.7183844846519;959.1463597398321;960.6013504395737;987.479281905857;4044.4337792709043;4079.9592004079577;4136.91726165475;4159.625633692922;4183.309753890574;10863.83704244437;11020.669379918616;11032.889671103347;11146.331220126818;11218.158638102175;11034;11053.447327633587;11097.056750176163;11106.722331941766;11130.165237607212;7810.218978102144;8167.264946154755;8169.591520423955;8287.419880608299;8439.324854011664;5919.585629005928;6037.426444487766;6082.847928801815;6144.262688477233;6147.108669243024;10044.246681498771;10272.743181420225;10306.742331441774;10327.122194613241;10332.380057196593;10023.248256380946;10194.949025255122;10541.631042913461;10584.735381615521;10701.304415212986;7183.964080179775;7352.5220860643885;7354.70581176747;7636.31273185416;7758;8055.838883222185;8261.09127995932;8436.367272454714;8469.110743372104;8758.737237882873;7782.416318776001;7863.292303692695;7968.123506414406;8006.399520035904;8082.070561885458;7618.276263754934;7650.846983060419;7714.6914123434435;7857.2928436441;7941.285284324438;7258.874874394477;7273.672684729306;7441.888371674538;7463.626818659154;7467.514611550232;5057.317262169707;5135.666181698178;5137.2037334213255;5186.222066690027;5245.737713114253;5139.8458046258675;5179.948200518097;5220.086484865057;5348.57211423093;5391.75737091824 08:40:40 INFO - PROCESS | 16533 | |4;prototype.html;320.0414757800387;321.2755236940698;324.508369819723;327.4776731113874;337.86147679451415;5192.766325515351;5302.780360517083;5302.939412117577;5318.6011049171275;5327.014502317074;5237.266782650432;5267.683938963665;5282.31329927109;5310.4424035476295;5314.76083576239;3926;3976.701747368959;4079.3473044312914;4087.4073259377374;4089.488813898263;4067.1087944105984;4070.5522392536795;4077.633013028827;4096.746789265907;4127.7204066739405;3877.592852750463;4054.6350828425434;4062.0860306431114;4062.8171732272117;4066.369712694522;3825.827837747308;3976.2047590481875;3999.8000599820084;4108.2129273766;4116.135611521584;3629.709623230135;3643.125649844045;3671.375866102769;3676.1361080146144;3684.7236457265544;5099.821506247301;5111.897762044776;5116.079105760961;5130.71781052042;5168.8449346519665;4561.612262957653;4712.599429048535;4733.337332773414;4744.410622441486;4751.216049351853;5458.918116228259;5470.234167216593;5476.698781567052;5496.862578435571;5516.448355164492;4043.3111980533204;4043.7978101094827;4044.3529035354204;4044.5955404459614;4065.918681626351;5587.664740115606;5618.550515958714;5721.513671337942;5725.141228815669;5732.398098199671;4130.256553820281;4150.6471949884;4155.58444155582;4167.06241095751;4167.2082304362075;4173;4188.120494696087;4189.937150942738;4208.831646734157;4215.48242632652;4638.353384548504;4676.50896655853;4679.298105284167;4689.60138388234;4779.976100119477;5463;5468.671879687152;5492.363665440611;5519.420460851633;5521.199426083276;1433.3120102350929;1442.917811641269;1450.775129854853;1458.1105525629357;1464.1434760665131;904.6878826804742;943.6461327002374;946.6118891254553;947.6967370441392;948.6821914658528;5141.614378921596;5286.312779338661;5310.415854256029;5357.249985002103;5381.730913454312;5643.266375371176;5668.26312579362;5672.298310506914;5677.914831277534;5701.543876489871;5043.52086551777;5245.7114858683135;5293.497117773805;5339.81310654133;5390.595705322116;2974.1523665755158;2974.5757207875513;2997.4454725875785;3018.079485756821;3023.8639261233297;5811.680357580289;5855.824325270249;5858.857522783102;5914.526837852962;5945.494632956161;5619.466150715675;5748.367679555246;5788.421157884262;5831.620944638585;5843.18195452637;5860.208871802337;5865.9441300566305;5879.118132280021;5909.054551271776;5921.911171332434;5413.7834486620095;5677.574181936288;5711.828645140652;5752.597318187687;5775.249217601685;5692.800751973661;5707.20099186106;5710.143478478261;5717.799877004285;5742.7702891883855;5919.7632094717455;5950.166976623363;5961.330827368344;6004.759809607567;6016.157737916783;3989.4414781929972;4015.9799201003807;4040.616141466556;4058.512978442606;4094.242565125461;5681.9431805681415;5708.771649133988;5726.370099289158;5765.221695071112;5766.394528574439;5397.622166448311;5566.68982372311;5577;5633.661980281032;5637.126245431965;5478.205660179331;5492.890142197054;5510.669359838423;5544.168374743659;5582;5242.397124330751;5460.726963651722;5474.616776825584;5495.752691128829;5557.166425036277;5439.5920305978;5489.505944465017;5501.642393244426;5525.309336332958;5564.998300305984;5340.78636854537;5374.865628359323;5374.973125134349;5412.783488660567;5466.125419932791 08:40:40 INFO - PROCESS | 16533 | |5;yui.html;700.7547358424551;739.1610522057463;750.7747675697291;775.8176828445314;796.8286818334057;14777.335019924103;15742.527724168265;15747.448839290628;15765.999999999985;15817.60455988601;14391.856081439182;14637.487687930925;14697.265136743146;14844.183569903651;14850.257487125655;677.6306912732548;818.5007145641155;829.7344849648115;832.0182185021672;834.1658341658342;791.6121100660692;821.48246604639;825.5046971816922;825.6573521988367;826.8222332198576;868.4789126524066;869.7782065573269;871.0723079919896;871.7689812199773;872.4067634008871;711.1359697966943;853.8591132463137;861.3711990247124;864.9264812490945;865.8701194820795;632.0519221168248;636.3858876184504;636.7039326713101;636.8216899268213;637.2512298049819;14040.789388159186;14081.225532595703;14094.71810563783;14109.082909610843;14113.647158821112;13350.332483375889;13664.248466334348;13719.176849389069;13737.519186828413;13895.513657022057;13143.671408214776;13223.669408264774;13428.127171733806;13447.32763361828;13657.112287701368;3714.275716235335;3831.578526362098;3868.7485313454536;3979.144483935968;3981.3231750602467;75878.62060689661;76853;77213.61393193054;78142.60928695377;78228.60885695535;11361.488733007034;11396.202265841477;11526.250793698382;11771.88228117725;11821;19324.130414131116;19347.322843700404;19417.223311067683;19443.4166974991;19448.222071116998;8217.630206640715;8471.195236452528;8576.185262400062;8745.344099192585;9060.139286767746;4781.187198176319;4820;4885.511448855086;4888.608911287089;5086.593072554187;3586.444101164324;3738.2897249522503;3742.8315725792404;3742.925141497155;3745.2696724139078;644.262319644005;667.1860330396908;673.4040374268808;674.7672053141658;676.1176664452838;586.806353903211;604.6916072802815;620.5687047502033;676.6278546799241;701.235653138082;8469.237768600855;8809.515476648718;8830.249428798496;8923.41997770143;9035.00614932357;562.9127485239794;581.7702007707016;615.1080932647678;715.0811207598211;720.1106633307861;4260.25445547028;4295.119500502389;4300.505441874225;4323.524412314643;4371.956280437218;113384.43307783408;117288;120155;120798;122153;96847.51576242215;97383;97504;97547.51226243965;97827;89742.65386019215;89906.55046724855;90005;90243.29270121775;91257.08742912619;8849.734507964771;8968.596413161555;8976;9077.95461022717;9327.300452465957;44406.55593444024;47135;47152.528474716186;48096;51409.74295128501;70974.64512677403;73760;74689;75005.62497187479;77748;11748.70628234301;11798.184513333415;11888.108391870472;12179.269243845398;12263.26420414778;14147.36336864823;14285.714285714435;14714.77927831062;14941.626459338604;15096.54710358691;13375.933120334335;13476.124051936593;13572;13892.72214555683;13897.513587024405;11874.940625296818;12318.75362492763;12487.31319777421;12767.680807979876;12768.6807829805;13260.138091024053;13314.267715275366;13326;13509.856306598856;14129.081609695337;10646.307989980627;10801.94772930519;11162.888371116185;11232.606858759904;11267.549298027987;11218.326900386002;11380.715482113013;11455.427228638368;11677.708057298296;11794.351310677652 08:40:40 INFO - PROCESS | 16533 | __end_tp_report 08:40:40 INFO - PROCESS | 16533 | __start_cc_report 08:40:40 INFO - PROCESS | 16533 | _x_x_mozilla_cycle_collect,889 08:40:40 INFO - PROCESS | 16533 | __end_cc_report 08:40:40 INFO - PROCESS | 16533 | __startTimestamp1466005240459__endTimestamp 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | ------- Summary: start ------- 08:40:40 INFO - PROCESS | 16533 | Number of tests: 6 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#0] dojo.html Cycles:165 Average:5248.27 Median:5439.65 stddev:586.64 (10.8%) stddev-sans-first:562.11 08:40:40 INFO - PROCESS | 16533 | Values: 3033.0 3054.1 3068.4 3078.2 3100.7 5193.2 5225.7 5303.9 5304.2 5356.9 5194.8 5205.2 5210.8 5214.8 5264.7 4678.6 4748.9 4758.1 4763.0 4893.5 4803.1 4829.5 4844.3 4859.7 4882.4 4730.8 4751.7 4810.9 4814.0 4891.9 4763.7 4782.6 4792.1 4795.0 4873.4 4785.4 4806.5 4815.7 4840.7 4867.1 5160.3 5198.0 5288.3 5289.3 5352.5 5609.0 5619.8 5637.2 5654.2 5676.6 5721.2 5728.5 5766.3 5769.9 5770.7 5182.4 5231.9 5258.4 5258.8 5309.7 5805.2 5810.4 5811.8 5823.1 5823.2 5385.6 5569.3 5576.0 5576.4 5580.2 5521.3 5630.0 5630.1 5643.1 5646.4 5624.2 5631.9 5633.6 5642.8 5647.6 5568.7 5584.0 5633.9 5642.4 5651.8 4369.4 4377.6 4379.8 4397.7 4424.1 3894.6 3909.5 3918.0 3922.8 3950.1 5151.8 5224.9 5265.0 5379.1 5413.8 5657.4 5671.1 5684.5 5712.3 5760.4 5317.6 5335.7 5347.3 5355.0 5356.7 4805.8 4899.9 4938.9 4956.1 4990.9 5929.1 5937.2 5937.6 5940.7 5981.6 5716.1 5735.7 5737.3 5739.1 5745.5 5619.7 5692.7 5701.6 5755.3 5901.5 5492.3 5492.3 5493.1 5498.4 5500.6 5531.1 5551.8 5568.4 5573.9 5624.4 5395.0 5477.2 5477.3 5535.4 5566.0 5515.4 5523.1 5524.8 5535.1 5536.1 5309.1 5393.5 5429.8 5443.9 5495.6 5482.0 5547.9 5549.6 5628.0 5628.9 5434.2 5436.9 5439.6 5440.5 5488.1 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#1] ext.html Cycles:180 Average:58048.27 Median:42388.86 stddev:111016.75 (261.9%) stddev-sans-first:111244.42 08:40:40 INFO - PROCESS | 16533 | Values: 613.2 632.9 640.7 652.0 657.0 30081.5 32940.5 32940.7 33025.7 42000.4 44036.8 45299.3 45362.3 45418.3 45446.3 8785.8 8930.9 8931.6 8933.5 8935.6 8729.6 8828.6 8832.6 8836.2 8836.8 8863.5 8908.9 8909.2 8910.4 8926.2 8812.9 8850.0 8867.2 8873.1 8874.3 8793.9 8871.9 8871.9 8872.9 8879.8 41985.8 42486.0 42589.4 42713.6 42715.6 3325.8 3352.8 3468.5 3498.7 3499.5 32356.7 32708.0 32874.8 34009.1 34088.0 4342.2 4428.0 4441.3 4452.9 4457.4 336644.3 336824.0 336999.0 337487.0 337766.0 55763.4 55898.7 56015.4 56035.0 56443.7 57957.0 58100.1 58241.7 58259.2 58308.4 13965.5 14972.4 15300.0 15422.4 15744.5 11914.9 11926.3 12004.1 12022.7 12026.1 14725.1 15514.8 15826.4 15986.4 16008.8 5864.3 6085.5 6101.2 6152.4 6156.7 946.9 1002.7 1013.0 1028.5 1108.5 32120.5 32497.8 32710.3 32786.2 33315.5 1133.2 1170.8 1194.9 1207.0 1233.6 16998.2 17251.5 17273.9 17367.7 17445.2 478748.0 481262.0 482197.0 484946.0 487224.0 56520.7 57590.4 57696.0 57755.1 57850.4 1322.9 1340.5 1348.2 1355.9 1386.6 30466.2 32496.7 32536.8 32782.8 33058.0 50353.0 50617.5 50631.5 50745.0 50746.2 425420.0 426709.0 427284.0 427785.0 428225.0 40583.0 42004.2 42696.4 42789.6 42842.1 38157.8 42890.7 47865.0 49749.5 53729.0 38860.8 41823.6 42318.4 42459.4 42477.8 39998.6 41221.6 41563.6 41867.8 42089.8 40630.8 40929.2 41092.4 41387.8 42224.0 36424.6 36640.6 37060.4 37182.3 37775.4 27786.0 27940.9 28136.3 28225.3 28386.0 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#2] jquery.html Cycles:180 Average:27261.84 Median:20406.69 stddev:71867.76 (352.2%) stddev-sans-first:72041.02 08:40:40 INFO - PROCESS | 16533 | Values: 377.9 385.2 397.6 400.9 411.8 17388.2 18591.6 20328.0 20485.4 20539.8 18465.8 18592.0 19185.0 19527.7 19602.1 5074.3 5271.5 5290.1 5557.3 5906.9 5778.7 5784.7 5796.5 5816.2 5825.9 5513.9 5805.0 5805.1 5832.4 5838.2 5882.2 5889.2 5897.2 5911.6 5933.9 5618.1 5758.5 5763.2 5769.6 5769.7 12936.6 13223.3 13232.6 13481.1 13815.3 2145.1 2154.3 2187.5 2246.6 2309.2 9942.4 9944.9 10009.2 10449.4 10533.2 1823.9 1872.7 1886.0 1910.5 1948.1 68652.0 71835.3 76048.6 77888.6 79171.6 10848.1 10957.3 11289.8 11324.6 11539.5 15531.2 15539.9 15652.4 15653.4 15682.6 7773.8 7873.5 7903.1 7941.4 8042.4 7359.2 7426.6 7462.2 7540.5 7566.1 4832.3 4836.6 4865.6 4899.3 4921.4 1938.6 1952.9 1963.2 1966.7 1989.9 929.9 1034.5 1057.7 1071.0 1085.4 19251.2 19481.7 19531.3 19886.2 20088.5 981.4 989.7 990.8 1023.3 1043.4 9336.3 10936.9 11093.4 11186.4 11193.7 424983.0 428293.0 441340.0 441532.0 443064.0 57304.0 87584.0 88372.6 89792.0 90418.5 960.3 977.6 988.9 990.9 992.5 16905.2 17157.1 17204.9 17504.1 17899.9 41465.8 41987.6 42484.6 42554.0 43185.1 57926.0 58846.0 58936.4 60660.0 60922.2 12144.2 12545.7 12681.4 13013.0 13511.7 13708.8 14245.1 14327.1 14432.8 14828.8 12640.8 12710.4 12756.2 12983.0 13119.5 12118.3 12479.0 12481.9 12635.6 13028.5 11841.8 12677.9 13120.3 13184.0 13368.3 13157.3 13193.1 13210.1 13264.3 13382.7 12686.6 12758.3 12911.8 12971.4 13094.9 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#3] mootools.html Cycles:180 Average:5747.92 Median:4548.64 stddev:3333.30 (73.3%) stddev-sans-first:3325.62 08:40:40 INFO - PROCESS | 16533 | Values: 1265.2 1441.7 1486.9 1593.9 1757.2 8186.4 8581.0 8598.0 8821.8 8856.7 8519.2 8682.3 8710.1 8715.4 8720.6 1954.2 2146.4 2221.1 2256.6 2283.9 2265.5 2270.1 2271.7 2276.4 2282.7 2224.1 2227.9 2253.4 2254.4 2255.2 1718.9 2174.8 2176.6 2233.0 2234.4 2228.7 2234.3 2254.5 2257.2 2258.0 8265.4 8288.5 8312.1 8323.4 8348.6 4894.0 4998.1 5007.7 5010.2 5015.5 3053.6 3137.8 3231.2 3232.7 3241.6 1035.1 1035.4 1074.2 1082.0 1096.2 12089.2 12116.9 12118.5 12142.9 12166.4 4329.7 4391.2 4480.5 4496.6 4503.9 10069.7 10095.1 10098.4 10107.4 10107.6 5020.5 5082.4 5095.0 5097.4 5098.9 4213.8 4593.4 4672.9 4677.4 4715.4 3756.8 3767.8 3868.7 3870.6 3890.3 1092.6 1112.3 1117.7 1137.0 1170.8 804.7 868.6 898.9 899.4 938.8 5847.2 5906.1 5911.9 5981.5 6065.5 916.7 938.7 959.1 960.6 987.5 4044.4 4080.0 4136.9 4159.6 4183.3 10863.8 11020.7 11032.9 11146.3 11218.2 11034.0 11053.4 11097.1 11106.7 11130.2 7810.2 8167.3 8169.6 8287.4 8439.3 5919.6 6037.4 6082.8 6144.3 6147.1 10044.2 10272.7 10306.7 10327.1 10332.4 10023.2 10194.9 10541.6 10584.7 10701.3 7184.0 7352.5 7354.7 7636.3 7758.0 8055.8 8261.1 8436.4 8469.1 8758.7 7782.4 7863.3 7968.1 8006.4 8082.1 7618.3 7650.8 7714.7 7857.3 7941.3 7258.9 7273.7 7441.9 7463.6 7467.5 5057.3 5135.7 5137.2 5186.2 5245.7 5139.8 5179.9 5220.1 5348.6 5391.8 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#4] prototype.html Cycles:180 Average:4665.95 Median:5322.81 stddev:1372.34 (25.8%) stddev-sans-first:1336.86 08:40:40 INFO - PROCESS | 16533 | Values: 320.0 321.3 324.5 327.5 337.9 5192.8 5302.8 5302.9 5318.6 5327.0 5237.3 5267.7 5282.3 5310.4 5314.8 3926.0 3976.7 4079.3 4087.4 4089.5 4067.1 4070.6 4077.6 4096.7 4127.7 3877.6 4054.6 4062.1 4062.8 4066.4 3825.8 3976.2 3999.8 4108.2 4116.1 3629.7 3643.1 3671.4 3676.1 3684.7 5099.8 5111.9 5116.1 5130.7 5168.8 4561.6 4712.6 4733.3 4744.4 4751.2 5458.9 5470.2 5476.7 5496.9 5516.4 4043.3 4043.8 4044.4 4044.6 4065.9 5587.7 5618.6 5721.5 5725.1 5732.4 4130.3 4150.6 4155.6 4167.1 4167.2 4173.0 4188.1 4189.9 4208.8 4215.5 4638.4 4676.5 4679.3 4689.6 4780.0 5463.0 5468.7 5492.4 5519.4 5521.2 1433.3 1442.9 1450.8 1458.1 1464.1 904.7 943.6 946.6 947.7 948.7 5141.6 5286.3 5310.4 5357.2 5381.7 5643.3 5668.3 5672.3 5677.9 5701.5 5043.5 5245.7 5293.5 5339.8 5390.6 2974.2 2974.6 2997.4 3018.1 3023.9 5811.7 5855.8 5858.9 5914.5 5945.5 5619.5 5748.4 5788.4 5831.6 5843.2 5860.2 5865.9 5879.1 5909.1 5921.9 5413.8 5677.6 5711.8 5752.6 5775.2 5692.8 5707.2 5710.1 5717.8 5742.8 5919.8 5950.2 5961.3 6004.8 6016.2 3989.4 4016.0 4040.6 4058.5 4094.2 5681.9 5708.8 5726.4 5765.2 5766.4 5397.6 5566.7 5577.0 5633.7 5637.1 5478.2 5492.9 5510.7 5544.2 5582.0 5242.4 5460.7 5474.6 5495.8 5557.2 5439.6 5489.5 5501.6 5525.3 5565.0 5340.8 5374.9 5375.0 5412.8 5466.1 08:40:40 INFO - PROCESS | 16533 | 08:40:40 INFO - PROCESS | 16533 | [#5] yui.html Cycles:180 Average:20743.23 Median:45770.78 stddev:30372.23 (66.4%) stddev-sans-first:30420.14 08:40:40 INFO - PROCESS | 16533 | Values: 700.8 739.2 750.8 775.8 796.8 14777.3 15742.5 15747.4 15766.0 15817.6 14391.9 14637.5 14697.3 14844.2 14850.3 677.6 818.5 829.7 832.0 834.2 791.6 821.5 825.5 825.7 826.8 868.5 869.8 871.1 871.8 872.4 711.1 853.9 861.4 864.9 865.9 632.1 636.4 636.7 636.8 637.3 14040.8 14081.2 14094.7 14109.1 14113.6 13350.3 13664.2 13719.2 13737.5 13895.5 13143.7 13223.7 13428.1 13447.3 13657.1 3714.3 3831.6 3868.7 3979.1 3981.3 75878.6 76853.0 77213.6 78142.6 78228.6 11361.5 11396.2 11526.3 11771.9 11821.0 19324.1 19347.3 19417.2 19443.4 19448.2 8217.6 8471.2 8576.2 8745.3 9060.1 4781.2 4820.0 4885.5 4888.6 5086.6 3586.4 3738.3 3742.8 3742.9 3745.3 644.3 667.2 673.4 674.8 676.1 586.8 604.7 620.6 676.6 701.2 8469.2 8809.5 8830.2 8923.4 9035.0 562.9 581.8 615.1 715.1 720.1 4260.3 4295.1 4300.5 4323.5 4372.0 113384.4 117288.0 120155.0 120798.0 122153.0 96847.5 97383.0 97504.0 97547.5 97827.0 89742.7 89906.6 90005.0 90243.3 91257.1 8849.7 8968.6 8976.0 9078.0 9327.3 44406.6 47135.0 47152.5 48096.0 51409.7 70974.6 73760.0 74689.0 75005.6 77748.0 11748.7 11798.2 11888.1 12179.3 12263.3 14147.4 14285.7 14714.8 14941.6 15096.5 13375.9 13476.1 13572.0 13892.7 13897.5 11874.9 12318.8 12487.3 12767.7 12768.7 13260.1 13314.3 13326.0 13509.9 14129.1 10646.3 10801.9 11162.9 11232.6 11267.5 11218.3 11380.7 11455.4 11677.7 11794.4 08:40:40 INFO - PROCESS | 16533 | -------- Summary: end -------- 08:40:40 INFO - PROCESS | 16533 | 08:40:41 INFO - TEST-INFO | 16533: exit 0 08:40:41 INFO - TEST-OK | dromaeo_css | took 1115065ms 08:40:41 INFO - TEST-START | kraken 08:40:41 INFO - operating with platform_type : linux_ 08:40:41 INFO - Initialising browser for kraken test... 08:40:41 INFO - TEST-INFO | started process 16723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjR02zo/profile http://localhost:57939/getInfo.html) 08:40:46 INFO - PROCESS | 16723 | __metrics Screen width/height:1600/1200 08:40:46 INFO - PROCESS | 16723 | colorDepth:24 08:40:46 INFO - PROCESS | 16723 | Browser inner width/height: 1024/697 08:40:46 INFO - PROCESS | 16723 | __metrics 08:40:47 INFO - PROCESS | 16723 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:47 INFO - PROCESS | 16723 | console.error: PushService: 08:40:47 INFO - PROCESS | 16723 | stateChangeProcessEnqueue: Error transitioning state 08:40:47 INFO - PROCESS | 16723 | UnknownError 08:40:48 INFO - TEST-INFO | 16723: exit 0 08:40:48 INFO - Browser initialized. 08:40:48 INFO - Running cycle 1/1 for kraken test... 08:40:48 INFO - TEST-INFO | started process 16804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjR02zo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:00 INFO - PROCESS | 16804 | RSS: Main: 177467392 08:41:00 INFO - PROCESS | 16804 | 08:41:02 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:03 INFO - PROCESS | 16804 | RSS: Main: 236609536 08:41:03 INFO - PROCESS | 16804 | 08:41:06 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-dft) 08:41:06 INFO - PROCESS | 16804 | RSS: Main: 223535104 08:41:06 INFO - PROCESS | 16804 | 08:41:09 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-fft) 08:41:10 INFO - PROCESS | 16804 | RSS: Main: 289943552 08:41:10 INFO - PROCESS | 16804 | 08:41:12 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator) 08:41:13 INFO - PROCESS | 16804 | RSS: Main: 201162752 08:41:13 INFO - PROCESS | 16804 | 08:41:15 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:15 INFO - PROCESS | 16804 | RSS: Main: 205692928 08:41:15 INFO - PROCESS | 16804 | 08:41:18 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:19 INFO - PROCESS | 16804 | RSS: Main: 241840128 08:41:19 INFO - PROCESS | 16804 | 08:41:23 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:23 INFO - PROCESS | 16804 | RSS: Main: 237436928 08:41:23 INFO - PROCESS | 16804 | 08:41:26 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial) 08:41:27 INFO - PROCESS | 16804 | RSS: Main: 240197632 08:41:27 INFO - PROCESS | 16804 | 08:41:28 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:29 INFO - PROCESS | 16804 | RSS: Main: 228732928 08:41:29 INFO - PROCESS | 16804 | 08:41:30 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:31 INFO - PROCESS | 16804 | RSS: Main: 234283008 08:41:31 INFO - PROCESS | 16804 | 08:41:33 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:34 INFO - PROCESS | 16804 | RSS: Main: 238559232 08:41:34 INFO - PROCESS | 16804 | 08:41:36 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:37 INFO - PROCESS | 16804 | RSS: Main: 242278400 08:41:37 INFO - PROCESS | 16804 | 08:41:40 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:40 INFO - PROCESS | 16804 | RSS: Main: 241242112 08:41:40 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57939/tests/kraken/driver.html?testName=ai-astar) 08:41:42 INFO - PROCESS | 16804 | RSS: Main: 283729920 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | __start_tp_report 08:41:42 INFO - PROCESS | 16804 | _x_x_mozilla_page_load 08:41:42 INFO - PROCESS | 16804 | _x_x_mozilla_page_load_details 08:41:42 INFO - PROCESS | 16804 | |i|pagename|runs| 08:41:42 INFO - PROCESS | 16804 | |0;ai-astar;110;105;110;109;111;109;109;111;110;110 08:41:42 INFO - PROCESS | 16804 | |1;audio-beat-detection;147;123;135;176;127;128;160;125;165;132 08:41:42 INFO - PROCESS | 16804 | |2;audio-dft;163;160;159;161;160;162;160;160;161;162 08:41:42 INFO - PROCESS | 16804 | |3;audio-fft;76;74;75;121;75;79;75;74;98;75 08:41:42 INFO - PROCESS | 16804 | |4;audio-oscillator;85;86;107;85;85;85;113;84;88;137 08:41:42 INFO - PROCESS | 16804 | |5;imaging-gaussian-blur;117;116;117;116;116;117;117;117;116;117 08:41:42 INFO - PROCESS | 16804 | |6;imaging-darkroom;145;147;145;146;145;146;145;146;146;146 08:41:42 INFO - PROCESS | 16804 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;94;95 08:41:42 INFO - PROCESS | 16804 | |8;json-parse-financial;55;53;54;54;55;54;54;54;55;53 08:41:42 INFO - PROCESS | 16804 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;62;63;62 08:41:42 INFO - PROCESS | 16804 | |10;stanford-crypto-aes;81;79;78;78;79;85;81;84;110;82 08:41:42 INFO - PROCESS | 16804 | |11;stanford-crypto-ccm;126;123;122;121;119;121;122;128;151;125 08:41:42 INFO - PROCESS | 16804 | |12;stanford-crypto-pbkdf2;166;163;164;159;159;160;159;164;163;161 08:41:42 INFO - PROCESS | 16804 | |13;stanford-crypto-sha256-iterative;65;63;63;63;62;65;65;63;66;61 08:41:42 INFO - PROCESS | 16804 | __end_tp_report 08:41:42 INFO - PROCESS | 16804 | __start_cc_report 08:41:42 INFO - PROCESS | 16804 | _x_x_mozilla_cycle_collect,1650 08:41:42 INFO - PROCESS | 16804 | __end_cc_report 08:41:42 INFO - PROCESS | 16804 | __startTimestamp1466005302730__endTimestamp 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | ------- Summary: start ------- 08:41:42 INFO - PROCESS | 16804 | Number of tests: 14 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.80 08:41:42 INFO - PROCESS | 16804 | Values: 110.0 105.0 110.0 109.0 111.0 109.0 109.0 111.0 110.0 110.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:141.00 stddev:19.01 (13.5%) stddev-sans-first:20.07 08:41:42 INFO - PROCESS | 16804 | Values: 147.0 123.0 135.0 176.0 127.0 128.0 160.0 125.0 165.0 132.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 08:41:42 INFO - PROCESS | 16804 | Values: 163.0 160.0 159.0 161.0 160.0 162.0 160.0 160.0 161.0 162.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.44 (20.6%) stddev-sans-first:16.21 08:41:42 INFO - PROCESS | 16804 | Values: 76.0 74.0 75.0 121.0 75.0 79.0 75.0 74.0 98.0 75.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:17.89 (21.0%) stddev-sans-first:18.57 08:41:42 INFO - PROCESS | 16804 | Values: 85.0 86.0 107.0 85.0 85.0 85.0 113.0 84.0 88.0 137.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:41:42 INFO - PROCESS | 16804 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:41:42 INFO - PROCESS | 16804 | Values: 145.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:41:42 INFO - PROCESS | 16804 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 08:41:42 INFO - PROCESS | 16804 | Values: 55.0 53.0 54.0 54.0 55.0 54.0 54.0 54.0 55.0 53.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:41:42 INFO - PROCESS | 16804 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 63.0 62.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:81.00 stddev:9.55 (11.8%) stddev-sans-first:10.07 08:41:42 INFO - PROCESS | 16804 | Values: 81.0 79.0 78.0 78.0 79.0 85.0 81.0 84.0 110.0 82.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:124.00 stddev:9.25 (7.5%) stddev-sans-first:9.81 08:41:42 INFO - PROCESS | 16804 | Values: 126.0 123.0 122.0 121.0 119.0 121.0 122.0 128.0 151.0 125.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:163.00 stddev:2.53 (1.6%) stddev-sans-first:2.18 08:41:42 INFO - PROCESS | 16804 | Values: 166.0 163.0 164.0 159.0 159.0 160.0 159.0 164.0 163.0 161.0 08:41:42 INFO - PROCESS | 16804 | 08:41:42 INFO - PROCESS | 16804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.59 08:41:42 INFO - PROCESS | 16804 | Values: 65.0 63.0 63.0 63.0 62.0 65.0 65.0 63.0 66.0 61.0 08:41:42 INFO - PROCESS | 16804 | -------- Summary: end -------- 08:41:42 INFO - PROCESS | 16804 | 08:41:43 INFO - TEST-INFO | 16804: exit 0 08:41:43 INFO - TEST-OK | kraken | took 62553ms 08:41:43 INFO - SUITE-END | took 1177s 08:41:43 INFO - Completed test suite (00:19:37) 08:41:43 INFO - javascript benchmark 08:41:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.0142703621314, 3054.0990407829686, 3068.447679417704, 3078.245829771706, 3100.720935115839, 5193.195054766513, 5225.6603320784125, 5303.946960530394, 5304.2043693446, 5356.892862142755, 5194.818181363653, 5205.219217117435, 5210.791568337271, 5214.7653355598995, 5264.657797243177, 4678.649101317406, 4748.8575342739605, 4758.072175925696, 4762.952370476286, 4893.510648935114, 4803.135435621587, 4829.4687584365865, 4844.346013288196, 4859.708417494944, 4882.43851957026, 4730.810767569293, 4751.714897106184, 4810.855674329776, 4814.013127308928, 4891.853244402673, 4763.714177149347, 4782.569568738795, 4792.089502994455, 4794.976025119887, 4873.366462359906, 4785.353977213102, 4806.49531799163, 4815.711057336536, 4840.733759643218, 4867.075255701406, 5160.303359046518, 5198.038362902875, 5288.338957630296, 5289.2859463972645, 5352.545033672142, 5609.0, 5619.831405057855, 5637.182608521783, 5654.236678048452, 5676.602637815355, 5721.199032135504, 5728.484436400744, 5766.336871259775, 5769.942300576982, 5770.711464426762, 5182.4299327073995, 5231.947680523184, 5258.395284542288, 5258.789648414059, 5309.681419114865, 5805.216295800013, 5810.360860305363, 5811.767529298865, 5823.097419899922, 5823.242978412779, 5385.569154467633, 5569.331680198402, 5576.0, 5576.414476479992, 5580.218769372291, 5521.337439507285, 5629.971850140805, 5630.07103827872, 5643.068893632587, 5646.407127251661, 5624.184493248456, 5631.859203519863, 5633.577481688808, 5642.774289028475, 5647.6329038613185, 5568.665880047129, 5583.972080139654, 5633.915491267634, 5642.379338272869, 5651.773929042793, 4369.4101296325225, 4377.606015458624, 4379.802908869108, 4397.692161548661, 4424.0709451015, 3894.5910679378826, 3909.5113110861143, 3918.0204948762807, 3922.8234729437245, 3950.071733142709, 5151.793928242903, 5224.869378265574, 5265.0, 5379.085555455582, 5413.783448662089, 5657.434256574392, 5671.064274394761, 5684.54523638108, 5712.343080545707, 5760.423957604206, 5317.574594032468, 5335.733213339317, 5347.2781174541715, 5355.0, 5356.7321633918145, 4805.807767689324, 4899.877503062452, 4938.851834444972, 4956.10790057793, 4990.900181996412, 5929.14027466015, 5937.228160339215, 5937.554683398763, 5940.732667029994, 5981.581289309794, 5716.114002329646, 5735.71321433935, 5737.282839645044, 5739.110437882135, 5745.540356771532, 5619.662820230799, 5692.658440493584, 5701.600887937971, 5755.3381361144, 5901.498372638202, 5492.286002819767, 5492.340919089735, 5493.121100623881, 5498.395176530658, 5500.559955203654, 5531.1426728857095, 5551.833444996657, 5568.387477377566, 5573.888522229614, 5624.381318054929, 5395.0, 5477.20580515831, 5477.260569823023, 5535.3634332050715, 5565.972170139124, 5515.448455154453, 5523.088690366205, 5524.779008839601, 5535.086710692691, 5536.141898005815, 5309.097453433003, 5393.487618676219, 5429.809956651498, 5443.863903402446, 5495.5878309127775, 5481.972590137024, 5547.861303467445, 5549.639273447213, 5628.0432326505415, 5628.915566266427, 5434.184872269191, 5436.918446223231, 5439.646422982493, 5440.455954404528, 5488.121900495901], "value": 5209.38046273438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.1660941120076, 632.9145565348678, 640.7308930249297, 651.9511036672251, 656.967151642418, 30081.548776768366, 32940.50589241163, 32940.67059329409, 33025.66974330256, 42000.36999445003, 44036.779816100956, 45299.320510192374, 45362.31956520655, 45418.31872521907, 45446.318305225366, 8785.824283514326, 8930.910690893073, 8931.598078086468, 8933.508657023862, 8935.64257429702, 8729.563521823915, 8828.646854125827, 8832.558372081403, 8836.204741573258, 8836.779080522974, 8863.468191908474, 8908.910910890872, 8909.153630405133, 8910.42082264654, 8926.152015558511, 8812.867806982867, 8850.0, 8867.201951824301, 8873.11268873114, 8874.290056795473, 8793.868091978626, 8871.86692199611, 8871.866921996176, 8872.911270887273, 8879.778005549848, 41985.790071049756, 42486.0, 42589.36115958263, 42713.57286427127, 42715.57284427147, 3325.800451972865, 3352.798832070084, 3468.479728040789, 3498.6676265754713, 3499.5100685903994, 32356.676433235603, 32708.0, 32874.83562582196, 34009.14977125567, 34088.0, 4342.1532801103795, 4428.0, 4441.333799930004, 4452.933206001912, 4457.442819647544, 336644.316778417, 336824.0, 336999.0, 337487.0, 337766.0, 55763.44236557664, 55898.72050639721, 56015.43984560184, 56035.0, 56443.71778141083, 57957.0, 58100.12849807256, 58241.70879145577, 58259.1740825914, 58308.4169158303, 13965.511207107906, 14972.401103955719, 15300.0, 15422.383104675688, 15744.527664170093, 11914.940425297818, 11926.284422934652, 12004.099692523096, 12022.699432514257, 12026.098042646836, 14725.116493010453, 15514.844851551567, 15826.44607438734, 15986.360545578047, 16008.759868601981, 5864.266966629171, 6085.513158947274, 6101.206843110456, 6152.415520525543, 6156.722947467375, 946.8579713043099, 1002.7292630989592, 1012.9746756331003, 1028.547439126782, 1108.4790148630132, 32120.518192227137, 32497.8392394125, 32710.345793084005, 32786.18034549108, 33315.500267496005, 1133.1897693149438, 1170.8302296167008, 1194.8685644579089, 1206.9939650301692, 1233.5805826019196, 16998.150092495573, 17251.482455526355, 17273.91363043202, 17367.65264694699, 17445.21496532659, 478748.0, 481262.0, 482197.0, 484946.0, 487224.0, 56520.71739641276, 57590.424095758506, 57696.0, 57755.13367299494, 57850.42149578535, 1322.8941684665203, 1340.4839136932546, 1348.1843484691817, 1355.945762169522, 1386.646405166676, 30466.23834404069, 32496.675033249365, 32536.83731581327, 32782.83608581942, 33058.0, 50353.0, 50617.493825061276, 50631.49368506268, 50745.0, 50746.2388064172, 425420.0, 426709.0, 427284.0, 427785.0, 428225.0, 40583.0, 42004.159916802106, 42696.35955460733, 42789.57210427856, 42842.1431571373, 38157.80921095377, 42890.713278601695, 47865.0, 49749.50250497449, 53729.0, 38860.80569597247, 41823.58176418319, 42318.36522452104, 42459.363109554, 42477.78761106298, 39998.60001399949, 41221.58778412177, 41563.58436415597, 41867.81321867789, 42089.789551053276, 40630.79684601676, 40929.1814163721, 41092.383614246406, 41387.7930610345, 42224.0, 36424.63575364318, 36640.63359366372, 37060.44409333808, 37182.25635487221, 37775.433368500046, 27786.0, 27940.860295698392, 28136.29659258535, 28225.294367640974, 28386.0], "value": 19892.18539426323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9244151169766, 385.19878652403, 397.5547386926643, 400.92382447335024, 411.7899871065757, 17388.21753021114, 18591.628167436644, 20328.0, 20485.385438436835, 20539.794602053975, 18465.815341846577, 18592.0, 19185.0, 19527.707084393747, 19602.11790469429, 5074.314967479389, 5271.499207575274, 5290.074237008527, 5557.277553917985, 5906.911396329058, 5778.682172480512, 5784.739686714108, 5796.478316951474, 5816.214811000503, 5825.941740582603, 5513.862153446176, 5805.0, 5805.10020946754, 5832.387599302076, 5838.153467747175, 5882.176495290662, 5889.1755154278435, 5897.20387747655, 5911.645301281937, 5933.910991335133, 5618.129189975561, 5758.48173664368, 5763.221965034751, 5769.596128271022, 5769.682667453289, 12936.611901642966, 13223.272720000492, 13232.603021909357, 13481.123726957716, 13815.309234538334, 2145.0668959002883, 2154.278316763886, 2187.4859408039097, 2246.618074927266, 2309.2379514760087, 9942.353747006422, 9944.900550994542, 10009.249306302056, 10449.425281609509, 10533.157347412189, 1823.8996855172961, 1872.6535590915723, 1885.9622807543772, 1910.512819231101, 1948.0551932312958, 68652.0, 71835.28164718338, 76048.61975690087, 77888.61055694742, 79171.60414197893, 10848.077913377452, 10957.315457712912, 11289.830652540219, 11324.6036388726, 11539.48072336747, 15531.22343882824, 15539.922300388425, 15652.373905043898, 15653.373865045498, 15682.607934801494, 7773.805654858674, 7873.488223265469, 7903.130655627876, 7941.444098913021, 8042.437029407885, 7359.190489046201, 7426.62866856655, 7462.216467270967, 7540.547567145989, 7566.092068951761, 4832.34763306949, 4836.613070954315, 4865.56209941107, 4899.265110233422, 4921.384826896638, 1938.6025864697704, 1952.9023548822502, 1963.2441510018746, 1966.7049942508452, 1989.8806071635747, 929.9488528130883, 1034.5189486888632, 1057.6826951914395, 1070.9718670076813, 1085.4355735017905, 19251.22995080181, 19481.707774383394, 19531.316403925794, 19886.204551817766, 20088.497787555134, 981.4276035231762, 989.6981420666622, 990.7572644702094, 1023.2683631203726, 1043.3635482355758, 9336.253099752004, 10936.890631093587, 11093.389863557582, 11186.44067796607, 11193.66419007431, 424983.0, 428293.0, 441340.0, 441532.0, 443064.0, 57304.0, 87584.0, 88372.55813721019, 89792.0, 90418.54790726135, 960.3325688646463, 977.5649835822991, 988.8615593816871, 990.8959559246175, 992.5235886774244, 16905.239264232892, 17157.142142892557, 17204.91397543004, 17504.124793760006, 17899.910500447415, 41465.792671037656, 41987.580124198365, 42484.575154248065, 42554.0, 43185.136297274505, 57926.0, 58846.0, 58936.410635894805, 60660.0, 60922.17233483003, 12144.210626309261, 12545.749085018431, 12681.365931703562, 13013.024023198108, 13511.729765404834, 13708.794368084287, 14245.145291282142, 14327.068740531831, 14432.783508247594, 14828.7775683367, 12640.810387844005, 12710.36448177606, 12756.234625922474, 12983.0, 13119.475220991435, 12118.333491658044, 12479.0, 12481.875181248435, 12635.620931372074, 13028.478860845838, 11841.82237266459, 12677.936610316889, 13120.278384688934, 13184.0, 13368.331583420984, 13157.34213289351, 13193.076484645982, 13210.07529472966, 13264.33678316061, 13382.732345352844, 12686.619401417973, 12758.298293593942, 12911.806322904977, 12971.416286266953, 13094.934525327313], "value": 9330.925295066392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.2155663488627, 1441.7332793433213, 1486.9033512821666, 1593.8804589655772, 1757.1653464604315, 8186.386021048423, 8581.0, 8597.957010214948, 8821.779455513599, 8856.690015849446, 8519.1906768857, 8682.26200772935, 8710.128987101287, 8715.433496822701, 8720.563971801415, 1954.2476146683557, 2146.399008277685, 2221.1448592292004, 2256.6050941085286, 2283.908643654252, 2265.4562904902787, 2270.0692715986447, 2271.6819645249598, 2276.4195130241847, 2282.6918366020623, 2224.143704673704, 2227.855189412683, 2253.43664083979, 2254.357508110189, 2255.1881322723807, 1718.8968661880326, 2174.8477606567467, 2176.5973294940486, 2233.0286325448483, 2234.4078819112947, 2228.665700144975, 2234.318532847481, 2254.4927391336983, 2257.164849005862, 2258.006477150065, 8265.380096492787, 8288.461250018729, 8312.085670576233, 8323.417360784748, 8348.582570871433, 4894.045661096087, 4998.12532806761, 5007.724575148365, 5010.248462730583, 5015.498450154992, 3053.618297712786, 3137.8274194919272, 3231.2083539532964, 3232.739231699639, 3241.6272128705264, 1035.0684384054337, 1035.3703328802333, 1074.2426589254558, 1082.0423924826507, 1096.2381145104155, 12089.153759236857, 12116.939415302955, 12118.515259389615, 12142.939285303606, 12166.391680415943, 4329.718568293051, 4391.209582275221, 4480.484744254387, 4496.550344965477, 4503.909921801545, 10069.748256293651, 10095.141912937335, 10098.394096354243, 10107.444090575089, 10107.64623238183, 5020.548150666457, 5082.364704411949, 5095.0, 5097.413797413271, 5098.923516147261, 4213.789310534522, 4593.379893714373, 4672.859814205579, 4677.368555244999, 4715.363425937523, 3756.8121593920196, 3767.773933563995, 3868.709846761504, 3870.612938706107, 3890.280298144796, 1092.5848177692585, 1112.282577737371, 1117.6982214801958, 1137.0448822988565, 1170.7716995185856, 804.7022601637315, 868.561376504861, 898.9280857531381, 899.4288626722079, 938.7653086728318, 5847.210626565445, 5906.143609176645, 5911.881762364728, 5981.461668449861, 6065.514758819284, 916.7387294621001, 938.7183844846519, 959.1463597398321, 960.6013504395737, 987.479281905857, 4044.4337792709043, 4079.9592004079577, 4136.91726165475, 4159.625633692922, 4183.309753890574, 10863.83704244437, 11020.669379918616, 11032.889671103347, 11146.331220126818, 11218.158638102175, 11034.0, 11053.447327633587, 11097.056750176163, 11106.722331941766, 11130.165237607212, 7810.218978102144, 8167.264946154755, 8169.591520423955, 8287.419880608299, 8439.324854011664, 5919.585629005928, 6037.426444487766, 6082.847928801815, 6144.262688477233, 6147.108669243024, 10044.246681498771, 10272.743181420225, 10306.742331441774, 10327.122194613241, 10332.380057196593, 10023.248256380946, 10194.949025255122, 10541.631042913461, 10584.735381615521, 10701.304415212986, 7183.964080179775, 7352.5220860643885, 7354.70581176747, 7636.31273185416, 7758.0, 8055.838883222185, 8261.09127995932, 8436.367272454714, 8469.110743372104, 8758.737237882873, 7782.416318776001, 7863.292303692695, 7968.123506414406, 8006.399520035904, 8082.070561885458, 7618.276263754934, 7650.846983060419, 7714.6914123434435, 7857.2928436441, 7941.285284324438, 7258.874874394477, 7273.672684729306, 7441.888371674538, 7463.626818659154, 7467.514611550232, 5057.317262169707, 5135.666181698178, 5137.2037334213255, 5186.222066690027, 5245.737713114253, 5139.8458046258675, 5179.948200518097, 5220.086484865057, 5348.57211423093, 5391.75737091824], "value": 4544.082365996638, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.0414757800387, 321.2755236940698, 324.508369819723, 327.4776731113874, 337.86147679451415, 5192.766325515351, 5302.780360517083, 5302.939412117577, 5318.6011049171275, 5327.014502317074, 5237.266782650432, 5267.683938963665, 5282.31329927109, 5310.4424035476295, 5314.76083576239, 3926.0, 3976.701747368959, 4079.3473044312914, 4087.4073259377374, 4089.488813898263, 4067.1087944105984, 4070.5522392536795, 4077.633013028827, 4096.746789265907, 4127.7204066739405, 3877.592852750463, 4054.6350828425434, 4062.0860306431114, 4062.8171732272117, 4066.369712694522, 3825.827837747308, 3976.2047590481875, 3999.8000599820084, 4108.2129273766, 4116.135611521584, 3629.709623230135, 3643.125649844045, 3671.375866102769, 3676.1361080146144, 3684.7236457265544, 5099.821506247301, 5111.897762044776, 5116.079105760961, 5130.71781052042, 5168.8449346519665, 4561.612262957653, 4712.599429048535, 4733.337332773414, 4744.410622441486, 4751.216049351853, 5458.918116228259, 5470.234167216593, 5476.698781567052, 5496.862578435571, 5516.448355164492, 4043.3111980533204, 4043.7978101094827, 4044.3529035354204, 4044.5955404459614, 4065.918681626351, 5587.664740115606, 5618.550515958714, 5721.513671337942, 5725.141228815669, 5732.398098199671, 4130.256553820281, 4150.6471949884, 4155.58444155582, 4167.06241095751, 4167.2082304362075, 4173.0, 4188.120494696087, 4189.937150942738, 4208.831646734157, 4215.48242632652, 4638.353384548504, 4676.50896655853, 4679.298105284167, 4689.60138388234, 4779.976100119477, 5463.0, 5468.671879687152, 5492.363665440611, 5519.420460851633, 5521.199426083276, 1433.3120102350929, 1442.917811641269, 1450.775129854853, 1458.1105525629357, 1464.1434760665131, 904.6878826804742, 943.6461327002374, 946.6118891254553, 947.6967370441392, 948.6821914658528, 5141.614378921596, 5286.312779338661, 5310.415854256029, 5357.249985002103, 5381.730913454312, 5643.266375371176, 5668.26312579362, 5672.298310506914, 5677.914831277534, 5701.543876489871, 5043.52086551777, 5245.7114858683135, 5293.497117773805, 5339.81310654133, 5390.595705322116, 2974.1523665755158, 2974.5757207875513, 2997.4454725875785, 3018.079485756821, 3023.8639261233297, 5811.680357580289, 5855.824325270249, 5858.857522783102, 5914.526837852962, 5945.494632956161, 5619.466150715675, 5748.367679555246, 5788.421157884262, 5831.620944638585, 5843.18195452637, 5860.208871802337, 5865.9441300566305, 5879.118132280021, 5909.054551271776, 5921.911171332434, 5413.7834486620095, 5677.574181936288, 5711.828645140652, 5752.597318187687, 5775.249217601685, 5692.800751973661, 5707.20099186106, 5710.143478478261, 5717.799877004285, 5742.7702891883855, 5919.7632094717455, 5950.166976623363, 5961.330827368344, 6004.759809607567, 6016.157737916783, 3989.4414781929972, 4015.9799201003807, 4040.616141466556, 4058.512978442606, 4094.242565125461, 5681.9431805681415, 5708.771649133988, 5726.370099289158, 5765.221695071112, 5766.394528574439, 5397.622166448311, 5566.68982372311, 5577.0, 5633.661980281032, 5637.126245431965, 5478.205660179331, 5492.890142197054, 5510.669359838423, 5544.168374743659, 5582.0, 5242.397124330751, 5460.726963651722, 5474.616776825584, 5495.752691128829, 5557.166425036277, 5439.5920305978, 5489.505944465017, 5501.642393244426, 5525.309336332958, 5564.998300305984, 5340.78636854537, 5374.865628359323, 5374.973125134349, 5412.783488660567, 5466.125419932791], "value": 4227.745624713962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7547358424551, 739.1610522057463, 750.7747675697291, 775.8176828445314, 796.8286818334057, 14777.335019924103, 15742.527724168265, 15747.448839290628, 15765.999999999985, 15817.60455988601, 14391.856081439182, 14637.487687930925, 14697.265136743146, 14844.183569903651, 14850.257487125655, 677.6306912732548, 818.5007145641155, 829.7344849648115, 832.0182185021672, 834.1658341658342, 791.6121100660692, 821.48246604639, 825.5046971816922, 825.6573521988367, 826.8222332198576, 868.4789126524066, 869.7782065573269, 871.0723079919896, 871.7689812199773, 872.4067634008871, 711.1359697966943, 853.8591132463137, 861.3711990247124, 864.9264812490945, 865.8701194820795, 632.0519221168248, 636.3858876184504, 636.7039326713101, 636.8216899268213, 637.2512298049819, 14040.789388159186, 14081.225532595703, 14094.71810563783, 14109.082909610843, 14113.647158821112, 13350.332483375889, 13664.248466334348, 13719.176849389069, 13737.519186828413, 13895.513657022057, 13143.671408214776, 13223.669408264774, 13428.127171733806, 13447.32763361828, 13657.112287701368, 3714.275716235335, 3831.578526362098, 3868.7485313454536, 3979.144483935968, 3981.3231750602467, 75878.62060689661, 76853.0, 77213.61393193054, 78142.60928695377, 78228.60885695535, 11361.488733007034, 11396.202265841477, 11526.250793698382, 11771.88228117725, 11821.0, 19324.130414131116, 19347.322843700404, 19417.223311067683, 19443.4166974991, 19448.222071116998, 8217.630206640715, 8471.195236452528, 8576.185262400062, 8745.344099192585, 9060.139286767746, 4781.187198176319, 4820.0, 4885.511448855086, 4888.608911287089, 5086.593072554187, 3586.444101164324, 3738.2897249522503, 3742.8315725792404, 3742.925141497155, 3745.2696724139078, 644.262319644005, 667.1860330396908, 673.4040374268808, 674.7672053141658, 676.1176664452838, 586.806353903211, 604.6916072802815, 620.5687047502033, 676.6278546799241, 701.235653138082, 8469.237768600855, 8809.515476648718, 8830.249428798496, 8923.41997770143, 9035.00614932357, 562.9127485239794, 581.7702007707016, 615.1080932647678, 715.0811207598211, 720.1106633307861, 4260.25445547028, 4295.119500502389, 4300.505441874225, 4323.524412314643, 4371.956280437218, 113384.43307783408, 117288.0, 120155.0, 120798.0, 122153.0, 96847.51576242215, 97383.0, 97504.0, 97547.51226243965, 97827.0, 89742.65386019215, 89906.55046724855, 90005.0, 90243.29270121775, 91257.08742912619, 8849.734507964771, 8968.596413161555, 8976.0, 9077.95461022717, 9327.300452465957, 44406.55593444024, 47135.0, 47152.528474716186, 48096.0, 51409.74295128501, 70974.64512677403, 73760.0, 74689.0, 75005.62497187479, 77748.0, 11748.70628234301, 11798.184513333415, 11888.108391870472, 12179.269243845398, 12263.26420414778, 14147.36336864823, 14285.714285714435, 14714.77927831062, 14941.626459338604, 15096.54710358691, 13375.933120334335, 13476.124051936593, 13572.0, 13892.72214555683, 13897.513587024405, 11874.940625296818, 12318.75362492763, 12487.31319777421, 12767.680807979876, 12768.6807829805, 13260.138091024053, 13314.267715275366, 13326.0, 13509.856306598856, 14129.081609695337, 10646.307989980627, 10801.94772930519, 11162.888371116185, 11232.606858759904, 11267.549298027987, 11218.326900386002, 11380.715482113013, 11455.427228638368, 11677.708057298296, 11794.351310677652], "value": 7449.814714934542, "unit": "score"}], "name": "dromaeo_css", "value": 7192.115224523767, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 109.0, 111.0, 109.0, 109.0, 111.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 135.0, 176.0, 127.0, 128.0, 160.0, 125.0, 165.0, 132.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 161.0, 160.0, 162.0, 160.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 121.0, 75.0, 79.0, 75.0, 74.0, 98.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 107.0, 85.0, 85.0, 85.0, 113.0, 84.0, 88.0, 137.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 78.0, 79.0, 85.0, 81.0, 84.0, 110.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 122.0, 121.0, 119.0, 121.0, 122.0, 128.0, 151.0, 125.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 159.0, 159.0, 160.0, 159.0, 164.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 62.0, 65.0, 65.0, 63.0, 66.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1498.1, "alertThreshold": 2.0}]} 08:41:43 INFO - Return code: 0 08:41:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:44 INFO - # TBPL SUCCESS # 08:41:44 INFO - Running post-action listener: _resource_record_post_action 08:41:44 INFO - ##### 08:41:44 INFO - ##### Finished run-tests step (success) 08:41:44 INFO - ##### 08:41:44 INFO - Running post-run listener: _resource_record_post_run 08:41:44 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548630528; Read time: 12; Write time: 1447492 08:41:44 INFO - TinderboxPrint: CPU usage
13.2% 08:41:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:41:44 INFO - TinderboxPrint: I/O write bytes / time
548,630,528 / 1,447,492 08:41:44 INFO - TinderboxPrint: CPU idle
8,286.7 (86.7%) 08:41:44 INFO - TinderboxPrint: CPU user
1,207.1 (12.6%) 08:41:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:41:44 INFO - install - Wall time: 19s; CPU: 16.0%; Read bytes: 0; Write bytes: 256045056; Read time: 0; Write time: 729252 08:41:44 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292425728; Read time: 12; Write time: 718200 08:41:44 INFO - Running post-run listener: _upload_blobber_files 08:41:44 INFO - Blob upload gear active. 08:41:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:44 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:41:44 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:41:44 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:41:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:49 INFO - (blobuploader) - INFO - Done attempting. 08:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:50 INFO - (blobuploader) - INFO - Done attempting. 08:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:51 INFO - (blobuploader) - INFO - Done attempting. 08:41:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:51 INFO - Return code: 0 08:41:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95691cc18c24351b4b026671fa69571f4d3f5b186f2488965e401c58d71b769e941f2aba3bf4a6d0f426a30a9cf2f7ae415f9c82cb94477aa44b1ec280bea7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96252778ba682f462f0751be58862f8446bdd5e1023e5d6c551e31e7afe6a27e06e30af5da62f3c27cb6b834e9249afccf34d5e323a162c69ec94cd7f9edf620", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73ae6de4f7c1587bbc0eac9746ce37c0b91fd90987b1b46b66b78bfa1f09b705573bc9d240210a2de249ea6c01c4c9d26cca58d7d9a2d722cbb4a7470fa22a74"} 08:41:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:51 INFO - Contents: 08:41:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95691cc18c24351b4b026671fa69571f4d3f5b186f2488965e401c58d71b769e941f2aba3bf4a6d0f426a30a9cf2f7ae415f9c82cb94477aa44b1ec280bea7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96252778ba682f462f0751be58862f8446bdd5e1023e5d6c551e31e7afe6a27e06e30af5da62f3c27cb6b834e9249afccf34d5e323a162c69ec94cd7f9edf620", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73ae6de4f7c1587bbc0eac9746ce37c0b91fd90987b1b46b66b78bfa1f09b705573bc9d240210a2de249ea6c01c4c9d26cca58d7d9a2d722cbb4a7470fa22a74"} 08:41:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:51 INFO - Copying logs to upload dir... 08:41:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.717894 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-15 08:41:50.818528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:50.821780) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 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/95691cc18c24351b4b026671fa69571f4d3f5b186f2488965e401c58d71b769e941f2aba3bf4a6d0f426a30a9cf2f7ae415f9c82cb94477aa44b1ec280bea7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96252778ba682f462f0751be58862f8446bdd5e1023e5d6c551e31e7afe6a27e06e30af5da62f3c27cb6b834e9249afccf34d5e323a162c69ec94cd7f9edf620", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73ae6de4f7c1587bbc0eac9746ce37c0b91fd90987b1b46b66b78bfa1f09b705573bc9d240210a2de249ea6c01c4c9d26cca58d7d9a2d722cbb4a7470fa22a74"} 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.011295 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/95691cc18c24351b4b026671fa69571f4d3f5b186f2488965e401c58d71b769e941f2aba3bf4a6d0f426a30a9cf2f7ae415f9c82cb94477aa44b1ec280bea7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96252778ba682f462f0751be58862f8446bdd5e1023e5d6c551e31e7afe6a27e06e30af5da62f3c27cb6b834e9249afccf34d5e323a162c69ec94cd7f9edf620", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73ae6de4f7c1587bbc0eac9746ce37c0b91fd90987b1b46b66b78bfa1f09b705573bc9d240210a2de249ea6c01c4c9d26cca58d7d9a2d722cbb4a7470fa22a74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:50.848726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:50.849147) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466000922.172975-90857063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:50.932600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:41:50.933056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:41:50.933482) ========= ========= Total master_lag: 0.18 =========