builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1466619459.2 results: success (0) buildid: 20160622083013 builduid: d7a5aa66e5e0435b83f43372cd86b620 revision: b5fa754a35da091bb0c2b197317cd5627f6c8486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.203949) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.204403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.204681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.233096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.233391) ========= 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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 11:17:40-- 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% 43.2M=0s 2016-06-22 11:17:40 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.354724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.355045) ========= 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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015197 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:39.405643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 11:17:39.405972) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b5fa754a35da091bb0c2b197317cd5627f6c8486 --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 b5fa754a35da091bb0c2b197317cd5627f6c8486 --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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 11:17:40,887 truncating revision to first 12 chars 2016-06-22 11:17:40,887 Setting DEBUG logging. 2016-06-22 11:17:40,887 attempt 1/10 2016-06-22 11:17:40,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b5fa754a35da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 11:17:41,827 unpacking tar archive at: fx-team-b5fa754a35da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 11:17:40.709072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:40.709360) ========= script_repo_revision: b5fa754a35da091bb0c2b197317cd5627f6c8486 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:40.709740) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:40.710005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 11:17:40.720362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-22 11:17:40.720633) ========= /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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:42 INFO - MultiFileLogger online at 20160622 11:17:42 in /builds/slave/test 11:17:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:17:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:42 INFO - {'append_to_log': False, 11:17:42 INFO - 'base_work_dir': '/builds/slave/test', 11:17:42 INFO - 'blob_upload_branch': 'Fx-Team', 11:17:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:42 INFO - 'branch': 'Fx-Team', 11:17:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:42 INFO - 'config_files': ('talos/linux_config.py',), 11:17:42 INFO - 'default_actions': ('clobber', 11:17:42 INFO - 'read-buildbot-config', 11:17:42 INFO - 'download-and-extract', 11:17:42 INFO - 'populate-webroot', 11:17:42 INFO - 'create-virtualenv', 11:17:42 INFO - 'install', 11:17:42 INFO - 'run-tests'), 11:17:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:42 INFO - 'download_minidump_stackwalk': True, 11:17:42 INFO - 'download_symbols': 'ondemand', 11:17:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:42 INFO - 'installer_path': 'installer.exe', 11:17:42 INFO - 'log_level': 'info', 11:17:42 INFO - 'log_name': 'talos', 11:17:42 INFO - 'log_to_console': True, 11:17:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:42 INFO - 'opt_config_files': (), 11:17:42 INFO - 'pip_index': False, 11:17:42 INFO - 'sps_profile': False, 11:17:42 INFO - 'sps_profile_interval': 0, 11:17:42 INFO - 'suite': 'dromaeojs', 11:17:42 INFO - 'system_bits': '32', 11:17:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:42 INFO - 'title': 'talos-linux64-ix-065', 11:17:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:42 INFO - 'use_talos_json': True, 11:17:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:42 INFO - 'work_dir': 'build'} 11:17:42 INFO - ##### 11:17:42 INFO - ##### Running clobber step. 11:17:42 INFO - ##### 11:17:42 INFO - Running pre-action listener: _resource_record_pre_action 11:17:42 INFO - Running main action method: clobber 11:17:42 INFO - rmtree: /builds/slave/test/build 11:17:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:42 INFO - Running post-action listener: _resource_record_post_action 11:17:42 INFO - ##### 11:17:42 INFO - ##### Finished clobber step (success) 11:17:42 INFO - ##### 11:17:42 INFO - ##### 11:17:42 INFO - ##### Running read-buildbot-config step. 11:17:42 INFO - ##### 11:17:42 INFO - Running pre-action listener: _resource_record_pre_action 11:17:42 INFO - Running main action method: read_buildbot_config 11:17:42 INFO - Using buildbot properties: 11:17:42 INFO - { 11:17:42 INFO - "project": "", 11:17:42 INFO - "product": "firefox", 11:17:42 INFO - "script_repo_revision": "production", 11:17:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:17:42 INFO - "repository": "", 11:17:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:17:42 INFO - "buildid": "20160622083013", 11:17:42 INFO - "pgo_build": "True", 11:17:42 INFO - "basedir": "/builds/slave/test", 11:17:42 INFO - "buildnumber": 1276, 11:17:42 INFO - "slavename": "talos-linux64-ix-065", 11:17:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:17:42 INFO - "platform": "ubuntu64_hw", 11:17:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:17:42 INFO - "branch": "fx-team", 11:17:42 INFO - "repo_path": "integration/fx-team", 11:17:42 INFO - "revision": "b5fa754a35da091bb0c2b197317cd5627f6c8486", 11:17:42 INFO - "stage_platform": "linux64-pgo", 11:17:42 INFO - "builduid": "d7a5aa66e5e0435b83f43372cd86b620", 11:17:42 INFO - "slavebuilddir": "test" 11:17:42 INFO - } 11:17:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:17:42 INFO - Running post-action listener: _resource_record_post_action 11:17:42 INFO - ##### 11:17:42 INFO - ##### Finished read-buildbot-config step (success) 11:17:42 INFO - ##### 11:17:42 INFO - ##### 11:17:42 INFO - ##### Running download-and-extract step. 11:17:42 INFO - ##### 11:17:42 INFO - Running pre-action listener: _resource_record_pre_action 11:17:42 INFO - Running main action method: download_and_extract 11:17:42 INFO - mkdir: /builds/slave/test/build/tests 11:17: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')]} 11:17:42 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:17:47 INFO - Downloaded 1361 bytes. 11:17:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:17:47 INFO - Using the following test package requirements: 11:17:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:17:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'jsshell-linux-x86_64.zip'], 11:17:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:47 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:48 INFO - Downloaded 24269679 bytes. 11:17:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:17:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:17:50 INFO - Return code: 0 11:17:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:50 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:00 INFO - Downloaded 24269679 bytes. 11:18:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:18:02 INFO - Return code: 0 11:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:02 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:18:03 INFO - Downloaded 14405384 bytes. 11:18:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:18:03 INFO - Return code: 0 11:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:03 INFO - https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:18:07 INFO - Downloaded 60167492 bytes. 11:18:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:07 INFO - mkdir: /builds/slave/test/properties 11:18:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:07 INFO - Contents: 11:18:07 INFO - build_url:https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - Running post-action listener: set_extra_try_arguments 11:18:08 INFO - ##### 11:18:08 INFO - ##### Finished download-and-extract step (success) 11:18:08 INFO - ##### 11:18:08 INFO - ##### 11:18:08 INFO - ##### Running populate-webroot step. 11:18:08 INFO - ##### 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: populate_webroot 11:18:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:08 INFO - '--tppagecycles', 11:18:08 INFO - '7'], 11:18:08 INFO - 'tests': ['tsvgm']}}, 11:18:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['damp', 'tps']}, 11:18:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'tests': ['damp', 'tps']}, 11:18:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['dromaeo_dom']}, 11:18:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['basic_compositor_video']}, 11:18:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tsvgx', 11:18:08 INFO - 'tsvgr_opacity', 11:18:08 INFO - 'tart', 11:18:08 INFO - 'tscrollx', 11:18:08 INFO - 'cart']}, 11:18:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:08 INFO - 'tsvgr_opacity', 11:18:08 INFO - 'tart', 11:18:08 INFO - 'tscrollx', 11:18:08 INFO - 'cart']}, 11:18:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tp5o']}, 11:18:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'tests': ['tp5o']}, 11:18:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s', 11:18:08 INFO - '--xperf_path', 11:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:08 INFO - 'tests': ['tp5n']}, 11:18:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:08 INFO - 'talos_options': ['--xperf_path', 11:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:08 INFO - 'tests': ['tp5n']}}, 11:18:08 INFO - 'talos.zip': {'path': '', 11:18:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - ##### 11:18:08 INFO - ##### Finished populate-webroot step (success) 11:18:08 INFO - ##### 11:18:08 INFO - ##### 11:18:08 INFO - ##### Running create-virtualenv step. 11:18:08 INFO - ##### 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: create_virtualenv 11:18:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:18:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:08 INFO - Using real prefix '/usr' 11:18:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:10 INFO - Installing pip.................done. 11:18:10 INFO - Return code: 0 11:18:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 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 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:18:10 INFO - Using env: {'DISPLAY': ':0', 11:18:10 INFO - 'HOME': '/home/cltbld', 11:18:10 INFO - 'LANG': 'en_US.UTF-8', 11:18:10 INFO - 'LANGUAGE': 'en_US:en', 11:18:10 INFO - 'LOGNAME': 'cltbld', 11:18:10 INFO - 'MAIL': '/var/mail/cltbld', 11:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:10 INFO - 'MOZ_NO_REMOTE': '1', 11:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:10 INFO - 'NO_EM_RESTART': '1', 11:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:10 INFO - 'PWD': '/builds/slave/test', 11:18:10 INFO - 'SHELL': '/bin/bash', 11:18:10 INFO - 'SHLVL': '1', 11:18:10 INFO - 'TERM': 'linux', 11:18:10 INFO - 'TMOUT': '86400', 11:18:10 INFO - 'USER': 'cltbld', 11:18:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:10 INFO - '_': '/tools/buildbot/bin/python'} 11:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:18:10 INFO - Cleaning up... 11:18:10 INFO - Return code: 0 11:18:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 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 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:18:10 INFO - Using env: {'DISPLAY': ':0', 11:18:10 INFO - 'HOME': '/home/cltbld', 11:18:10 INFO - 'LANG': 'en_US.UTF-8', 11:18:10 INFO - 'LANGUAGE': 'en_US:en', 11:18:10 INFO - 'LOGNAME': 'cltbld', 11:18:10 INFO - 'MAIL': '/var/mail/cltbld', 11:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:10 INFO - 'MOZ_NO_REMOTE': '1', 11:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:10 INFO - 'NO_EM_RESTART': '1', 11:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:10 INFO - 'PWD': '/builds/slave/test', 11:18:10 INFO - 'SHELL': '/bin/bash', 11:18:10 INFO - 'SHLVL': '1', 11:18:10 INFO - 'TERM': 'linux', 11:18:10 INFO - 'TMOUT': '86400', 11:18:10 INFO - 'USER': 'cltbld', 11:18:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:10 INFO - '_': '/tools/buildbot/bin/python'} 11:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:11 INFO - Downloading/unpacking psutil>=3.1.1 11:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:13 INFO - Installing collected packages: psutil 11:18:13 INFO - Running setup.py install for psutil 11:18:13 INFO - building 'psutil._psutil_linux' extension 11:18:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:18:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:18:13 INFO - building 'psutil._psutil_posix' extension 11:18:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:18:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:18:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:13 INFO - Successfully installed psutil 11:18:13 INFO - Cleaning up... 11:18:13 INFO - Return code: 0 11:18:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:13 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 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:18:13 INFO - Using env: {'DISPLAY': ':0', 11:18:13 INFO - 'HOME': '/home/cltbld', 11:18:13 INFO - 'LANG': 'en_US.UTF-8', 11:18:13 INFO - 'LANGUAGE': 'en_US:en', 11:18:13 INFO - 'LOGNAME': 'cltbld', 11:18:13 INFO - 'MAIL': '/var/mail/cltbld', 11:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:13 INFO - 'MOZ_NO_REMOTE': '1', 11:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:13 INFO - 'NO_EM_RESTART': '1', 11:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:13 INFO - 'PWD': '/builds/slave/test', 11:18:13 INFO - 'SHELL': '/bin/bash', 11:18:13 INFO - 'SHLVL': '1', 11:18:13 INFO - 'TERM': 'linux', 11:18:13 INFO - 'TMOUT': '86400', 11:18:13 INFO - 'USER': 'cltbld', 11:18:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:13 INFO - '_': '/tools/buildbot/bin/python'} 11:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:15 INFO - Installing collected packages: mozsystemmonitor 11:18:15 INFO - Running setup.py install for mozsystemmonitor 11:18:15 INFO - Successfully installed mozsystemmonitor 11:18:15 INFO - Cleaning up... 11:18:15 INFO - Return code: 0 11:18:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 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 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:18:15 INFO - Using env: {'DISPLAY': ':0', 11:18:15 INFO - 'HOME': '/home/cltbld', 11:18:15 INFO - 'LANG': 'en_US.UTF-8', 11:18:15 INFO - 'LANGUAGE': 'en_US:en', 11:18:15 INFO - 'LOGNAME': 'cltbld', 11:18:15 INFO - 'MAIL': '/var/mail/cltbld', 11:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:15 INFO - 'MOZ_NO_REMOTE': '1', 11:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:15 INFO - 'NO_EM_RESTART': '1', 11:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:15 INFO - 'PWD': '/builds/slave/test', 11:18:15 INFO - 'SHELL': '/bin/bash', 11:18:15 INFO - 'SHLVL': '1', 11:18:15 INFO - 'TERM': 'linux', 11:18:15 INFO - 'TMOUT': '86400', 11:18:15 INFO - 'USER': 'cltbld', 11:18:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:15 INFO - '_': '/tools/buildbot/bin/python'} 11:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:18 INFO - warning: no files found matching '*.txt' 11:18:18 INFO - no previously-included directories found matching 'build' 11:18:18 INFO - no previously-included directories found matching 'dist' 11:18:18 INFO - no previously-included directories found matching '.git*' 11:18:18 INFO - Installing collected packages: jsonschema, functools32 11:18:18 INFO - Running setup.py install for functools32 11:18:18 INFO - warning: no files found matching '*.txt' 11:18:18 INFO - no previously-included directories found matching 'build' 11:18:18 INFO - no previously-included directories found matching 'dist' 11:18:18 INFO - no previously-included directories found matching '.git*' 11:18:18 INFO - Successfully installed jsonschema functools32 11:18:18 INFO - Cleaning up... 11:18:18 INFO - Return code: 0 11:18:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:18 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 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:18:18 INFO - Using env: {'DISPLAY': ':0', 11:18:18 INFO - 'HOME': '/home/cltbld', 11:18:18 INFO - 'LANG': 'en_US.UTF-8', 11:18:18 INFO - 'LANGUAGE': 'en_US:en', 11:18:18 INFO - 'LOGNAME': 'cltbld', 11:18:18 INFO - 'MAIL': '/var/mail/cltbld', 11:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:18 INFO - 'MOZ_NO_REMOTE': '1', 11:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:18 INFO - 'NO_EM_RESTART': '1', 11:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:18 INFO - 'PWD': '/builds/slave/test', 11:18:18 INFO - 'SHELL': '/bin/bash', 11:18:18 INFO - 'SHLVL': '1', 11:18:18 INFO - 'TERM': 'linux', 11:18:18 INFO - 'TMOUT': '86400', 11:18:18 INFO - 'USER': 'cltbld', 11:18:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:18 INFO - '_': '/tools/buildbot/bin/python'} 11:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:21 INFO - Downloading docopt-0.6.1.tar.gz 11:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:21 INFO - Running setup.py install for blobuploader 11:18:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:21 INFO - Running setup.py install for requests 11:18:22 INFO - Running setup.py install for docopt 11:18:22 INFO - Successfully installed blobuploader requests docopt 11:18:22 INFO - Cleaning up... 11:18:22 INFO - Return code: 0 11:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:22 INFO - Using env: {'DISPLAY': ':0', 11:18:22 INFO - 'HOME': '/home/cltbld', 11:18:22 INFO - 'LANG': 'en_US.UTF-8', 11:18:22 INFO - 'LANGUAGE': 'en_US:en', 11:18:22 INFO - 'LOGNAME': 'cltbld', 11:18:22 INFO - 'MAIL': '/var/mail/cltbld', 11:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:22 INFO - 'MOZ_NO_REMOTE': '1', 11:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:22 INFO - 'NO_EM_RESTART': '1', 11:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:22 INFO - 'PWD': '/builds/slave/test', 11:18:22 INFO - 'SHELL': '/bin/bash', 11:18:22 INFO - 'SHLVL': '1', 11:18:22 INFO - 'TERM': 'linux', 11:18:22 INFO - 'TMOUT': '86400', 11:18:22 INFO - 'USER': 'cltbld', 11:18:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:22 INFO - '_': '/tools/buildbot/bin/python'} 11:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:22 INFO - Running setup.py (path:/tmp/pip-ic3QEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:22 INFO - Running setup.py (path:/tmp/pip-64bb3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:22 INFO - Running setup.py (path:/tmp/pip-coGiWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:22 INFO - Running setup.py (path:/tmp/pip-oEz48L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:22 INFO - Running setup.py (path:/tmp/pip-HV6T9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:22 INFO - Running setup.py (path:/tmp/pip-OOVN1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:23 INFO - Running setup.py (path:/tmp/pip-FPQsDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:23 INFO - Running setup.py (path:/tmp/pip-PcFtGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:23 INFO - Running setup.py (path:/tmp/pip-pN3iCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:23 INFO - Running setup.py (path:/tmp/pip-ACnplB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:23 INFO - Running setup.py (path:/tmp/pip-GBozN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:23 INFO - Running setup.py (path:/tmp/pip-2kxh6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:23 INFO - Running setup.py (path:/tmp/pip-yYiy2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:23 INFO - Running setup.py (path:/tmp/pip-yCy81n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:23 INFO - Running setup.py (path:/tmp/pip-jl_SYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:23 INFO - Running setup.py (path:/tmp/pip-Q4jerF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:23 INFO - Running setup.py (path:/tmp/pip-Io_Srq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:23 INFO - Running setup.py install for manifestparser 11:18:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:23 INFO - Running setup.py install for mozcrash 11:18:24 INFO - Running setup.py install for mozdebug 11:18:24 INFO - Running setup.py install for mozdevice 11:18:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for mozfile 11:18:24 INFO - Running setup.py install for mozhttpd 11:18:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for mozinfo 11:18:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for mozInstall 11:18:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for mozleak 11:18:24 INFO - Running setup.py install for mozlog 11:18:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for moznetwork 11:18:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:24 INFO - Running setup.py install for mozprocess 11:18:25 INFO - Running setup.py install for mozprofile 11:18:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:25 INFO - Running setup.py install for mozrunner 11:18:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:25 INFO - Running setup.py install for mozscreenshot 11:18:25 INFO - Running setup.py install for moztest 11:18:25 INFO - Running setup.py install for mozversion 11:18:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:25 INFO - Cleaning up... 11:18:25 INFO - Return code: 0 11:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:25 INFO - Using env: {'DISPLAY': ':0', 11:18:25 INFO - 'HOME': '/home/cltbld', 11:18:25 INFO - 'LANG': 'en_US.UTF-8', 11:18:25 INFO - 'LANGUAGE': 'en_US:en', 11:18:25 INFO - 'LOGNAME': 'cltbld', 11:18:25 INFO - 'MAIL': '/var/mail/cltbld', 11:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:25 INFO - 'MOZ_NO_REMOTE': '1', 11:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:25 INFO - 'NO_EM_RESTART': '1', 11:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:25 INFO - 'PWD': '/builds/slave/test', 11:18:25 INFO - 'SHELL': '/bin/bash', 11:18:25 INFO - 'SHLVL': '1', 11:18:25 INFO - 'TERM': 'linux', 11:18:25 INFO - 'TMOUT': '86400', 11:18:25 INFO - 'USER': 'cltbld', 11:18:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:25 INFO - '_': '/tools/buildbot/bin/python'} 11:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:25 INFO - Running setup.py (path:/tmp/pip-OkDFgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:25 INFO - Running setup.py (path:/tmp/pip-rdzIOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:26 INFO - Running setup.py (path:/tmp/pip-HnWcKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:26 INFO - Running setup.py (path:/tmp/pip-hgxeLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:26 INFO - Running setup.py (path:/tmp/pip-aBpYfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:26 INFO - Running setup.py (path:/tmp/pip-_pdGaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:26 INFO - Running setup.py (path:/tmp/pip-4eOG_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:26 INFO - Running setup.py (path:/tmp/pip-3s4RnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:26 INFO - Running setup.py (path:/tmp/pip-LAT8QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:26 INFO - Running setup.py (path:/tmp/pip-xLauu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:26 INFO - Running setup.py (path:/tmp/pip-VcvW8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:26 INFO - Running setup.py (path:/tmp/pip-kbv9FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:26 INFO - Running setup.py (path:/tmp/pip-SIXl85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:26 INFO - Running setup.py (path:/tmp/pip-EpqeJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:26 INFO - Running setup.py (path:/tmp/pip-rQmVnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:26 INFO - Running setup.py (path:/tmp/pip-ilodQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:27 INFO - Running setup.py (path:/tmp/pip-oW7e3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:28 INFO - Downloading blessings-1.6.tar.gz 11:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:29 INFO - Installing collected packages: blessings 11:18:29 INFO - Running setup.py install for blessings 11:18:29 INFO - Successfully installed blessings 11:18:29 INFO - Cleaning up... 11:18:29 INFO - Return code: 0 11:18:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:29 INFO - Reading from file tmpfile_stdout 11:18:29 INFO - Current package versions: 11:18:29 INFO - argparse == 1.2.1 11:18:29 INFO - blessings == 1.6 11:18:29 INFO - blobuploader == 1.2.4 11:18:29 INFO - docopt == 0.6.1 11:18:29 INFO - functools32 == 3.2.3-2 11:18:29 INFO - jsonschema == 2.5.1 11:18:29 INFO - manifestparser == 1.1 11:18:29 INFO - mozInstall == 1.12 11:18:29 INFO - mozcrash == 0.17 11:18:29 INFO - mozdebug == 0.1 11:18:29 INFO - mozdevice == 0.48 11:18:29 INFO - mozfile == 1.2 11:18:29 INFO - mozhttpd == 0.7 11:18:29 INFO - mozinfo == 0.9 11:18:29 INFO - mozleak == 0.1 11:18:29 INFO - mozlog == 3.2 11:18:29 INFO - moznetwork == 0.27 11:18:29 INFO - mozprocess == 0.22 11:18:29 INFO - mozprofile == 0.28 11:18:29 INFO - mozrunner == 6.11 11:18:29 INFO - mozscreenshot == 0.1 11:18:29 INFO - mozsystemmonitor == 0.3 11:18:29 INFO - moztest == 0.7 11:18:29 INFO - mozversion == 1.4 11:18:29 INFO - psutil == 3.1.1 11:18:29 INFO - requests == 1.2.3 11:18:29 INFO - wsgiref == 0.1.2 11:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:29 INFO - Using env: {'DISPLAY': ':0', 11:18:29 INFO - 'HOME': '/home/cltbld', 11:18:29 INFO - 'LANG': 'en_US.UTF-8', 11:18:29 INFO - 'LANGUAGE': 'en_US:en', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MAIL': '/var/mail/cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SHLVL': '1', 11:18:29 INFO - 'TERM': 'linux', 11:18:29 INFO - 'TMOUT': '86400', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - '_': '/tools/buildbot/bin/python'} 11:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:29 INFO - Cleaning up... 11:18:29 INFO - Return code: 0 11:18:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:29 INFO - Using env: {'DISPLAY': ':0', 11:18:29 INFO - 'HOME': '/home/cltbld', 11:18:29 INFO - 'LANG': 'en_US.UTF-8', 11:18:29 INFO - 'LANGUAGE': 'en_US:en', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MAIL': '/var/mail/cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SHLVL': '1', 11:18:29 INFO - 'TERM': 'linux', 11:18:29 INFO - 'TMOUT': '86400', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - '_': '/tools/buildbot/bin/python'} 11:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:29 INFO - Cleaning up... 11:18:29 INFO - Return code: 0 11:18:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68ce89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, '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': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18: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', 'flake8'] in /builds/slave/test/build 11:18: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 flake8 11:18:29 INFO - Using env: {'DISPLAY': ':0', 11:18:29 INFO - 'HOME': '/home/cltbld', 11:18:29 INFO - 'LANG': 'en_US.UTF-8', 11:18:29 INFO - 'LANGUAGE': 'en_US:en', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MAIL': '/var/mail/cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SHLVL': '1', 11:18:29 INFO - 'TERM': 'linux', 11:18:29 INFO - 'TMOUT': '86400', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - '_': '/tools/buildbot/bin/python'} 11:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:30 INFO - Downloading/unpacking flake8 11:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:32 INFO - no previously-included directories found matching 'docs/_build' 11:18:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:32 INFO - Running setup.py install for pep8 11:18:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:32 INFO - no previously-included directories found matching 'docs/_build' 11:18:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:32 INFO - Cleaning up... 11:18:32 INFO - Return code: 0 11:18:32 INFO - Running post-action listener: _resource_record_post_action 11:18:32 INFO - Running post-action listener: _start_resource_monitoring 11:18:32 INFO - Starting resource monitoring. 11:18:32 INFO - ##### 11:18:32 INFO - ##### Finished create-virtualenv step (success) 11:18:32 INFO - ##### 11:18:32 INFO - ##### 11:18:32 INFO - ##### Running install step. 11:18:32 INFO - ##### 11:18:32 INFO - Running pre-action listener: _resource_record_pre_action 11:18:32 INFO - Running main action method: install 11:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:33 INFO - Reading from file tmpfile_stdout 11:18:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:33 INFO - Reading from file tmpfile_stdout 11:18:33 INFO - Output received: 11:18:33 INFO - Usage: mozinstall [options] installer 11:18:33 INFO - Options: 11:18:33 INFO - -h, --help show this help message and exit 11:18:33 INFO - -d DEST, --destination=DEST 11:18:33 INFO - Directory to install application into. [default: 11:18:33 INFO - "/builds/slave/test"] 11:18:33 INFO - --app=APP Application being installed. [default: firefox] 11:18:33 INFO - mkdir: /builds/slave/test/build/application 11:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:18:50 INFO - Reading from file tmpfile_stdout 11:18:50 INFO - Output received: 11:18:50 INFO - /builds/slave/test/build/application/firefox/firefox 11:18:50 INFO - Running post-action listener: _resource_record_post_action 11:18:50 INFO - ##### 11:18:50 INFO - ##### Finished install step (success) 11:18:50 INFO - ##### 11:18:50 INFO - ##### 11:18:50 INFO - ##### Running run-tests step. 11:18:50 INFO - ##### 11:18:50 INFO - Running pre-action listener: _resource_record_pre_action 11:18:50 INFO - Running main action method: run_tests 11:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:50 INFO - Python 2.7.3 11:18:50 INFO - Return code: 0 11:18:50 INFO - grabbing minidump binary from tooltool 11:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:50 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 0x21ee1c0>, '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 0x21ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ef550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:18:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:18:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:18:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:50 INFO - Return code: 0 11:18:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:18:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:18:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:18:51 INFO - Return code: 0 11:18:51 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/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:18:51 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/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:18:51 INFO - Using env: {'DISPLAY': ':0', 11:18:51 INFO - 'HOME': '/home/cltbld', 11:18:51 INFO - 'LANG': 'en_US.UTF-8', 11:18:51 INFO - 'LANGUAGE': 'en_US:en', 11:18:51 INFO - 'LOGNAME': 'cltbld', 11:18:51 INFO - 'MAIL': '/var/mail/cltbld', 11:18:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:51 INFO - 'MOZ_NO_REMOTE': '1', 11:18:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:51 INFO - 'NO_EM_RESTART': '1', 11:18:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:51 INFO - 'PWD': '/builds/slave/test', 11:18:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:51 INFO - 'SHELL': '/bin/bash', 11:18:51 INFO - 'SHLVL': '1', 11:18:51 INFO - 'TERM': 'linux', 11:18:51 INFO - 'TMOUT': '86400', 11:18:51 INFO - 'USER': 'cltbld', 11:18:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351', 11:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:51 INFO - '_': '/tools/buildbot/bin/python'} 11:18:51 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/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:18:51 INFO - mozversion application_buildid: 20160622083013 11:18:51 INFO - mozversion application_changeset: b5fa754a35da091bb0c2b197317cd5627f6c8486 11:18:51 INFO - mozversion application_display_name: Nightly 11:18:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:51 INFO - mozversion application_name: Firefox 11:18:51 INFO - mozversion application_remotingname: firefox 11:18:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:18:51 INFO - mozversion application_vendor: Mozilla 11:18:51 INFO - mozversion application_version: 50.0a1 11:18:51 INFO - mozversion platform_buildid: 20160622083013 11:18:51 INFO - mozversion platform_changeset: b5fa754a35da091bb0c2b197317cd5627f6c8486 11:18:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:18:51 INFO - mozversion platform_version: 50.0a1 11:18:51 INFO - using testdate: 1466619531 11:18:51 INFO - actual date: 1466619531 11:18:51 INFO - starting webserver on 'localhost:45711' 11:18:51 INFO - SUITE-START | Running 2 tests 11:18:51 INFO - TEST-START | dromaeo_css 11:18:51 INFO - operating with platform_type : linux_ 11:18:51 INFO - Initialising browser for dromaeo_css test... 11:18:51 INFO - TEST-INFO | started process 6350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG6Dj9G/profile http://localhost:45711/getInfo.html) 11:18:55 INFO - PROCESS | 6350 | __metrics Screen width/height:1600/1200 11:18:55 INFO - PROCESS | 6350 | colorDepth:24 11:18:55 INFO - PROCESS | 6350 | Browser inner width/height: 1024/697 11:18:55 INFO - PROCESS | 6350 | __metrics 11:18:56 INFO - PROCESS | 6350 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:57 INFO - TEST-INFO | 6350: exit 0 11:18:57 INFO - Browser initialized. 11:18:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:57 INFO - TEST-INFO | started process 6431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG6Dj9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:09 INFO - PROCESS | 6431 | RSS: Main: 174133248 11:19:09 INFO - PROCESS | 6431 | 11:20:00 INFO - PROCESS | 6431 | 1466619600843 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:22:08 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45711/tests/dromaeo/cssquery-ext.html) 11:22:09 INFO - PROCESS | 6431 | RSS: Main: 265224192 11:22:09 INFO - PROCESS | 6431 | 11:25:12 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-ext.html (next: http://localhost:45711/tests/dromaeo/cssquery-jquery.html) 11:25:12 INFO - PROCESS | 6431 | RSS: Main: 273342464 11:25:12 INFO - PROCESS | 6431 | 11:28:14 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45711/tests/dromaeo/cssquery-mootools.html) 11:28:15 INFO - PROCESS | 6431 | RSS: Main: 272908288 11:28:15 INFO - PROCESS | 6431 | 11:31:17 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45711/tests/dromaeo/cssquery-prototype.html) 11:31:18 INFO - PROCESS | 6431 | RSS: Main: 263151616 11:31:18 INFO - PROCESS | 6431 | 11:34:20 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45711/tests/dromaeo/cssquery-yui.html) 11:34:21 INFO - PROCESS | 6431 | RSS: Main: 227856384 11:34:21 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-yui.html (next: http://localhost:45711/tests/dromaeo/cssquery-dojo.html) 11:37:24 INFO - PROCESS | 6431 | RSS: Main: 292585472 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | __start_tp_report 11:37:24 INFO - PROCESS | 6431 | _x_x_mozilla_page_load 11:37:24 INFO - PROCESS | 6431 | _x_x_mozilla_page_load_details 11:37:24 INFO - PROCESS | 6431 | |i|pagename|runs| 11:37:24 INFO - PROCESS | 6431 | |0;dojo.html;3102.14690959986;3120.500719884819;3133.373325334933;3148.197209711523;3186.9521957170646;5232.0320740663;5296.9735151324285;5395.865103372413;5497.642653227543;5500.4774546418075;5363.061464243751;5387.353517577886;5402.135658294674;5458.344998600173;5463.31708536433;4844.951550484503;4854.514548545135;4946.604271658259;4951.876203094916;5093.719845408501;4964.280179374006;4977.975110124445;5022.84931452057;5036.672616279949;5056.115179843531;4726.621870250389;4761.761911904408;4807.567318941277;4895.853124406273;4904.313396124546;4867.221244600847;4870.805167793284;4871.80512779492;4910.582600478963;4933.531314525115;4866.78099485524;4866.829660961885;4878.926816097762;4884.072026315024;4952.752362381866;5146.459621739738;5318.680879147263;5389.353277606712;5390.703511306877;5393.325834270716;5788.102844059177;5835.241418615553;5846.093855452412;5849.912251316234;5852.034414321632;5819;5849.356570777254;5888.764449422018;5896.410358964112;5903.085021821625;5149.897002059975;5328.760205790749;5386.892262154735;5390;5472.124460086367;5956.85107872298;5956.970215148896;5968.16445697594;5971.850703732354;5977.880442391215;5387.488188622075;5728.942710572925;5737.684427356536;5741.282339707536;5741.971290143606;5682.54539636828;5739.053056245672;5742.081266997344;5742.454466825645;5778.595498315161;5753.971230143822;5757;5757.539396848242;5760.049591817303;5760.36635970043;5547.140193270049;5664.376918538957;5720.2849643794525;5772;5774.740136693775;4376.387305777193;4393.956060439418;4395.450568678915;4431.091626216682;4438.622717069021;3905.082305658168;3917.4123881417445;3929.646331830149;3935.252302062599;3959.5050618672667;5366.946330536644;5464.972675136679;5476.91784623231;5488.451154884479;5531.778728850801;5827.970860145757;5849.61977471463;5858.912116318259;5910.556708246899;5920.733566989496;5561.277033985556;5571.582131340085;5572;5574.1081426972305;5577.721113944286;4817.253325734517;5004.024215278058;5032.647714660012;5043.830074174001;5044.9495505045215;6096.073160813016;6104.428839602234;6109.34393638171;6113.020255720364;6116.396640261158;5928.288605367384;5928.673922934107;5930.05119180929;5932.0508718604815;5966.642001479751;5561.4716601922755;5869.6771677558145;5950.523958083257;5991.64050156992;6080.90878636812;5733;5763.625364351304;5767.480926716616;5768.192453056491;5772.509336706427;5820.417958204146;5860.267466566679;5869.383714709894;5874.265716785402;5879.647221166743;5475.72621368938;5653.349864765604;5682.403347648437;5710.885782284414;5734.053881109737;5688.317401911797;5692.430756924275;5697.943020569741;5700.173474846041;5705.7432415542235;5352.518273355417;5614.63504872182;5625.521830644441;5629.577781666309;5629.8592535186945;5572.91640625399;5609.80365687199;5642;5719.57103217252;5731.111677689964;5476.589255805751;5500.917486237629;5531.1426728857095;5543.057680194296;5583.637063590853 11:37:24 INFO - PROCESS | 6431 | |1;ext.html;606.275500776572;609.6890585801243;610.3560743415694;631.9020551814467;638.5530128909764;30086.849565752167;41813.16373672525;43004.354934676005;43097.78451107748;47120.764396178056;44531.77734111325;44757.77621111898;44896.55103448965;44928.3260751089;44946.55053449464;8602.741917742478;8757.343199260049;8759.211670949613;8777.42946708465;8789.516576588285;8675.392722509427;8823.823523529525;8825.779355516132;8826.646934122627;8829.60266787996;8825.69110081144;8871.556422178865;8879.955600222022;8891;8891.377603567753;8839.558022098901;8870.512121833297;8878.778030549256;8884.02275749667;8889.377743557954;8702.303815694793;8751.518666473341;8764;8775.297976161892;8792.956035219848;42602.147957040994;42951.35572966408;43028.784856075836;43058.784706076585;43111.784441077594;3431.2108215110416;3937.940930886039;3973.1060511384994;4083.530394004668;4182.64447521961;32756.181095472803;33172.834135829406;33536.6646333536;33549.32901341984;33681.15797105068;4358.5205627380965;4399.406080179167;4428.3578881062385;4608.907821843578;4613.538646135393;331322;332396.3380183108;337177;339719;341936;50703.239451408255;55016;55927.72036139793;56007.43992560104;56123.71938140283;48902.510974889796;53435.73282133642;53463.19805202925;57446.138307925416;58588.41411585915;15910.920445397698;15915.204239787965;16004.67990640204;16018.519444416686;16023.759643605355;13272.13731107475;13335.399907004208;13358.933205333911;13411.195328280335;13417.463301467831;13962.371693273826;15004.174770387734;15773.447929322649;15834.60413489672;15856.048637081813;5495.890082198333;5600.243967064475;5776.913346299809;5847.502962248256;5888.941110588839;913.4838816069033;991.2862738828032;1042.8852826189113;1088.7256847955475;1100.5198008678315;32128.839355803073;32202.19494512609;32476.512852307234;32602.673973260436;33013.339733205205;1114.9609763658234;1133.2350663302402;1146.7649131927935;1190.0539071438227;1207.4204381896739;16919;17130.40043598493;17181.226844792014;17225.827741722675;17238.936993735246;502787;505128;505149;509162;509307.61577650066;57583.712081440164;57617.71191144017;57719;57735.42264577385;57904.4209557899;1270.675977625718;1331.9600411987656;1344.3516272942288;1354.2010213973804;1363.3932899859467;30793.538096929013;31246.68753312438;32322;32479;32546.969628886032;50921;51182;51606;51648.741756290976;51657.483425165265;439509;440058;440693;440934;441884.4398226187;33796.3240735179;37146.44280335851;41210.587894120676;41825.58174418217;42183.578164217965;43592.34611480894;48221.75889120532;48749.75625121852;49025.754871225414;49384.50615493799;40208.1958360837;40976.79511602423;41423;42071.57928420677;42445;40229.79885100556;40360.79819600883;40546;41645.37531937084;41743.7912810434;40461.39307910325;41531.169376611695;41705.37441938434;41759.37360939649;41772.58227417687;34998.30003399969;35924.4611330825;36657.45013824741;36763.816180918926;36896.63103368932;27238.863805681638;27818.860905695343;27818.860905695343;28059.719402806528;28161.295967600974 11:37:24 INFO - PROCESS | 6431 | |2;jquery.html;365.87560229521955;378.5173903273327;381.1386267036498;387.7692772800183;389.7213492352967;15365.308561114749;17224.397146099873;18577.72133417998;19161.808381916177;19522.707159392587;17490.300387984465;18086.81913180868;18175.272989080422;18193.090345482706;18678;5509.338879334476;5709.8287051388525;5742.425757424266;5766.481016708495;5769.451902069297;5348.171033489815;5638.267025286707;5650.406707295737;5655.519280861111;5660.858478538028;5507.906995341765;5582.106862901936;5582.7766889324585;5584.804531841386;5589.049861523551;5566.3598686151;5691.174779656968;5691.857703557403;5757.913631295534;5758.798442054529;5006.6033739503055;5033.572146367563;5084.9745751271375;5093.5415812576675;5095.031943930679;22162.77837221623;22203.777962220334;22394.55210895773;22767.430814229778;22791;2461.3108329667543;2473.492933948536;2489.191012920808;2601.869906504667;2966.61434013579;14516.201608911506;15185.164815935119;15684.372625094982;16423;17110.657786844193;2011.145263263122;2154.7394774057198;2178.161407857986;2198.3404978506383;2240.409309390335;63495.365046349405;71327.93008104882;85827;88559;95729.5213523935;16810.747838782427;16956.491305260613;17025.744613830804;17660.470185894443;18108.275668973358;31812.681873180973;32021.519677204862;32198.678013220037;32264.83867580694;32352.514712279335;8737.650493980169;8934.878861748146;8988.280937524982;9037.096290371042;9547.665831695856;7876.763697089096;8091.271785539212;8542.145785421408;8821.60302786376;8850.64597416109;8606.31149508038;8922.330825188137;8988.865167022499;9039.954800226089;9110.225630821322;3073.9538906916414;3242.2218667520096;3329.6503867094093;3371.898843034713;3496.73774466916;856.2636132925679;939.5349302095507;1040.5057597641212;1055.4089709762557;1067.3755852826184;19121.80878191228;19369.709454358195;19415.8058419414;19492;19626.11682474292;985.3792110970043;999.3354419311077;1022.1107636356269;1031.2626472072354;1055.2982266792496;10358.430286334324;10671.986161314662;10740.785184296426;10790.460476976119;10798.73003174927;471363;480931;485350.305733181;487824;498566;93061;96714.51642741742;96731.51634241783;96822;97259.51370243104;999.0858364596459;1025.1337619711333;1041.4896700616644;1049.4333060147587;1055.4247934875511;17390.47828565145;17418.216180271666;17457;17685.38101166453;17938.372156974445;38588;40383.59616403798;42248.5775142257;43892;45273.32090018586;49319;59609;59643;59693;60724.69637651784;8437.367197460093;8556.31549476028;8674.696385626472;8749.381364447598;8820.2061814437;12312.569060082855;13665.86334136646;13972.650683732581;14027.649308766955;14053.437862485795;11599.594014209462;11962.282263064244;12193.634190974284;12716.682082947631;12798.232106073665;11911.225770324902;11995.160338776202;12097.399059202313;12494.312812795384;12599.811002835148;12129.939350303192;12411.44148513301;12649.747005060031;12660.366981650697;12803.807942880678;8493.830123397622;8595.09751476086;8778.912210878065;8781.297496200417;9121.954390228006;11970.054886057645;12134.575289864812;12496.562620308245;12714.427850746553;12736 11:37:24 INFO - PROCESS | 6431 | |3;mootools.html;1265.114419906066;1418.241240936099;1428.3358238419137;1541.5529496446031;1726.283592309191;8192.303654189394;8598.398112132154;8642.870356944642;8915.821683566324;8930.866037009433;8764.956175219131;8788.824223515527;8860.424072435304;8860.601272942717;8879.422837515556;1969.350114462224;2259.141526220034;2282.6918366020623;2290;2301.2635956493928;2337.298810356886;2378.500514891875;2379.8691071991034;2385.5825230584664;2386.8448550844228;2310.4108452344713;2328.6157783965627;2332.1720789119872;2333.46330344021;2348.6124789409814;1869.5326168457887;2174.8695078295355;2221.6334304839684;2229.609818281794;2260.2993072147524;2257.063318722728;2274.408653750037;2275.8862056897087;2281.9543609127722;2282.931512054641;9118.179363857285;9183.678571249975;9187.67843125494;9194.770130746718;9195;5007.824726134604;5067.189249720064;5108.923366149511;5120.667156634844;5122.103631864409;3147.4806656901583;3198.5202219667003;3348.2466445049913;3361.2773253750315;3374.7468939829364;1057.962971296001;1072.774717309366;1089.5206109311957;1101.3809699741366;1103.1836441033659;12506.937465312707;12533.248005119722;12565.183263087962;12571.120021598492;12577.182483138658;4365.781710914442;4449.3326001100095;4478.0596074824;4488.685791994529;4587.839425620154;10421.895781042243;10428.426436545911;10449.738756531147;10457.058864702214;10459.424731639832;5110.66780659256;5145;5145.536901678867;5148.613853960968;5149.639525233198;3970.06703424695;4089;4100.2414553307735;4663.860084197479;4815.783289751969;3899.5710471848074;3939.665128464055;3987.2424239395004;4036.6972477064337;4056.290149223874;1210.17707958589;1216.0454043575928;1229.3115855121162;1230.7107829660022;1236.1347057060093;800.5876973358725;861.4658911474926;913.1781396742984;947.0624082158613;951.4101257220567;6027.276726792726;6145.231846019247;6147.907781383194;6207.286162091327;6299.149614802035;414.5398607545622;428;429.7657776511809;431.77116128451974;432.23278680342645;4115.58844115592;4262.104957958863;4313.827446902152;4316.913661726748;4323.589259020388;11054.557817687364;11492.42537873103;11586.073114150848;11596.652100437;11628.244164129304;11430.657080287605;11459.828102578467;11461.484233209525;11463.31220126795;11470.254433461798;7736.303732664087;8018.396320735759;8020.639071241808;8271.875921861178;8460.576971151419;5850.94149058521;6005;6096.055111457554;6099.756009759737;6155.045967874987;10198.235132365251;10461.895381046092;10606.045455909005;10654.307470014424;10666.466676665981;10261.692149235534;10405.895941040493;10835.51240194209;10836.891631083588;10865.728356791144;6810.693518791567;7616.276453736886;7852.882206767017;8046.396520260887;8302.086770455124;8758.299336053227;8767.649294028168;8834.602442890215;8839.955800221214;8849.55752212374;7523.3229009389415;7860.371170306476;7882.211778822072;7934.920650793418;7980.12218655959;7534.7944328907115;7642.4650274480255;7677.769666910001;7691.461597688108;7804.141544429995;7253.854922901618;7328.303811137934;7341.77974660761;7353.889691654736;7362.558246505013;4802.975985120052;4952.851414457572;5058.772355243949;5062.594992400673;5189;5099.23511473282;5121.487851214849;5127.820526281562;5178.559822414986;5251.868703282448 11:37:24 INFO - PROCESS | 6431 | |4;prototype.html;298.6222428627785;305.93116548776527;312.90143604764495;313.5751057317336;314.14239127182776;5000.699958002522;5072.898542029157;5248.553872920802;5292.020976119421;5296.311479507668;5282.762275697593;5285.418603953562;5288.814891478799;5294.629375943686;5309.522143007129;4100.384942258655;4102.815373308194;4125.092479654479;4127.29835927893;4130.256553820311;3929.135590170158;4056.8782936511952;4095.3037983542868;4116.7529948203055;4159.334506478964;4042.4744783178144;4051.6961227908023;4052.9392059119136;4081.4898137732785;4125.339945608704;4028.315186418316;4049.9595004050025;4054.7972601369815;4059.918801623966;4069.186162767429;3593.4609808528667;3611.819409029538;3616.150204701893;3634.7819130852236;3634.800085995269;5122.743862806845;5130.71781052042;5175.663581867167;5186.429492755794;5189.792408303663;4435.68950173488;4561.475430325522;4602.815887364502;4604.194266003436;4621.74580398078;5210.478952104797;5318.494742999409;5495.505404513613;5498.780048798043;5519.39286678465;3945.1517923646265;3950.2692001979726;3953.960460395388;3959.109200429909;3962.385830196324;5554.361248456398;5565.2486914266465;5604.719764011783;5697.77208911643;5701.543876489913;3991.221711766236;4003.4786781023026;4020.537638171589;4021.7184797063924;4044.797760111983;4086.223617512663;4092.263392589303;4094.549599544048;4098.549159592442;4100.282450571138;4493.393391892053;4608.655206879806;4674.984634910464;4686.437627484724;4696.483386827446;5499.085484693119;5533.418991005967;5542.5565954723525;5546.528545073633;5548.778048878;1373.1486478383467;1382.861713828609;1390.3743315508061;1402.2427888940063;1411.745885740556;870.1596757654207;907.5552979040223;908.4367692030983;914.4970266353479;926.6756635177769;4726.054789042205;4753.33453316536;4777.065288558139;4780.378550788375;4806.735629540409;4975.5522003019905;4982.302477653131;5005.6996580205305;5051.191809310492;5061.670991385548;4701.318308845267;4800.567948884617;4816.530958057756;4828.76866399066;4952.826651067196;3001.6848230935875;3016.8189908605555;3023.818570885754;3034.924126896801;3053.129857990462;5848.678322692293;5873.324567674772;5891.852703682443;5895.4399332063385;5902.498287645598;5602.691851948182;5790.913136302959;5820.73806678692;5832.766689332464;5860.267466566679;5828.912566311508;5855.59920432612;5878.912401205791;5896.734646940898;5911.55663325261;5451.264079349237;5688.203651488878;5729.312482502127;5730.484256416942;5769.596128271149;5631.267935168402;5675.659460432387;5693.772249110155;5726.370099288992;5771.826845194483;5904.350521442724;5912.46787789101;5914.408559144051;5937;5950.553708471795;3841.4621952927173;3992.9600703992587;4012.317905955936;4045.4134150547416;4067.572904844949;5682.744276507485;5694.914576281442;5704.885902281848;5712.457316554921;5719.685417302088;5583.408728512354;5591.189277554813;5594.524465420485;5608.980766923985;5611.719414029364;5442.6462279951675;5442.836714898559;5551.7779288828;5553.805616803393;5562.833115006556;5414.404415514369;5446.428125046813;5451.536619387238;5475.342958844964;5500.4499550044675;5301.973490132525;5454.59090568201;5519.647686316878;5591.916121258266;5602.299712535933;5511.944880551304;5528.44715528444;5536.1488833250105;5547.696291371605;5549.306336707911 11:37:24 INFO - PROCESS | 6431 | |5;yui.html;710.8507213485168;729.2525161709248;748.7080038784875;790.2220004988778;841.3521588376946;14595.270236488173;15184.088954662728;15203.54389368318;15401.845981540195;15823.129727864964;14928.925355373234;15061.17163556004;15208.315625796839;15217.4673886414;15233.92383038086;667.4927055437854;777.4557809533321;780.2275747010448;787.8345547435046;795.387551585279;792.7304716396424;794.4756460735915;797.0554892452434;797.2386371015666;799.9160088190714;822.40786633624;823.7775800533852;823.9741521805361;824.2622852546967;824.4640983360804;692.9826754331132;803.7428023032631;804.9476784009021;807.2815194476921;817.7424111404888;604.4137186928672;604.4559896093551;604.5798170271663;604.607005446459;605.2283338743093;13981.79027314591;14055.78916316256;14062.578122656336;14074.92962535191;14091.084079534798;14142.151470911675;14197.858021419757;14347.78478322826;14794.260286985607;14856.851431485762;12322.075844311712;12903.22580645155;12955.870441295561;12969.870301297055;13089;4509.233430316854;4516.548345165457;4527.456705195397;4556.407667003302;4705.811767529295;73641.2635873645;73901.63049184774;74169.25830741678;74526.62736686337;74571.25428745698;11229.27009744364;11631.825522617168;11655.53377864876;12062.577809776616;12111.939440302918;21792.45518862041;21800.454988625093;21802.672959905613;21926.561468770535;21944.45138871541;8096.635651395702;8590.742277731679;8612.311015118776;8615.052344242129;8620.568971551398;4527.750973696412;4591.79336929839;4638.466576343696;4683.859484215479;4769.8569042928075;3378.223008708011;3490.860365585348;3496.667816557423;3498.1429549760473;3498.7900725956524;584.9473547380757;585.9296884373817;600.9038553831366;601.7292218501692;601.9036954087325;514.2954152810673;643.324509265279;661.7849199010341;683.4256836743857;697.2957313113792;8709.259712924346;9713.320067595341;9813.656522021838;9837.458939758239;9996.150327222267;646.2019406033545;657.5232956106785;662.7812821768805;667.5560752099799;693.1231991530718;4251.59609837065;4447.822087116479;4565.543445655408;4723.267893476516;4753.31076993834;66529.66735166294;66548.66725666437;66716;99735.50132249293;117526;98063;98482;99531;100640;100674.49662751639;85416.57291713501;86990;87037.5648121768;88491.57542122868;88951;8826.558672066243;8877.955610222167;8953.955230223808;9011.504367259864;9314.673986410444;50996.23505647344;51938;53254.4674553265;53779.08430072611;53966.73016634892;67463.403932831;77039;77264.61367693126;77509.2249077502;77581;11847;11872.168948173545;11877.821832672344;11918.761624767283;12295.446704898122;14171.43314267459;14430.567082987527;14511.492097776527;14532.782008269673;15395;14652.19412932299;14870.182139981973;14912.62718432048;14916.477923272634;14982.250887455366;14473.131612103307;14777.335019924345;15270.312835922188;15495;15681.215939203223;14474.638134046732;14608.634784130056;14722.337494812546;14926.925365373103;14947.103173809606;10773.838392423962;11448.049011959793;11457.683613845784;11689.707757305796;12550.121491495507;11444.370559619301;11506.769864602493;11600.94199528997;11774.587889423829;11831.52673893069 11:37:24 INFO - PROCESS | 6431 | __end_tp_report 11:37:24 INFO - PROCESS | 6431 | __start_cc_report 11:37:24 INFO - PROCESS | 6431 | _x_x_mozilla_cycle_collect,863 11:37:24 INFO - PROCESS | 6431 | __end_cc_report 11:37:24 INFO - PROCESS | 6431 | __startTimestamp1466620644910__endTimestamp 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | ------- Summary: start ------- 11:37:24 INFO - PROCESS | 6431 | Number of tests: 6 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#0] dojo.html Cycles:165 Average:5381.35 Median:5572.92 stddev:625.35 (11.2%) stddev-sans-first:601.17 11:37:24 INFO - PROCESS | 6431 | Values: 3102.1 3120.5 3133.4 3148.2 3187.0 5232.0 5297.0 5395.9 5497.6 5500.5 5363.1 5387.4 5402.1 5458.3 5463.3 4845.0 4854.5 4946.6 4951.9 5093.7 4964.3 4978.0 5022.8 5036.7 5056.1 4726.6 4761.8 4807.6 4895.9 4904.3 4867.2 4870.8 4871.8 4910.6 4933.5 4866.8 4866.8 4878.9 4884.1 4952.8 5146.5 5318.7 5389.4 5390.7 5393.3 5788.1 5835.2 5846.1 5849.9 5852.0 5819.0 5849.4 5888.8 5896.4 5903.1 5149.9 5328.8 5386.9 5390.0 5472.1 5956.9 5957.0 5968.2 5971.9 5977.9 5387.5 5728.9 5737.7 5741.3 5742.0 5682.5 5739.1 5742.1 5742.5 5778.6 5754.0 5757.0 5757.5 5760.0 5760.4 5547.1 5664.4 5720.3 5772.0 5774.7 4376.4 4394.0 4395.5 4431.1 4438.6 3905.1 3917.4 3929.6 3935.3 3959.5 5366.9 5465.0 5476.9 5488.5 5531.8 5828.0 5849.6 5858.9 5910.6 5920.7 5561.3 5571.6 5572.0 5574.1 5577.7 4817.3 5004.0 5032.6 5043.8 5044.9 6096.1 6104.4 6109.3 6113.0 6116.4 5928.3 5928.7 5930.1 5932.1 5966.6 5561.5 5869.7 5950.5 5991.6 6080.9 5733.0 5763.6 5767.5 5768.2 5772.5 5820.4 5860.3 5869.4 5874.3 5879.6 5475.7 5653.3 5682.4 5710.9 5734.1 5688.3 5692.4 5697.9 5700.2 5705.7 5352.5 5614.6 5625.5 5629.6 5629.9 5572.9 5609.8 5642.0 5719.6 5731.1 5476.6 5500.9 5531.1 5543.1 5583.6 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#1] ext.html Cycles:180 Average:59085.77 Median:42776.75 stddev:114728.81 (268.2%) stddev-sans-first:114966.64 11:37:24 INFO - PROCESS | 6431 | Values: 606.3 609.7 610.4 631.9 638.6 30086.8 41813.2 43004.4 43097.8 47120.8 44531.8 44757.8 44896.6 44928.3 44946.6 8602.7 8757.3 8759.2 8777.4 8789.5 8675.4 8823.8 8825.8 8826.6 8829.6 8825.7 8871.6 8880.0 8891.0 8891.4 8839.6 8870.5 8878.8 8884.0 8889.4 8702.3 8751.5 8764.0 8775.3 8793.0 42602.1 42951.4 43028.8 43058.8 43111.8 3431.2 3937.9 3973.1 4083.5 4182.6 32756.2 33172.8 33536.7 33549.3 33681.2 4358.5 4399.4 4428.4 4608.9 4613.5 331322.0 332396.3 337177.0 339719.0 341936.0 50703.2 55016.0 55927.7 56007.4 56123.7 48902.5 53435.7 53463.2 57446.1 58588.4 15910.9 15915.2 16004.7 16018.5 16023.8 13272.1 13335.4 13358.9 13411.2 13417.5 13962.4 15004.2 15773.4 15834.6 15856.0 5495.9 5600.2 5776.9 5847.5 5888.9 913.5 991.3 1042.9 1088.7 1100.5 32128.8 32202.2 32476.5 32602.7 33013.3 1115.0 1133.2 1146.8 1190.1 1207.4 16919.0 17130.4 17181.2 17225.8 17238.9 502787.0 505128.0 505149.0 509162.0 509307.6 57583.7 57617.7 57719.0 57735.4 57904.4 1270.7 1332.0 1344.4 1354.2 1363.4 30793.5 31246.7 32322.0 32479.0 32547.0 50921.0 51182.0 51606.0 51648.7 51657.5 439509.0 440058.0 440693.0 440934.0 441884.4 33796.3 37146.4 41210.6 41825.6 42183.6 43592.3 48221.8 48749.8 49025.8 49384.5 40208.2 40976.8 41423.0 42071.6 42445.0 40229.8 40360.8 40546.0 41645.4 41743.8 40461.4 41531.2 41705.4 41759.4 41772.6 34998.3 35924.5 36657.5 36763.8 36896.6 27238.9 27818.9 27818.9 28059.7 28161.3 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#2] jquery.html Cycles:180 Average:29976.90 Median:17797.37 stddev:79933.78 (449.1%) stddev-sans-first:80127.10 11:37:24 INFO - PROCESS | 6431 | Values: 365.9 378.5 381.1 387.8 389.7 15365.3 17224.4 18577.7 19161.8 19522.7 17490.3 18086.8 18175.3 18193.1 18678.0 5509.3 5709.8 5742.4 5766.5 5769.5 5348.2 5638.3 5650.4 5655.5 5660.9 5507.9 5582.1 5582.8 5584.8 5589.0 5566.4 5691.2 5691.9 5757.9 5758.8 5006.6 5033.6 5085.0 5093.5 5095.0 22162.8 22203.8 22394.6 22767.4 22791.0 2461.3 2473.5 2489.2 2601.9 2966.6 14516.2 15185.2 15684.4 16423.0 17110.7 2011.1 2154.7 2178.2 2198.3 2240.4 63495.4 71327.9 85827.0 88559.0 95729.5 16810.7 16956.5 17025.7 17660.5 18108.3 31812.7 32021.5 32198.7 32264.8 32352.5 8737.7 8934.9 8988.3 9037.1 9547.7 7876.8 8091.3 8542.1 8821.6 8850.6 8606.3 8922.3 8988.9 9040.0 9110.2 3074.0 3242.2 3329.7 3371.9 3496.7 856.3 939.5 1040.5 1055.4 1067.4 19121.8 19369.7 19415.8 19492.0 19626.1 985.4 999.3 1022.1 1031.3 1055.3 10358.4 10672.0 10740.8 10790.5 10798.7 471363.0 480931.0 485350.3 487824.0 498566.0 93061.0 96714.5 96731.5 96822.0 97259.5 999.1 1025.1 1041.5 1049.4 1055.4 17390.5 17418.2 17457.0 17685.4 17938.4 38588.0 40383.6 42248.6 43892.0 45273.3 49319.0 59609.0 59643.0 59693.0 60724.7 8437.4 8556.3 8674.7 8749.4 8820.2 12312.6 13665.9 13972.7 14027.6 14053.4 11599.6 11962.3 12193.6 12716.7 12798.2 11911.2 11995.2 12097.4 12494.3 12599.8 12129.9 12411.4 12649.7 12660.4 12803.8 8493.8 8595.1 8778.9 8781.3 9122.0 11970.1 12134.6 12496.6 12714.4 12736.0 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#3] mootools.html Cycles:180 Average:5850.35 Median:2374.57 stddev:3464.51 (145.9%) stddev-sans-first:3457.09 11:37:24 INFO - PROCESS | 6431 | Values: 1265.1 1418.2 1428.3 1541.6 1726.3 8192.3 8598.4 8642.9 8915.8 8930.9 8765.0 8788.8 8860.4 8860.6 8879.4 1969.4 2259.1 2282.7 2290.0 2301.3 2337.3 2378.5 2379.9 2385.6 2386.8 2310.4 2328.6 2332.2 2333.5 2348.6 1869.5 2174.9 2221.6 2229.6 2260.3 2257.1 2274.4 2275.9 2282.0 2282.9 9118.2 9183.7 9187.7 9194.8 9195.0 5007.8 5067.2 5108.9 5120.7 5122.1 3147.5 3198.5 3348.2 3361.3 3374.7 1058.0 1072.8 1089.5 1101.4 1103.2 12506.9 12533.2 12565.2 12571.1 12577.2 4365.8 4449.3 4478.1 4488.7 4587.8 10421.9 10428.4 10449.7 10457.1 10459.4 5110.7 5145.0 5145.5 5148.6 5149.6 3970.1 4089.0 4100.2 4663.9 4815.8 3899.6 3939.7 3987.2 4036.7 4056.3 1210.2 1216.0 1229.3 1230.7 1236.1 800.6 861.5 913.2 947.1 951.4 6027.3 6145.2 6147.9 6207.3 6299.1 414.5 428.0 429.8 431.8 432.2 4115.6 4262.1 4313.8 4316.9 4323.6 11054.6 11492.4 11586.1 11596.7 11628.2 11430.7 11459.8 11461.5 11463.3 11470.3 7736.3 8018.4 8020.6 8271.9 8460.6 5850.9 6005.0 6096.1 6099.8 6155.0 10198.2 10461.9 10606.0 10654.3 10666.5 10261.7 10405.9 10835.5 10836.9 10865.7 6810.7 7616.3 7852.9 8046.4 8302.1 8758.3 8767.6 8834.6 8840.0 8849.6 7523.3 7860.4 7882.2 7934.9 7980.1 7534.8 7642.5 7677.8 7691.5 7804.1 7253.9 7328.3 7341.8 7353.9 7362.6 4803.0 4952.9 5058.8 5062.6 5189.0 5099.2 5121.5 5127.8 5178.6 5251.9 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#4] prototype.html Cycles:180 Average:4604.36 Median:5188.11 stddev:1363.63 (26.3%) stddev-sans-first:1328.61 11:37:24 INFO - PROCESS | 6431 | Values: 298.6 305.9 312.9 313.6 314.1 5000.7 5072.9 5248.6 5292.0 5296.3 5282.8 5285.4 5288.8 5294.6 5309.5 4100.4 4102.8 4125.1 4127.3 4130.3 3929.1 4056.9 4095.3 4116.8 4159.3 4042.5 4051.7 4052.9 4081.5 4125.3 4028.3 4050.0 4054.8 4059.9 4069.2 3593.5 3611.8 3616.2 3634.8 3634.8 5122.7 5130.7 5175.7 5186.4 5189.8 4435.7 4561.5 4602.8 4604.2 4621.7 5210.5 5318.5 5495.5 5498.8 5519.4 3945.2 3950.3 3954.0 3959.1 3962.4 5554.4 5565.2 5604.7 5697.8 5701.5 3991.2 4003.5 4020.5 4021.7 4044.8 4086.2 4092.3 4094.5 4098.5 4100.3 4493.4 4608.7 4675.0 4686.4 4696.5 5499.1 5533.4 5542.6 5546.5 5548.8 1373.1 1382.9 1390.4 1402.2 1411.7 870.2 907.6 908.4 914.5 926.7 4726.1 4753.3 4777.1 4780.4 4806.7 4975.6 4982.3 5005.7 5051.2 5061.7 4701.3 4800.6 4816.5 4828.8 4952.8 3001.7 3016.8 3023.8 3034.9 3053.1 5848.7 5873.3 5891.9 5895.4 5902.5 5602.7 5790.9 5820.7 5832.8 5860.3 5828.9 5855.6 5878.9 5896.7 5911.6 5451.3 5688.2 5729.3 5730.5 5769.6 5631.3 5675.7 5693.8 5726.4 5771.8 5904.4 5912.5 5914.4 5937.0 5950.6 3841.5 3993.0 4012.3 4045.4 4067.6 5682.7 5694.9 5704.9 5712.5 5719.7 5583.4 5591.2 5594.5 5609.0 5611.7 5442.6 5442.8 5551.8 5553.8 5562.8 5414.4 5446.4 5451.5 5475.3 5500.4 5302.0 5454.6 5519.6 5591.9 5602.3 5511.9 5528.4 5536.1 5547.7 5549.3 11:37:24 INFO - PROCESS | 6431 | 11:37:24 INFO - PROCESS | 6431 | [#5] yui.html Cycles:180 Average:20089.66 Median:4738.29 stddev:27801.39 (586.7%) stddev-sans-first:27841.30 11:37:24 INFO - PROCESS | 6431 | Values: 710.9 729.3 748.7 790.2 841.4 14595.3 15184.1 15203.5 15401.8 15823.1 14928.9 15061.2 15208.3 15217.5 15233.9 667.5 777.5 780.2 787.8 795.4 792.7 794.5 797.1 797.2 799.9 822.4 823.8 824.0 824.3 824.5 693.0 803.7 804.9 807.3 817.7 604.4 604.5 604.6 604.6 605.2 13981.8 14055.8 14062.6 14074.9 14091.1 14142.2 14197.9 14347.8 14794.3 14856.9 12322.1 12903.2 12955.9 12969.9 13089.0 4509.2 4516.5 4527.5 4556.4 4705.8 73641.3 73901.6 74169.3 74526.6 74571.3 11229.3 11631.8 11655.5 12062.6 12111.9 21792.5 21800.5 21802.7 21926.6 21944.5 8096.6 8590.7 8612.3 8615.1 8620.6 4527.8 4591.8 4638.5 4683.9 4769.9 3378.2 3490.9 3496.7 3498.1 3498.8 584.9 585.9 600.9 601.7 601.9 514.3 643.3 661.8 683.4 697.3 8709.3 9713.3 9813.7 9837.5 9996.2 646.2 657.5 662.8 667.6 693.1 4251.6 4447.8 4565.5 4723.3 4753.3 66529.7 66548.7 66716.0 99735.5 117526.0 98063.0 98482.0 99531.0 100640.0 100674.5 85416.6 86990.0 87037.6 88491.6 88951.0 8826.6 8878.0 8954.0 9011.5 9314.7 50996.2 51938.0 53254.5 53779.1 53966.7 67463.4 77039.0 77264.6 77509.2 77581.0 11847.0 11872.2 11877.8 11918.8 12295.4 14171.4 14430.6 14511.5 14532.8 15395.0 14652.2 14870.2 14912.6 14916.5 14982.3 14473.1 14777.3 15270.3 15495.0 15681.2 14474.6 14608.6 14722.3 14926.9 14947.1 10773.8 11448.0 11457.7 11689.7 12550.1 11444.4 11506.8 11600.9 11774.6 11831.5 11:37:24 INFO - PROCESS | 6431 | -------- Summary: end -------- 11:37:24 INFO - PROCESS | 6431 | 11:37:25 INFO - TEST-INFO | 6431: exit 0 11:37:25 INFO - TEST-OK | dromaeo_css | took 1114113ms 11:37:25 INFO - TEST-START | kraken 11:37:25 INFO - operating with platform_type : linux_ 11:37:25 INFO - Initialising browser for kraken test... 11:37:25 INFO - TEST-INFO | started process 6613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppE9snA/profile http://localhost:45711/getInfo.html) 11:37:29 INFO - PROCESS | 6613 | __metrics Screen width/height:1600/1200 11:37:29 INFO - PROCESS | 6613 | colorDepth:24 11:37:29 INFO - PROCESS | 6613 | Browser inner width/height: 1024/697 11:37:29 INFO - PROCESS | 6613 | __metrics 11:37:30 INFO - PROCESS | 6613 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:31 INFO - TEST-INFO | 6613: exit 0 11:37:31 INFO - Browser initialized. 11:37:31 INFO - Running cycle 1/1 for kraken test... 11:37:31 INFO - TEST-INFO | started process 6694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppE9snA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:43 INFO - PROCESS | 6694 | RSS: Main: 174268416 11:37:43 INFO - PROCESS | 6694 | 11:37:45 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:46 INFO - PROCESS | 6694 | RSS: Main: 232792064 11:37:46 INFO - PROCESS | 6694 | 11:37:49 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-dft) 11:37:49 INFO - PROCESS | 6694 | RSS: Main: 217980928 11:37:49 INFO - PROCESS | 6694 | 11:37:53 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-fft) 11:37:53 INFO - PROCESS | 6694 | RSS: Main: 286785536 11:37:53 INFO - PROCESS | 6694 | 11:37:55 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-oscillator) 11:37:56 INFO - PROCESS | 6694 | RSS: Main: 197779456 11:37:56 INFO - PROCESS | 6694 | 11:37:58 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:59 INFO - PROCESS | 6694 | RSS: Main: 202244096 11:37:59 INFO - PROCESS | 6694 | 11:38:02 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:02 INFO - PROCESS | 6694 | RSS: Main: 236670976 11:38:02 INFO - PROCESS | 6694 | 11:38:06 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:06 INFO - PROCESS | 6694 | RSS: Main: 238206976 11:38:06 INFO - PROCESS | 6694 | 11:38:09 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45711/tests/kraken/driver.html?testName=json-parse-financial) 11:38:10 INFO - PROCESS | 6694 | RSS: Main: 238772224 11:38:10 INFO - PROCESS | 6694 | 11:38:11 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:12 INFO - PROCESS | 6694 | RSS: Main: 226185216 11:38:12 INFO - PROCESS | 6694 | 11:38:14 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:14 INFO - PROCESS | 6694 | RSS: Main: 228442112 11:38:14 INFO - PROCESS | 6694 | 11:38:16 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:17 INFO - PROCESS | 6694 | RSS: Main: 237387776 11:38:17 INFO - PROCESS | 6694 | 11:38:19 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:20 INFO - PROCESS | 6694 | RSS: Main: 239919104 11:38:20 INFO - PROCESS | 6694 | 11:38:23 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:23 INFO - PROCESS | 6694 | RSS: Main: 240721920 11:38:23 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45711/tests/kraken/driver.html?testName=ai-astar) 11:38:25 INFO - PROCESS | 6694 | RSS: Main: 283291648 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | __start_tp_report 11:38:25 INFO - PROCESS | 6694 | _x_x_mozilla_page_load 11:38:25 INFO - PROCESS | 6694 | _x_x_mozilla_page_load_details 11:38:25 INFO - PROCESS | 6694 | |i|pagename|runs| 11:38:25 INFO - PROCESS | 6694 | |0;ai-astar;101;111;110;109;111;110;109;108;110;110 11:38:25 INFO - PROCESS | 6694 | |1;audio-beat-detection;149;126;127;174;128;127;146;124;166;124 11:38:25 INFO - PROCESS | 6694 | |2;audio-dft;161;162;168;160;161;161;160;160;163;161 11:38:25 INFO - PROCESS | 6694 | |3;audio-fft;75;76;76;110;76;76;74;74;103;84 11:38:25 INFO - PROCESS | 6694 | |4;audio-oscillator;85;86;123;87;87;88;129;85;87;121 11:38:25 INFO - PROCESS | 6694 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;116;118 11:38:25 INFO - PROCESS | 6694 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;146 11:38:25 INFO - PROCESS | 6694 | |7;imaging-desaturate;94;95;96;95;95;95;95;95;95;95 11:38:25 INFO - PROCESS | 6694 | |8;json-parse-financial;53;51;54;53;51;52;53;52;51;52 11:38:25 INFO - PROCESS | 6694 | |9;json-stringify-tinderbox;62;62;61;62;61;61;62;61;61;62 11:38:25 INFO - PROCESS | 6694 | |10;stanford-crypto-aes;78;85;78;78;79;80;82;80;94;79 11:38:25 INFO - PROCESS | 6694 | |11;stanford-crypto-ccm;120;122;121;129;120;130;117;130;143;123 11:38:25 INFO - PROCESS | 6694 | |12;stanford-crypto-pbkdf2;160;163;163;164;159;164;159;163;158;161 11:38:25 INFO - PROCESS | 6694 | |13;stanford-crypto-sha256-iterative;64;64;63;64;64;64;63;64;63;65 11:38:25 INFO - PROCESS | 6694 | __end_tp_report 11:38:25 INFO - PROCESS | 6694 | __start_cc_report 11:38:25 INFO - PROCESS | 6694 | _x_x_mozilla_cycle_collect,1630 11:38:25 INFO - PROCESS | 6694 | __end_cc_report 11:38:25 INFO - PROCESS | 6694 | __startTimestamp1466620705836__endTimestamp 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | ------- Summary: start ------- 11:38:25 INFO - PROCESS | 6694 | Number of tests: 14 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.92 (2.7%) stddev-sans-first:0.97 11:38:25 INFO - PROCESS | 6694 | Values: 101.0 111.0 110.0 109.0 111.0 110.0 109.0 108.0 110.0 110.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:137.00 stddev:18.65 (13.6%) stddev-sans-first:19.44 11:38:25 INFO - PROCESS | 6694 | Values: 149.0 126.0 127.0 174.0 128.0 127.0 146.0 124.0 166.0 124.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:2.41 (1.5%) stddev-sans-first:2.54 11:38:25 INFO - PROCESS | 6694 | Values: 161.0 162.0 168.0 160.0 161.0 161.0 160.0 160.0 163.0 161.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.12 (17.3%) stddev-sans-first:13.64 11:38:25 INFO - PROCESS | 6694 | Values: 75.0 76.0 76.0 110.0 76.0 76.0 74.0 74.0 103.0 84.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:86.50 stddev:18.44 (21.3%) stddev-sans-first:18.97 11:38:25 INFO - PROCESS | 6694 | Values: 85.0 86.0 123.0 87.0 87.0 88.0 129.0 85.0 87.0 121.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:38:25 INFO - PROCESS | 6694 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 118.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:38:25 INFO - PROCESS | 6694 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 11:38:25 INFO - PROCESS | 6694 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.03 (2.0%) stddev-sans-first:1.05 11:38:25 INFO - PROCESS | 6694 | Values: 53.0 51.0 54.0 53.0 51.0 52.0 53.0 52.0 51.0 52.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:38:25 INFO - PROCESS | 6694 | Values: 62.0 62.0 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:4.97 (6.2%) stddev-sans-first:5.12 11:38:25 INFO - PROCESS | 6694 | Values: 78.0 85.0 78.0 78.0 79.0 80.0 82.0 80.0 94.0 79.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:7.68 (6.1%) stddev-sans-first:7.88 11:38:25 INFO - PROCESS | 6694 | Values: 120.0 122.0 121.0 129.0 120.0 130.0 117.0 130.0 143.0 123.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:163.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 11:38:25 INFO - PROCESS | 6694 | Values: 160.0 163.0 163.0 164.0 159.0 164.0 159.0 163.0 158.0 161.0 11:38:25 INFO - PROCESS | 6694 | 11:38:25 INFO - PROCESS | 6694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:38:25 INFO - PROCESS | 6694 | Values: 64.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 63.0 65.0 11:38:25 INFO - PROCESS | 6694 | -------- Summary: end -------- 11:38:25 INFO - PROCESS | 6694 | 11:38:26 INFO - TEST-INFO | 6694: exit 0 11:38:26 INFO - TEST-OK | kraken | took 61159ms 11:38:26 INFO - SUITE-END | took 1175s 11:38:26 INFO - Completed test suite (00:19:35) 11:38:26 INFO - javascript benchmark 11:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.14690959986, 3120.500719884819, 3133.373325334933, 3148.197209711523, 3186.9521957170646, 5232.0320740663, 5296.9735151324285, 5395.865103372413, 5497.642653227543, 5500.4774546418075, 5363.061464243751, 5387.353517577886, 5402.135658294674, 5458.344998600173, 5463.31708536433, 4844.951550484503, 4854.514548545135, 4946.604271658259, 4951.876203094916, 5093.719845408501, 4964.280179374006, 4977.975110124445, 5022.84931452057, 5036.672616279949, 5056.115179843531, 4726.621870250389, 4761.761911904408, 4807.567318941277, 4895.853124406273, 4904.313396124546, 4867.221244600847, 4870.805167793284, 4871.80512779492, 4910.582600478963, 4933.531314525115, 4866.78099485524, 4866.829660961885, 4878.926816097762, 4884.072026315024, 4952.752362381866, 5146.459621739738, 5318.680879147263, 5389.353277606712, 5390.703511306877, 5393.325834270716, 5788.102844059177, 5835.241418615553, 5846.093855452412, 5849.912251316234, 5852.034414321632, 5819.0, 5849.356570777254, 5888.764449422018, 5896.410358964112, 5903.085021821625, 5149.897002059975, 5328.760205790749, 5386.892262154735, 5390.0, 5472.124460086367, 5956.85107872298, 5956.970215148896, 5968.16445697594, 5971.850703732354, 5977.880442391215, 5387.488188622075, 5728.942710572925, 5737.684427356536, 5741.282339707536, 5741.971290143606, 5682.54539636828, 5739.053056245672, 5742.081266997344, 5742.454466825645, 5778.595498315161, 5753.971230143822, 5757.0, 5757.539396848242, 5760.049591817303, 5760.36635970043, 5547.140193270049, 5664.376918538957, 5720.2849643794525, 5772.0, 5774.740136693775, 4376.387305777193, 4393.956060439418, 4395.450568678915, 4431.091626216682, 4438.622717069021, 3905.082305658168, 3917.4123881417445, 3929.646331830149, 3935.252302062599, 3959.5050618672667, 5366.946330536644, 5464.972675136679, 5476.91784623231, 5488.451154884479, 5531.778728850801, 5827.970860145757, 5849.61977471463, 5858.912116318259, 5910.556708246899, 5920.733566989496, 5561.277033985556, 5571.582131340085, 5572.0, 5574.1081426972305, 5577.721113944286, 4817.253325734517, 5004.024215278058, 5032.647714660012, 5043.830074174001, 5044.9495505045215, 6096.073160813016, 6104.428839602234, 6109.34393638171, 6113.020255720364, 6116.396640261158, 5928.288605367384, 5928.673922934107, 5930.05119180929, 5932.0508718604815, 5966.642001479751, 5561.4716601922755, 5869.6771677558145, 5950.523958083257, 5991.64050156992, 6080.90878636812, 5733.0, 5763.625364351304, 5767.480926716616, 5768.192453056491, 5772.509336706427, 5820.417958204146, 5860.267466566679, 5869.383714709894, 5874.265716785402, 5879.647221166743, 5475.72621368938, 5653.349864765604, 5682.403347648437, 5710.885782284414, 5734.053881109737, 5688.317401911797, 5692.430756924275, 5697.943020569741, 5700.173474846041, 5705.7432415542235, 5352.518273355417, 5614.63504872182, 5625.521830644441, 5629.577781666309, 5629.8592535186945, 5572.91640625399, 5609.80365687199, 5642.0, 5719.57103217252, 5731.111677689964, 5476.589255805751, 5500.917486237629, 5531.1426728857095, 5543.057680194296, 5583.637063590853], "value": 5338.623171339857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.275500776572, 609.6890585801243, 610.3560743415694, 631.9020551814467, 638.5530128909764, 30086.849565752167, 41813.16373672525, 43004.354934676005, 43097.78451107748, 47120.764396178056, 44531.77734111325, 44757.77621111898, 44896.55103448965, 44928.3260751089, 44946.55053449464, 8602.741917742478, 8757.343199260049, 8759.211670949613, 8777.42946708465, 8789.516576588285, 8675.392722509427, 8823.823523529525, 8825.779355516132, 8826.646934122627, 8829.60266787996, 8825.69110081144, 8871.556422178865, 8879.955600222022, 8891.0, 8891.377603567753, 8839.558022098901, 8870.512121833297, 8878.778030549256, 8884.02275749667, 8889.377743557954, 8702.303815694793, 8751.518666473341, 8764.0, 8775.297976161892, 8792.956035219848, 42602.147957040994, 42951.35572966408, 43028.784856075836, 43058.784706076585, 43111.784441077594, 3431.2108215110416, 3937.940930886039, 3973.1060511384994, 4083.530394004668, 4182.64447521961, 32756.181095472803, 33172.834135829406, 33536.6646333536, 33549.32901341984, 33681.15797105068, 4358.5205627380965, 4399.406080179167, 4428.3578881062385, 4608.907821843578, 4613.538646135393, 331322.0, 332396.3380183108, 337177.0, 339719.0, 341936.0, 50703.239451408255, 55016.0, 55927.72036139793, 56007.43992560104, 56123.71938140283, 48902.510974889796, 53435.73282133642, 53463.19805202925, 57446.138307925416, 58588.41411585915, 15910.920445397698, 15915.204239787965, 16004.67990640204, 16018.519444416686, 16023.759643605355, 13272.13731107475, 13335.399907004208, 13358.933205333911, 13411.195328280335, 13417.463301467831, 13962.371693273826, 15004.174770387734, 15773.447929322649, 15834.60413489672, 15856.048637081813, 5495.890082198333, 5600.243967064475, 5776.913346299809, 5847.502962248256, 5888.941110588839, 913.4838816069033, 991.2862738828032, 1042.8852826189113, 1088.7256847955475, 1100.5198008678315, 32128.839355803073, 32202.19494512609, 32476.512852307234, 32602.673973260436, 33013.339733205205, 1114.9609763658234, 1133.2350663302402, 1146.7649131927935, 1190.0539071438227, 1207.4204381896739, 16919.0, 17130.40043598493, 17181.226844792014, 17225.827741722675, 17238.936993735246, 502787.0, 505128.0, 505149.0, 509162.0, 509307.61577650066, 57583.712081440164, 57617.71191144017, 57719.0, 57735.42264577385, 57904.4209557899, 1270.675977625718, 1331.9600411987656, 1344.3516272942288, 1354.2010213973804, 1363.3932899859467, 30793.538096929013, 31246.68753312438, 32322.0, 32479.0, 32546.969628886032, 50921.0, 51182.0, 51606.0, 51648.741756290976, 51657.483425165265, 439509.0, 440058.0, 440693.0, 440934.0, 441884.4398226187, 33796.3240735179, 37146.44280335851, 41210.587894120676, 41825.58174418217, 42183.578164217965, 43592.34611480894, 48221.75889120532, 48749.75625121852, 49025.754871225414, 49384.50615493799, 40208.1958360837, 40976.79511602423, 41423.0, 42071.57928420677, 42445.0, 40229.79885100556, 40360.79819600883, 40546.0, 41645.37531937084, 41743.7912810434, 40461.39307910325, 41531.169376611695, 41705.37441938434, 41759.37360939649, 41772.58227417687, 34998.30003399969, 35924.4611330825, 36657.45013824741, 36763.816180918926, 36896.63103368932, 27238.863805681638, 27818.860905695343, 27818.860905695343, 28059.719402806528, 28161.295967600974], "value": 20014.60461800225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.87560229521955, 378.5173903273327, 381.1386267036498, 387.7692772800183, 389.7213492352967, 15365.308561114749, 17224.397146099873, 18577.72133417998, 19161.808381916177, 19522.707159392587, 17490.300387984465, 18086.81913180868, 18175.272989080422, 18193.090345482706, 18678.0, 5509.338879334476, 5709.8287051388525, 5742.425757424266, 5766.481016708495, 5769.451902069297, 5348.171033489815, 5638.267025286707, 5650.406707295737, 5655.519280861111, 5660.858478538028, 5507.906995341765, 5582.106862901936, 5582.7766889324585, 5584.804531841386, 5589.049861523551, 5566.3598686151, 5691.174779656968, 5691.857703557403, 5757.913631295534, 5758.798442054529, 5006.6033739503055, 5033.572146367563, 5084.9745751271375, 5093.5415812576675, 5095.031943930679, 22162.77837221623, 22203.777962220334, 22394.55210895773, 22767.430814229778, 22791.0, 2461.3108329667543, 2473.492933948536, 2489.191012920808, 2601.869906504667, 2966.61434013579, 14516.201608911506, 15185.164815935119, 15684.372625094982, 16423.0, 17110.657786844193, 2011.145263263122, 2154.7394774057198, 2178.161407857986, 2198.3404978506383, 2240.409309390335, 63495.365046349405, 71327.93008104882, 85827.0, 88559.0, 95729.5213523935, 16810.747838782427, 16956.491305260613, 17025.744613830804, 17660.470185894443, 18108.275668973358, 31812.681873180973, 32021.519677204862, 32198.678013220037, 32264.83867580694, 32352.514712279335, 8737.650493980169, 8934.878861748146, 8988.280937524982, 9037.096290371042, 9547.665831695856, 7876.763697089096, 8091.271785539212, 8542.145785421408, 8821.60302786376, 8850.64597416109, 8606.31149508038, 8922.330825188137, 8988.865167022499, 9039.954800226089, 9110.225630821322, 3073.9538906916414, 3242.2218667520096, 3329.6503867094093, 3371.898843034713, 3496.73774466916, 856.2636132925679, 939.5349302095507, 1040.5057597641212, 1055.4089709762557, 1067.3755852826184, 19121.80878191228, 19369.709454358195, 19415.8058419414, 19492.0, 19626.11682474292, 985.3792110970043, 999.3354419311077, 1022.1107636356269, 1031.2626472072354, 1055.2982266792496, 10358.430286334324, 10671.986161314662, 10740.785184296426, 10790.460476976119, 10798.73003174927, 471363.0, 480931.0, 485350.305733181, 487824.0, 498566.0, 93061.0, 96714.51642741742, 96731.51634241783, 96822.0, 97259.51370243104, 999.0858364596459, 1025.1337619711333, 1041.4896700616644, 1049.4333060147587, 1055.4247934875511, 17390.47828565145, 17418.216180271666, 17457.0, 17685.38101166453, 17938.372156974445, 38588.0, 40383.59616403798, 42248.5775142257, 43892.0, 45273.32090018586, 49319.0, 59609.0, 59643.0, 59693.0, 60724.69637651784, 8437.367197460093, 8556.31549476028, 8674.696385626472, 8749.381364447598, 8820.2061814437, 12312.569060082855, 13665.86334136646, 13972.650683732581, 14027.649308766955, 14053.437862485795, 11599.594014209462, 11962.282263064244, 12193.634190974284, 12716.682082947631, 12798.232106073665, 11911.225770324902, 11995.160338776202, 12097.399059202313, 12494.312812795384, 12599.811002835148, 12129.939350303192, 12411.44148513301, 12649.747005060031, 12660.366981650697, 12803.807942880678, 8493.830123397622, 8595.09751476086, 8778.912210878065, 8781.297496200417, 9121.954390228006, 11970.054886057645, 12134.575289864812, 12496.562620308245, 12714.427850746553, 12736.0], "value": 10079.369398057877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.114419906066, 1418.241240936099, 1428.3358238419137, 1541.5529496446031, 1726.283592309191, 8192.303654189394, 8598.398112132154, 8642.870356944642, 8915.821683566324, 8930.866037009433, 8764.956175219131, 8788.824223515527, 8860.424072435304, 8860.601272942717, 8879.422837515556, 1969.350114462224, 2259.141526220034, 2282.6918366020623, 2290.0, 2301.2635956493928, 2337.298810356886, 2378.500514891875, 2379.8691071991034, 2385.5825230584664, 2386.8448550844228, 2310.4108452344713, 2328.6157783965627, 2332.1720789119872, 2333.46330344021, 2348.6124789409814, 1869.5326168457887, 2174.8695078295355, 2221.6334304839684, 2229.609818281794, 2260.2993072147524, 2257.063318722728, 2274.408653750037, 2275.8862056897087, 2281.9543609127722, 2282.931512054641, 9118.179363857285, 9183.678571249975, 9187.67843125494, 9194.770130746718, 9195.0, 5007.824726134604, 5067.189249720064, 5108.923366149511, 5120.667156634844, 5122.103631864409, 3147.4806656901583, 3198.5202219667003, 3348.2466445049913, 3361.2773253750315, 3374.7468939829364, 1057.962971296001, 1072.774717309366, 1089.5206109311957, 1101.3809699741366, 1103.1836441033659, 12506.937465312707, 12533.248005119722, 12565.183263087962, 12571.120021598492, 12577.182483138658, 4365.781710914442, 4449.3326001100095, 4478.0596074824, 4488.685791994529, 4587.839425620154, 10421.895781042243, 10428.426436545911, 10449.738756531147, 10457.058864702214, 10459.424731639832, 5110.66780659256, 5145.0, 5145.536901678867, 5148.613853960968, 5149.639525233198, 3970.06703424695, 4089.0, 4100.2414553307735, 4663.860084197479, 4815.783289751969, 3899.5710471848074, 3939.665128464055, 3987.2424239395004, 4036.6972477064337, 4056.290149223874, 1210.17707958589, 1216.0454043575928, 1229.3115855121162, 1230.7107829660022, 1236.1347057060093, 800.5876973358725, 861.4658911474926, 913.1781396742984, 947.0624082158613, 951.4101257220567, 6027.276726792726, 6145.231846019247, 6147.907781383194, 6207.286162091327, 6299.149614802035, 414.5398607545622, 428.0, 429.7657776511809, 431.77116128451974, 432.23278680342645, 4115.58844115592, 4262.104957958863, 4313.827446902152, 4316.913661726748, 4323.589259020388, 11054.557817687364, 11492.42537873103, 11586.073114150848, 11596.652100437, 11628.244164129304, 11430.657080287605, 11459.828102578467, 11461.484233209525, 11463.31220126795, 11470.254433461798, 7736.303732664087, 8018.396320735759, 8020.639071241808, 8271.875921861178, 8460.576971151419, 5850.94149058521, 6005.0, 6096.055111457554, 6099.756009759737, 6155.045967874987, 10198.235132365251, 10461.895381046092, 10606.045455909005, 10654.307470014424, 10666.466676665981, 10261.692149235534, 10405.895941040493, 10835.51240194209, 10836.891631083588, 10865.728356791144, 6810.693518791567, 7616.276453736886, 7852.882206767017, 8046.396520260887, 8302.086770455124, 8758.299336053227, 8767.649294028168, 8834.602442890215, 8839.955800221214, 8849.55752212374, 7523.3229009389415, 7860.371170306476, 7882.211778822072, 7934.920650793418, 7980.12218655959, 7534.7944328907115, 7642.4650274480255, 7677.769666910001, 7691.461597688108, 7804.141544429995, 7253.854922901618, 7328.303811137934, 7341.77974660761, 7353.889691654736, 7362.558246505013, 4802.975985120052, 4952.851414457572, 5058.772355243949, 5062.594992400673, 5189.0, 5099.23511473282, 5121.487851214849, 5127.820526281562, 5178.559822414986, 5251.868703282448], "value": 4526.29078610838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.6222428627785, 305.93116548776527, 312.90143604764495, 313.5751057317336, 314.14239127182776, 5000.699958002522, 5072.898542029157, 5248.553872920802, 5292.020976119421, 5296.311479507668, 5282.762275697593, 5285.418603953562, 5288.814891478799, 5294.629375943686, 5309.522143007129, 4100.384942258655, 4102.815373308194, 4125.092479654479, 4127.29835927893, 4130.256553820311, 3929.135590170158, 4056.8782936511952, 4095.3037983542868, 4116.7529948203055, 4159.334506478964, 4042.4744783178144, 4051.6961227908023, 4052.9392059119136, 4081.4898137732785, 4125.339945608704, 4028.315186418316, 4049.9595004050025, 4054.7972601369815, 4059.918801623966, 4069.186162767429, 3593.4609808528667, 3611.819409029538, 3616.150204701893, 3634.7819130852236, 3634.800085995269, 5122.743862806845, 5130.71781052042, 5175.663581867167, 5186.429492755794, 5189.792408303663, 4435.68950173488, 4561.475430325522, 4602.815887364502, 4604.194266003436, 4621.74580398078, 5210.478952104797, 5318.494742999409, 5495.505404513613, 5498.780048798043, 5519.39286678465, 3945.1517923646265, 3950.2692001979726, 3953.960460395388, 3959.109200429909, 3962.385830196324, 5554.361248456398, 5565.2486914266465, 5604.719764011783, 5697.77208911643, 5701.543876489913, 3991.221711766236, 4003.4786781023026, 4020.537638171589, 4021.7184797063924, 4044.797760111983, 4086.223617512663, 4092.263392589303, 4094.549599544048, 4098.549159592442, 4100.282450571138, 4493.393391892053, 4608.655206879806, 4674.984634910464, 4686.437627484724, 4696.483386827446, 5499.085484693119, 5533.418991005967, 5542.5565954723525, 5546.528545073633, 5548.778048878, 1373.1486478383467, 1382.861713828609, 1390.3743315508061, 1402.2427888940063, 1411.745885740556, 870.1596757654207, 907.5552979040223, 908.4367692030983, 914.4970266353479, 926.6756635177769, 4726.054789042205, 4753.33453316536, 4777.065288558139, 4780.378550788375, 4806.735629540409, 4975.5522003019905, 4982.302477653131, 5005.6996580205305, 5051.191809310492, 5061.670991385548, 4701.318308845267, 4800.567948884617, 4816.530958057756, 4828.76866399066, 4952.826651067196, 3001.6848230935875, 3016.8189908605555, 3023.818570885754, 3034.924126896801, 3053.129857990462, 5848.678322692293, 5873.324567674772, 5891.852703682443, 5895.4399332063385, 5902.498287645598, 5602.691851948182, 5790.913136302959, 5820.73806678692, 5832.766689332464, 5860.267466566679, 5828.912566311508, 5855.59920432612, 5878.912401205791, 5896.734646940898, 5911.55663325261, 5451.264079349237, 5688.203651488878, 5729.312482502127, 5730.484256416942, 5769.596128271149, 5631.267935168402, 5675.659460432387, 5693.772249110155, 5726.370099288992, 5771.826845194483, 5904.350521442724, 5912.46787789101, 5914.408559144051, 5937.0, 5950.553708471795, 3841.4621952927173, 3992.9600703992587, 4012.317905955936, 4045.4134150547416, 4067.572904844949, 5682.744276507485, 5694.914576281442, 5704.885902281848, 5712.457316554921, 5719.685417302088, 5583.408728512354, 5591.189277554813, 5594.524465420485, 5608.980766923985, 5611.719414029364, 5442.6462279951675, 5442.836714898559, 5551.7779288828, 5553.805616803393, 5562.833115006556, 5414.404415514369, 5446.428125046813, 5451.536619387238, 5475.342958844964, 5500.4499550044675, 5301.973490132525, 5454.59090568201, 5519.647686316878, 5591.916121258266, 5602.299712535933, 5511.944880551304, 5528.44715528444, 5536.1488833250105, 5547.696291371605, 5549.306336707911], "value": 4163.267210821654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8507213485168, 729.2525161709248, 748.7080038784875, 790.2220004988778, 841.3521588376946, 14595.270236488173, 15184.088954662728, 15203.54389368318, 15401.845981540195, 15823.129727864964, 14928.925355373234, 15061.17163556004, 15208.315625796839, 15217.4673886414, 15233.92383038086, 667.4927055437854, 777.4557809533321, 780.2275747010448, 787.8345547435046, 795.387551585279, 792.7304716396424, 794.4756460735915, 797.0554892452434, 797.2386371015666, 799.9160088190714, 822.40786633624, 823.7775800533852, 823.9741521805361, 824.2622852546967, 824.4640983360804, 692.9826754331132, 803.7428023032631, 804.9476784009021, 807.2815194476921, 817.7424111404888, 604.4137186928672, 604.4559896093551, 604.5798170271663, 604.607005446459, 605.2283338743093, 13981.79027314591, 14055.78916316256, 14062.578122656336, 14074.92962535191, 14091.084079534798, 14142.151470911675, 14197.858021419757, 14347.78478322826, 14794.260286985607, 14856.851431485762, 12322.075844311712, 12903.22580645155, 12955.870441295561, 12969.870301297055, 13089.0, 4509.233430316854, 4516.548345165457, 4527.456705195397, 4556.407667003302, 4705.811767529295, 73641.2635873645, 73901.63049184774, 74169.25830741678, 74526.62736686337, 74571.25428745698, 11229.27009744364, 11631.825522617168, 11655.53377864876, 12062.577809776616, 12111.939440302918, 21792.45518862041, 21800.454988625093, 21802.672959905613, 21926.561468770535, 21944.45138871541, 8096.635651395702, 8590.742277731679, 8612.311015118776, 8615.052344242129, 8620.568971551398, 4527.750973696412, 4591.79336929839, 4638.466576343696, 4683.859484215479, 4769.8569042928075, 3378.223008708011, 3490.860365585348, 3496.667816557423, 3498.1429549760473, 3498.7900725956524, 584.9473547380757, 585.9296884373817, 600.9038553831366, 601.7292218501692, 601.9036954087325, 514.2954152810673, 643.324509265279, 661.7849199010341, 683.4256836743857, 697.2957313113792, 8709.259712924346, 9713.320067595341, 9813.656522021838, 9837.458939758239, 9996.150327222267, 646.2019406033545, 657.5232956106785, 662.7812821768805, 667.5560752099799, 693.1231991530718, 4251.59609837065, 4447.822087116479, 4565.543445655408, 4723.267893476516, 4753.31076993834, 66529.66735166294, 66548.66725666437, 66716.0, 99735.50132249293, 117526.0, 98063.0, 98482.0, 99531.0, 100640.0, 100674.49662751639, 85416.57291713501, 86990.0, 87037.5648121768, 88491.57542122868, 88951.0, 8826.558672066243, 8877.955610222167, 8953.955230223808, 9011.504367259864, 9314.673986410444, 50996.23505647344, 51938.0, 53254.4674553265, 53779.08430072611, 53966.73016634892, 67463.403932831, 77039.0, 77264.61367693126, 77509.2249077502, 77581.0, 11847.0, 11872.168948173545, 11877.821832672344, 11918.761624767283, 12295.446704898122, 14171.43314267459, 14430.567082987527, 14511.492097776527, 14532.782008269673, 15395.0, 14652.19412932299, 14870.182139981973, 14912.62718432048, 14916.477923272634, 14982.250887455366, 14473.131612103307, 14777.335019924345, 15270.312835922188, 15495.0, 15681.215939203223, 14474.638134046732, 14608.634784130056, 14722.337494812546, 14926.925365373103, 14947.103173809606, 10773.838392423962, 11448.049011959793, 11457.683613845784, 11689.707757305796, 12550.121491495507, 11444.370559619301, 11506.769864602493, 11600.94199528997, 11774.587889423829, 11831.52673893069], "value": 7484.497471879832, "unit": "score"}], "name": "dromaeo_css", "value": 7304.650684834282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 109.0, 111.0, 110.0, 109.0, 108.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 127.0, 174.0, 128.0, 127.0, 146.0, 124.0, 166.0, 124.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 168.0, 160.0, 161.0, 161.0, 160.0, 160.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 110.0, 76.0, 76.0, 74.0, 74.0, 103.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 123.0, 87.0, 87.0, 88.0, 129.0, 85.0, 87.0, 121.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 54.0, 53.0, 51.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 85.0, 78.0, 78.0, 79.0, 80.0, 82.0, 80.0, 94.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 121.0, 129.0, 120.0, 130.0, 117.0, 130.0, 143.0, 123.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 163.0, 164.0, 159.0, 164.0, 159.0, 163.0, 158.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 65.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1493.6, "alertThreshold": 2.0}]} 11:38:27 INFO - Return code: 0 11:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:27 INFO - # TBPL SUCCESS # 11:38:27 INFO - Running post-action listener: _resource_record_post_action 11:38:27 INFO - ##### 11:38:27 INFO - ##### Finished run-tests step (success) 11:38:27 INFO - ##### 11:38:27 INFO - Running post-run listener: _resource_record_post_run 11:38:27 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515108864; Read time: 8; Write time: 435564 11:38:27 INFO - TinderboxPrint: CPU usage
13.2% 11:38:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:38:27 INFO - TinderboxPrint: I/O write bytes / time
515,108,864 / 435,564 11:38:27 INFO - TinderboxPrint: CPU idle
8,270.4 (86.8%) 11:38:27 INFO - TinderboxPrint: CPU user
1,210.1 (12.7%) 11:38:27 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 219607040; Read time: 0; Write time: 230852 11:38:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295501824; Read time: 8; Write time: 204712 11:38:27 INFO - Running post-run listener: _upload_blobber_files 11:38:27 INFO - Blob upload gear active. 11:38:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:32 INFO - (blobuploader) - INFO - Done attempting. 11:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:33 INFO - (blobuploader) - INFO - Done attempting. 11:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:34 INFO - (blobuploader) - INFO - Done attempting. 11:38:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:34 INFO - Return code: 0 11:38:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a2c0826c09838c5fc9876ec5bff3b55a5c6492dd5b49533c70a2f19e710ffb5c2c24776af5472e109191cb371adec921e5f47ba40ef21f2955c5cf1c0af061", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f29c398609b173902f1a8e1a050a24b803ba79d19148937489477f65742a6a227f1ebb02be7d7694d27ad7ff5ed77999e47edd69c1c777f8267ddfb9c00cb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aeb0c3d3f980164d8698318248a83ce6813abc407a5bb18f111bfb76c8428c671ca1217ea435ab6b2c743b0e927bac0caafabd167971d289cf00e200c942e13f"} 11:38:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:34 INFO - Contents: 11:38:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a2c0826c09838c5fc9876ec5bff3b55a5c6492dd5b49533c70a2f19e710ffb5c2c24776af5472e109191cb371adec921e5f47ba40ef21f2955c5cf1c0af061", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f29c398609b173902f1a8e1a050a24b803ba79d19148937489477f65742a6a227f1ebb02be7d7694d27ad7ff5ed77999e47edd69c1c777f8267ddfb9c00cb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aeb0c3d3f980164d8698318248a83ce6813abc407a5bb18f111bfb76c8428c671ca1217ea435ab6b2c743b0e927bac0caafabd167971d289cf00e200c942e13f"} 11:38:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:34 INFO - Copying logs to upload dir... 11:38:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.081038 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-22 11:38:32.810052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 11:38:32.813606) ========= 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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 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/90a2c0826c09838c5fc9876ec5bff3b55a5c6492dd5b49533c70a2f19e710ffb5c2c24776af5472e109191cb371adec921e5f47ba40ef21f2955c5cf1c0af061", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f29c398609b173902f1a8e1a050a24b803ba79d19148937489477f65742a6a227f1ebb02be7d7694d27ad7ff5ed77999e47edd69c1c777f8267ddfb9c00cb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aeb0c3d3f980164d8698318248a83ce6813abc407a5bb18f111bfb76c8428c671ca1217ea435ab6b2c743b0e927bac0caafabd167971d289cf00e200c942e13f"} build_url:https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/c3i-_W8nR5qlWUFsF7pzcA/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/90a2c0826c09838c5fc9876ec5bff3b55a5c6492dd5b49533c70a2f19e710ffb5c2c24776af5472e109191cb371adec921e5f47ba40ef21f2955c5cf1c0af061", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f29c398609b173902f1a8e1a050a24b803ba79d19148937489477f65742a6a227f1ebb02be7d7694d27ad7ff5ed77999e47edd69c1c777f8267ddfb9c00cb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aeb0c3d3f980164d8698318248a83ce6813abc407a5bb18f111bfb76c8428c671ca1217ea435ab6b2c743b0e927bac0caafabd167971d289cf00e200c942e13f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 11:38:32.841073) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:38:32.841472) ========= 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=523ca41ca1e0623de333ad52000001bf-1466611666.685074-795067351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 11:38:32.925722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 11:38:32.926098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 11:38:32.926472) ========= ========= Total master_lag: 0.17 =========