builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1466097085.42 results: success (0) buildid: 20160616091425 builduid: 39be919706034a4090fc8da7e4358a84 revision: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.416858) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.417904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.418195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.485089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.485399) ========= 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=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 10:11:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-16 10:11:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.625486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.625961) ========= 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=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.675611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:25.675975) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9d62d5f09bbcafdd18290a01c07629e40d69b8 --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 ea9d62d5f09bbcafdd18290a01c07629e40d69b8 --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=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 10:11:25,975 truncating revision to first 12 chars 2016-06-16 10:11:25,975 Setting DEBUG logging. 2016-06-16 10:11:25,975 attempt 1/10 2016-06-16 10:11:25,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9d62d5f09b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 10:11:26,402 unpacking tar archive at: fx-team-ea9d62d5f09b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:26.467996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:26.468316) ========= script_repo_revision: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:26.468744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:26.469019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 10:11:26.478390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-16 10:11:26.478772) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:26 INFO - MultiFileLogger online at 20160616 10:11:26 in /builds/slave/test 10:11:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:26 INFO - {'append_to_log': False, 10:11:26 INFO - 'base_work_dir': '/builds/slave/test', 10:11:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:26 INFO - 'branch': 'Fx-Team-Non-PGO', 10:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:26 INFO - 'config_files': ('talos/linux_config.py',), 10:11:26 INFO - 'default_actions': ('clobber', 10:11:26 INFO - 'read-buildbot-config', 10:11:26 INFO - 'download-and-extract', 10:11:26 INFO - 'populate-webroot', 10:11:26 INFO - 'create-virtualenv', 10:11:26 INFO - 'install', 10:11:26 INFO - 'run-tests'), 10:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:26 INFO - 'download_minidump_stackwalk': True, 10:11:26 INFO - 'download_symbols': 'ondemand', 10:11:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:26 INFO - 'installer_path': 'installer.exe', 10:11:26 INFO - 'log_level': 'info', 10:11:26 INFO - 'log_name': 'talos', 10:11:26 INFO - 'log_to_console': True, 10:11:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:26 INFO - 'opt_config_files': (), 10:11:26 INFO - 'pip_index': False, 10:11:26 INFO - 'sps_profile': False, 10:11:26 INFO - 'sps_profile_interval': 0, 10:11:26 INFO - 'suite': 'dromaeojs', 10:11:26 INFO - 'system_bits': '32', 10:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:26 INFO - 'title': 'talos-linux64-ix-003', 10:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:26 INFO - 'use_talos_json': True, 10:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:26 INFO - 'work_dir': 'build'} 10:11:26 INFO - ##### 10:11:26 INFO - ##### Running clobber step. 10:11:26 INFO - ##### 10:11:26 INFO - Running pre-action listener: _resource_record_pre_action 10:11:26 INFO - Running main action method: clobber 10:11:26 INFO - rmtree: /builds/slave/test/build 10:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:27 INFO - Running post-action listener: _resource_record_post_action 10:11:27 INFO - ##### 10:11:27 INFO - ##### Finished clobber step (success) 10:11:27 INFO - ##### 10:11:27 INFO - ##### 10:11:27 INFO - ##### Running read-buildbot-config step. 10:11:27 INFO - ##### 10:11:27 INFO - Running pre-action listener: _resource_record_pre_action 10:11:27 INFO - Running main action method: read_buildbot_config 10:11:27 INFO - Using buildbot properties: 10:11:27 INFO - { 10:11:27 INFO - "project": "", 10:11:27 INFO - "product": "firefox", 10:11:27 INFO - "script_repo_revision": "production", 10:11:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:11:27 INFO - "repository": "", 10:11:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:11:27 INFO - "buildid": "20160616091425", 10:11:27 INFO - "pgo_build": "False", 10:11:27 INFO - "basedir": "/builds/slave/test", 10:11:27 INFO - "buildnumber": 1869, 10:11:27 INFO - "slavename": "talos-linux64-ix-003", 10:11:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:11:27 INFO - "platform": "ubuntu64_hw", 10:11:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:11:27 INFO - "branch": "fx-team", 10:11:27 INFO - "repo_path": "integration/fx-team", 10:11:27 INFO - "revision": "ea9d62d5f09bbcafdd18290a01c07629e40d69b8", 10:11:27 INFO - "stage_platform": "linux64", 10:11:27 INFO - "builduid": "39be919706034a4090fc8da7e4358a84", 10:11:27 INFO - "slavebuilddir": "test" 10:11:27 INFO - } 10:11:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:11:27 INFO - Running post-action listener: _resource_record_post_action 10:11:27 INFO - ##### 10:11:27 INFO - ##### Finished read-buildbot-config step (success) 10:11:27 INFO - ##### 10:11:27 INFO - ##### 10:11:27 INFO - ##### Running download-and-extract step. 10:11:27 INFO - ##### 10:11:27 INFO - Running pre-action listener: _resource_record_pre_action 10:11:27 INFO - Running main action method: download_and_extract 10:11:27 INFO - mkdir: /builds/slave/test/build/tests 10:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:27 INFO - https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:34 INFO - Downloaded 1361 bytes. 10:11:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:34 INFO - Using the following test package requirements: 10:11:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:11:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'jsshell-linux-x86_64.zip'], 10:11:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:34 INFO - https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:39 INFO - Downloaded 22654315 bytes. 10:11:39 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'] 10:11:39 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 10:11:40 INFO - Return code: 0 10:11:40 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 10:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:40 INFO - https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:41 INFO - Downloaded 22654315 bytes. 10:11:41 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'] 10:11:41 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 10:11:42 INFO - Return code: 0 10:11: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')]} 10:11:42 INFO - https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:43 INFO - Downloaded 14405384 bytes. 10:11:43 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'] 10:11:43 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 10:11:43 INFO - Return code: 0 10:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:43 INFO - https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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 10:11:47 INFO - Downloaded 56169499 bytes. 10:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:11:47 INFO - mkdir: /builds/slave/test/properties 10:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:47 INFO - Contents: 10:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:11:48 INFO - Running post-action listener: _resource_record_post_action 10:11:48 INFO - Running post-action listener: set_extra_try_arguments 10:11:48 INFO - ##### 10:11:48 INFO - ##### Finished download-and-extract step (success) 10:11:48 INFO - ##### 10:11:48 INFO - ##### 10:11:48 INFO - ##### Running populate-webroot step. 10:11:48 INFO - ##### 10:11:48 INFO - Running pre-action listener: _resource_record_pre_action 10:11:48 INFO - Running main action method: populate_webroot 10:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:48 INFO - '--tppagecycles', 10:11:48 INFO - '7'], 10:11:48 INFO - 'tests': ['tsvgm']}}, 10:11:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['damp', 'tps']}, 10:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'tests': ['damp', 'tps']}, 10:11:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['dromaeo_dom']}, 10:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['basic_compositor_video']}, 10:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:11:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['a11yr', 10:11:48 INFO - 'ts_paint', 10:11:48 INFO - 'tpaint', 10:11:48 INFO - 'sessionrestore', 10:11:48 INFO - 'sessionrestore_no_auto_restore', 10:11:48 INFO - 'tabpaint']}, 10:11:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['tsvgx', 10:11:48 INFO - 'tsvgr_opacity', 10:11:48 INFO - 'tart', 10:11:48 INFO - 'tscrollx', 10:11:48 INFO - 'cart']}, 10:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:48 INFO - 'tsvgr_opacity', 10:11:48 INFO - 'tart', 10:11:48 INFO - 'tscrollx', 10:11:48 INFO - 'cart']}, 10:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'talos_options': ['--disable-e10s'], 10:11:48 INFO - 'tests': ['tp5o']}, 10:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'tests': ['tp5o']}, 10:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'talos_options': ['--disable-e10s', 10:11:48 INFO - '--xperf_path', 10:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:48 INFO - 'tests': ['tp5n']}, 10:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:48 INFO - 'talos_options': ['--xperf_path', 10:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:48 INFO - 'tests': ['tp5n']}}, 10:11:48 INFO - 'talos.zip': {'path': '', 10:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:48 INFO - Running post-action listener: _resource_record_post_action 10:11:48 INFO - ##### 10:11:48 INFO - ##### Finished populate-webroot step (success) 10:11:48 INFO - ##### 10:11:48 INFO - ##### 10:11:48 INFO - ##### Running create-virtualenv step. 10:11:48 INFO - ##### 10:11:48 INFO - Running pre-action listener: _resource_record_pre_action 10:11:48 INFO - Running main action method: create_virtualenv 10:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:48 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 10:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:48 INFO - Using real prefix '/usr' 10:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:51 INFO - Installing pip.................done. 10:11:51 INFO - Return code: 0 10:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:11:51 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 10:11:51 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 10:11:51 INFO - Using env: {'DISPLAY': ':0', 10:11:51 INFO - 'HOME': '/home/cltbld', 10:11:51 INFO - 'LANG': 'en_US.UTF-8', 10:11:51 INFO - 'LANGUAGE': 'en_US:en', 10:11:51 INFO - 'LOGNAME': 'cltbld', 10:11:51 INFO - 'MAIL': '/var/mail/cltbld', 10:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:51 INFO - 'MOZ_NO_REMOTE': '1', 10:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:51 INFO - 'NO_EM_RESTART': '1', 10:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:51 INFO - 'PWD': '/builds/slave/test', 10:11:51 INFO - 'SHELL': '/bin/bash', 10:11:51 INFO - 'SHLVL': '1', 10:11:51 INFO - 'TERM': 'linux', 10:11:51 INFO - 'TMOUT': '86400', 10:11:51 INFO - 'USER': 'cltbld', 10:11:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:51 INFO - '_': '/tools/buildbot/bin/python'} 10:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:51 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 10:11:51 INFO - Cleaning up... 10:11:51 INFO - Return code: 0 10:11:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:11:51 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 10:11:51 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 10:11:51 INFO - Using env: {'DISPLAY': ':0', 10:11:51 INFO - 'HOME': '/home/cltbld', 10:11:51 INFO - 'LANG': 'en_US.UTF-8', 10:11:51 INFO - 'LANGUAGE': 'en_US:en', 10:11:51 INFO - 'LOGNAME': 'cltbld', 10:11:51 INFO - 'MAIL': '/var/mail/cltbld', 10:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:51 INFO - 'MOZ_NO_REMOTE': '1', 10:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:51 INFO - 'NO_EM_RESTART': '1', 10:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:51 INFO - 'PWD': '/builds/slave/test', 10:11:51 INFO - 'SHELL': '/bin/bash', 10:11:51 INFO - 'SHLVL': '1', 10:11:51 INFO - 'TERM': 'linux', 10:11:51 INFO - 'TMOUT': '86400', 10:11:51 INFO - 'USER': 'cltbld', 10:11:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:51 INFO - '_': '/tools/buildbot/bin/python'} 10:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:51 INFO - Downloading/unpacking psutil>=3.1.1 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:53 INFO - Installing collected packages: psutil 10:11:53 INFO - Running setup.py install for psutil 10:11:53 INFO - building 'psutil._psutil_linux' extension 10:11:53 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 10:11:53 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 10:11:53 INFO - building 'psutil._psutil_posix' extension 10:11:53 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 10:11:53 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 10:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:54 INFO - Successfully installed psutil 10:11:54 INFO - Cleaning up... 10:11:54 INFO - Return code: 0 10:11:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:11:54 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')]} 10:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:54 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')]} 10:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:54 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:11:54 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 10:11:54 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 10:11:54 INFO - Using env: {'DISPLAY': ':0', 10:11:54 INFO - 'HOME': '/home/cltbld', 10:11:54 INFO - 'LANG': 'en_US.UTF-8', 10:11:54 INFO - 'LANGUAGE': 'en_US:en', 10:11:54 INFO - 'LOGNAME': 'cltbld', 10:11:54 INFO - 'MAIL': '/var/mail/cltbld', 10:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:54 INFO - 'MOZ_NO_REMOTE': '1', 10:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:54 INFO - 'NO_EM_RESTART': '1', 10:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:54 INFO - 'PWD': '/builds/slave/test', 10:11:54 INFO - 'SHELL': '/bin/bash', 10:11:54 INFO - 'SHLVL': '1', 10:11:54 INFO - 'TERM': 'linux', 10:11:54 INFO - 'TMOUT': '86400', 10:11:54 INFO - 'USER': 'cltbld', 10:11:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:54 INFO - '_': '/tools/buildbot/bin/python'} 10:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:11:54 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 10:11:54 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 10:11:54 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 10:11:54 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 10:11:54 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 10:11:54 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 10:11:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:11:56 INFO - Installing collected packages: mozsystemmonitor 10:11:56 INFO - Running setup.py install for mozsystemmonitor 10:11:56 INFO - Successfully installed mozsystemmonitor 10:11:56 INFO - Cleaning up... 10:11:56 INFO - Return code: 0 10:11:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:11:56 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')]} 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 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')]} 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:11:56 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 10:11:56 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 10:11:56 INFO - Using env: {'DISPLAY': ':0', 10:11:56 INFO - 'HOME': '/home/cltbld', 10:11:56 INFO - 'LANG': 'en_US.UTF-8', 10:11:56 INFO - 'LANGUAGE': 'en_US:en', 10:11:56 INFO - 'LOGNAME': 'cltbld', 10:11:56 INFO - 'MAIL': '/var/mail/cltbld', 10:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:56 INFO - 'MOZ_NO_REMOTE': '1', 10:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:56 INFO - 'NO_EM_RESTART': '1', 10:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:56 INFO - 'PWD': '/builds/slave/test', 10:11:56 INFO - 'SHELL': '/bin/bash', 10:11:56 INFO - 'SHLVL': '1', 10:11:56 INFO - 'TERM': 'linux', 10:11:56 INFO - 'TMOUT': '86400', 10:11:56 INFO - 'USER': 'cltbld', 10:11:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:56 INFO - '_': '/tools/buildbot/bin/python'} 10:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:56 INFO - Downloading/unpacking jsonschema==2.5.1 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:11:58 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 10:11:58 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 10:11:58 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 10:11:58 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 10:11:58 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 10:11:58 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 10:11:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:58 INFO - warning: no files found matching '*.txt' 10:11:58 INFO - no previously-included directories found matching 'build' 10:11:58 INFO - no previously-included directories found matching 'dist' 10:11:58 INFO - no previously-included directories found matching '.git*' 10:11:58 INFO - Installing collected packages: jsonschema, functools32 10:11:58 INFO - Running setup.py install for functools32 10:11:58 INFO - warning: no files found matching '*.txt' 10:11:58 INFO - no previously-included directories found matching 'build' 10:11:58 INFO - no previously-included directories found matching 'dist' 10:11:58 INFO - no previously-included directories found matching '.git*' 10:11:58 INFO - Successfully installed jsonschema functools32 10:11:58 INFO - Cleaning up... 10:11:58 INFO - Return code: 0 10:11:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:58 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:11:58 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 10:11:58 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 10:11:58 INFO - Using env: {'DISPLAY': ':0', 10:11:58 INFO - 'HOME': '/home/cltbld', 10:11:58 INFO - 'LANG': 'en_US.UTF-8', 10:11:58 INFO - 'LANGUAGE': 'en_US:en', 10:11:58 INFO - 'LOGNAME': 'cltbld', 10:11:58 INFO - 'MAIL': '/var/mail/cltbld', 10:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:59 INFO - 'MOZ_NO_REMOTE': '1', 10:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:59 INFO - 'NO_EM_RESTART': '1', 10:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:59 INFO - 'PWD': '/builds/slave/test', 10:11:59 INFO - 'SHELL': '/bin/bash', 10:11:59 INFO - 'SHLVL': '1', 10:11:59 INFO - 'TERM': 'linux', 10:11:59 INFO - 'TMOUT': '86400', 10:11:59 INFO - 'USER': 'cltbld', 10:11:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:59 INFO - '_': '/tools/buildbot/bin/python'} 10:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - Downloading docopt-0.6.1.tar.gz 10:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:01 INFO - Running setup.py install for blobuploader 10:12:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:01 INFO - Running setup.py install for requests 10:12:02 INFO - Running setup.py install for docopt 10:12:02 INFO - Successfully installed blobuploader requests docopt 10:12:02 INFO - Cleaning up... 10:12:02 INFO - Return code: 0 10:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:02 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:12:02 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 10:12:02 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 10:12:02 INFO - Using env: {'DISPLAY': ':0', 10:12:02 INFO - 'HOME': '/home/cltbld', 10:12:02 INFO - 'LANG': 'en_US.UTF-8', 10:12:02 INFO - 'LANGUAGE': 'en_US:en', 10:12:02 INFO - 'LOGNAME': 'cltbld', 10:12:02 INFO - 'MAIL': '/var/mail/cltbld', 10:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:02 INFO - 'MOZ_NO_REMOTE': '1', 10:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:02 INFO - 'NO_EM_RESTART': '1', 10:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:02 INFO - 'PWD': '/builds/slave/test', 10:12:02 INFO - 'SHELL': '/bin/bash', 10:12:02 INFO - 'SHLVL': '1', 10:12:02 INFO - 'TERM': 'linux', 10:12:02 INFO - 'TMOUT': '86400', 10:12:02 INFO - 'USER': 'cltbld', 10:12:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:02 INFO - '_': '/tools/buildbot/bin/python'} 10:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:02 INFO - Running setup.py (path:/tmp/pip-xyQbnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:02 INFO - Running setup.py (path:/tmp/pip-uiqCSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:02 INFO - Running setup.py (path:/tmp/pip-sJEYTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:02 INFO - Running setup.py (path:/tmp/pip-t214LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:02 INFO - Running setup.py (path:/tmp/pip-8ZPsVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:03 INFO - Running setup.py (path:/tmp/pip-20TYv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:03 INFO - Running setup.py (path:/tmp/pip-CN5KoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:03 INFO - Running setup.py (path:/tmp/pip-ZUqvgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:03 INFO - Running setup.py (path:/tmp/pip-IiMHfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:03 INFO - Running setup.py (path:/tmp/pip-zxeOtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:03 INFO - Running setup.py (path:/tmp/pip-Y4nHtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:03 INFO - Running setup.py (path:/tmp/pip-rG4Dag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:03 INFO - Running setup.py (path:/tmp/pip-cxRbu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:03 INFO - Running setup.py (path:/tmp/pip-tTHKeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:03 INFO - Running setup.py (path:/tmp/pip-fWDDG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:03 INFO - Running setup.py (path:/tmp/pip-WPw6VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:03 INFO - Running setup.py (path:/tmp/pip-T57Zhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:03 INFO - Running setup.py install for manifestparser 10:12:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:03 INFO - Running setup.py install for mozcrash 10:12:04 INFO - Running setup.py install for mozdebug 10:12:04 INFO - Running setup.py install for mozdevice 10:12:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Running setup.py install for mozfile 10:12:04 INFO - Running setup.py install for mozhttpd 10:12:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Running setup.py install for mozinfo 10:12:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Running setup.py install for mozInstall 10:12:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Running setup.py install for mozleak 10:12:04 INFO - Running setup.py install for mozlog 10:12:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:04 INFO - Running setup.py install for moznetwork 10:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Running setup.py install for mozprocess 10:12:05 INFO - Running setup.py install for mozprofile 10:12:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Running setup.py install for mozrunner 10:12:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Running setup.py install for mozscreenshot 10:12:05 INFO - Running setup.py install for moztest 10:12:05 INFO - Running setup.py install for mozversion 10:12:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:05 INFO - Cleaning up... 10:12:05 INFO - Return code: 0 10:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:05 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:12:05 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 10:12:05 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 10:12:05 INFO - Using env: {'DISPLAY': ':0', 10:12:05 INFO - 'HOME': '/home/cltbld', 10:12:05 INFO - 'LANG': 'en_US.UTF-8', 10:12:05 INFO - 'LANGUAGE': 'en_US:en', 10:12:05 INFO - 'LOGNAME': 'cltbld', 10:12:05 INFO - 'MAIL': '/var/mail/cltbld', 10:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:05 INFO - 'MOZ_NO_REMOTE': '1', 10:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:05 INFO - 'NO_EM_RESTART': '1', 10:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:05 INFO - 'PWD': '/builds/slave/test', 10:12:05 INFO - 'SHELL': '/bin/bash', 10:12:05 INFO - 'SHLVL': '1', 10:12:05 INFO - 'TERM': 'linux', 10:12:05 INFO - 'TMOUT': '86400', 10:12:05 INFO - 'USER': 'cltbld', 10:12:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:05 INFO - '_': '/tools/buildbot/bin/python'} 10:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:05 INFO - Running setup.py (path:/tmp/pip-i7eXYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:05 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)) 10:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:05 INFO - Running setup.py (path:/tmp/pip-OROAcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:06 INFO - Running setup.py (path:/tmp/pip-V6vBMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:06 INFO - Running setup.py (path:/tmp/pip-nr8yBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:06 INFO - Running setup.py (path:/tmp/pip-FIcydI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:06 INFO - Running setup.py (path:/tmp/pip-bTiEYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:06 INFO - Running setup.py (path:/tmp/pip-KG79Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:06 INFO - Running setup.py (path:/tmp/pip-yqUu2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:06 INFO - Running setup.py (path:/tmp/pip-XIqT8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:06 INFO - Running setup.py (path:/tmp/pip-TUFiSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:06 INFO - Running setup.py (path:/tmp/pip-q_G_Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:06 INFO - Running setup.py (path:/tmp/pip-6GyfFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:06 INFO - Running setup.py (path:/tmp/pip-SLv_Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:06 INFO - Running setup.py (path:/tmp/pip-Uggb3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:06 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)) 10:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:06 INFO - Running setup.py (path:/tmp/pip-35U7hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:07 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)) 10:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:07 INFO - Running setup.py (path:/tmp/pip-qkmwyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:07 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)) 10:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:07 INFO - Running setup.py (path:/tmp/pip-Am9nA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:07 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)) 10:12:07 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)) 10:12:07 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)) 10:12:07 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)) 10:12:07 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)) 10:12:07 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)) 10:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:07 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 10:12:07 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 10:12:07 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 10:12:07 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 10:12:07 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 10:12:07 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 10:12:09 INFO - Downloading blessings-1.6.tar.gz 10:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:09 INFO - Installing collected packages: blessings 10:12:09 INFO - Running setup.py install for blessings 10:12:09 INFO - Successfully installed blessings 10:12:09 INFO - Cleaning up... 10:12:09 INFO - Return code: 0 10:12:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:09 INFO - Reading from file tmpfile_stdout 10:12:09 INFO - Current package versions: 10:12:09 INFO - argparse == 1.2.1 10:12:09 INFO - blessings == 1.6 10:12:09 INFO - blobuploader == 1.2.4 10:12:09 INFO - docopt == 0.6.1 10:12:09 INFO - functools32 == 3.2.3-2 10:12:09 INFO - jsonschema == 2.5.1 10:12:09 INFO - manifestparser == 1.1 10:12:09 INFO - mozInstall == 1.12 10:12:09 INFO - mozcrash == 0.17 10:12:09 INFO - mozdebug == 0.1 10:12:09 INFO - mozdevice == 0.48 10:12:09 INFO - mozfile == 1.2 10:12:09 INFO - mozhttpd == 0.7 10:12:09 INFO - mozinfo == 0.9 10:12:09 INFO - mozleak == 0.1 10:12:09 INFO - mozlog == 3.2 10:12:09 INFO - moznetwork == 0.27 10:12:09 INFO - mozprocess == 0.22 10:12:09 INFO - mozprofile == 0.28 10:12:09 INFO - mozrunner == 6.11 10:12:09 INFO - mozscreenshot == 0.1 10:12:09 INFO - mozsystemmonitor == 0.3 10:12:09 INFO - moztest == 0.7 10:12:09 INFO - mozversion == 1.4 10:12:09 INFO - psutil == 3.1.1 10:12:09 INFO - requests == 1.2.3 10:12:09 INFO - wsgiref == 0.1.2 10:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:12:09 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 10:12:09 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 10:12:09 INFO - Using env: {'DISPLAY': ':0', 10:12:09 INFO - 'HOME': '/home/cltbld', 10:12:09 INFO - 'LANG': 'en_US.UTF-8', 10:12:09 INFO - 'LANGUAGE': 'en_US:en', 10:12:09 INFO - 'LOGNAME': 'cltbld', 10:12:09 INFO - 'MAIL': '/var/mail/cltbld', 10:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:09 INFO - 'MOZ_NO_REMOTE': '1', 10:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:09 INFO - 'NO_EM_RESTART': '1', 10:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:09 INFO - 'PWD': '/builds/slave/test', 10:12:09 INFO - 'SHELL': '/bin/bash', 10:12:09 INFO - 'SHLVL': '1', 10:12:09 INFO - 'TERM': 'linux', 10:12:09 INFO - 'TMOUT': '86400', 10:12:09 INFO - 'USER': 'cltbld', 10:12:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:09 INFO - '_': '/tools/buildbot/bin/python'} 10:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 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)) 10:12:09 INFO - Cleaning up... 10:12:09 INFO - Return code: 0 10:12:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:12:09 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 10:12:09 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 10:12:09 INFO - Using env: {'DISPLAY': ':0', 10:12:09 INFO - 'HOME': '/home/cltbld', 10:12:09 INFO - 'LANG': 'en_US.UTF-8', 10:12:09 INFO - 'LANGUAGE': 'en_US:en', 10:12:09 INFO - 'LOGNAME': 'cltbld', 10:12:09 INFO - 'MAIL': '/var/mail/cltbld', 10:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:09 INFO - 'MOZ_NO_REMOTE': '1', 10:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:09 INFO - 'NO_EM_RESTART': '1', 10:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:09 INFO - 'PWD': '/builds/slave/test', 10:12:09 INFO - 'SHELL': '/bin/bash', 10:12:09 INFO - 'SHLVL': '1', 10:12:09 INFO - 'TERM': 'linux', 10:12:09 INFO - 'TMOUT': '86400', 10:12:09 INFO - 'USER': 'cltbld', 10:12:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:09 INFO - '_': '/tools/buildbot/bin/python'} 10:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:09 INFO - Cleaning up... 10:12:09 INFO - Return code: 0 10:12:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:09 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 0x7fe6efe18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, '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': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', '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 10:12:09 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 10:12:09 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 10:12:09 INFO - Using env: {'DISPLAY': ':0', 10:12:09 INFO - 'HOME': '/home/cltbld', 10:12:09 INFO - 'LANG': 'en_US.UTF-8', 10:12:09 INFO - 'LANGUAGE': 'en_US:en', 10:12:09 INFO - 'LOGNAME': 'cltbld', 10:12:09 INFO - 'MAIL': '/var/mail/cltbld', 10:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:09 INFO - 'MOZ_NO_REMOTE': '1', 10:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:09 INFO - 'NO_EM_RESTART': '1', 10:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:09 INFO - 'PWD': '/builds/slave/test', 10:12:09 INFO - 'SHELL': '/bin/bash', 10:12:09 INFO - 'SHLVL': '1', 10:12:09 INFO - 'TERM': 'linux', 10:12:09 INFO - 'TMOUT': '86400', 10:12:09 INFO - 'USER': 'cltbld', 10:12:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:09 INFO - '_': '/tools/buildbot/bin/python'} 10:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:10 INFO - Downloading/unpacking flake8 10:12:10 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 10:12:10 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 10:12:10 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 10:12:10 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 10:12:10 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 10:12:10 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 10:12:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 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 10:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:12 INFO - no previously-included directories found matching 'docs/_build' 10:12:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:12 INFO - Running setup.py install for pep8 10:12:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:12 INFO - no previously-included directories found matching 'docs/_build' 10:12:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:13 INFO - Cleaning up... 10:12:13 INFO - Return code: 0 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - Running post-action listener: _start_resource_monitoring 10:12:13 INFO - Starting resource monitoring. 10:12:13 INFO - ##### 10:12:13 INFO - ##### Finished create-virtualenv step (success) 10:12:13 INFO - ##### 10:12:13 INFO - ##### 10:12:13 INFO - ##### Running install step. 10:12:13 INFO - ##### 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: install 10:12:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:13 INFO - Reading from file tmpfile_stdout 10:12:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:13 INFO - Reading from file tmpfile_stdout 10:12:13 INFO - Output received: 10:12:13 INFO - Usage: mozinstall [options] installer 10:12:13 INFO - Options: 10:12:13 INFO - -h, --help show this help message and exit 10:12:13 INFO - -d DEST, --destination=DEST 10:12:13 INFO - Directory to install application into. [default: 10:12:13 INFO - "/builds/slave/test"] 10:12:13 INFO - --app=APP Application being installed. [default: firefox] 10:12:13 INFO - mkdir: /builds/slave/test/build/application 10:12:13 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'] 10:12:13 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 10:12:29 INFO - Reading from file tmpfile_stdout 10:12:29 INFO - Output received: 10:12:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:29 INFO - Running post-action listener: _resource_record_post_action 10:12:29 INFO - ##### 10:12:29 INFO - ##### Finished install step (success) 10:12:29 INFO - ##### 10:12:29 INFO - ##### 10:12:29 INFO - ##### Running run-tests step. 10:12:29 INFO - ##### 10:12:29 INFO - Running pre-action listener: _resource_record_pre_action 10:12:29 INFO - Running main action method: run_tests 10:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:29 INFO - Python 2.7.3 10:12:29 INFO - Return code: 0 10:12:29 INFO - grabbing minidump binary from tooltool 10:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:29 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 0x282f2e0>, '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 0x279b140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x279b5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:29 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 10:12:29 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 10:12:29 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 10:12:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:29 INFO - Return code: 0 10:12:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:30 INFO - Return code: 0 10:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 10:12:30 INFO - Using env: {'DISPLAY': ':0', 10:12:30 INFO - 'HOME': '/home/cltbld', 10:12:30 INFO - 'LANG': 'en_US.UTF-8', 10:12:30 INFO - 'LANGUAGE': 'en_US:en', 10:12:30 INFO - 'LOGNAME': 'cltbld', 10:12:30 INFO - 'MAIL': '/var/mail/cltbld', 10:12:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:30 INFO - 'MOZ_NO_REMOTE': '1', 10:12:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:30 INFO - 'NO_EM_RESTART': '1', 10:12:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:30 INFO - 'PWD': '/builds/slave/test', 10:12:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:30 INFO - 'SHELL': '/bin/bash', 10:12:30 INFO - 'SHLVL': '1', 10:12:30 INFO - 'TERM': 'linux', 10:12:30 INFO - 'TMOUT': '86400', 10:12:30 INFO - 'USER': 'cltbld', 10:12:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466093534.845881-826466114', 10:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:30 INFO - '_': '/tools/buildbot/bin/python'} 10:12:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:12:30 INFO - mozversion application_buildid: 20160616091425 10:12:30 INFO - mozversion application_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 10:12:30 INFO - mozversion application_display_name: Nightly 10:12:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:30 INFO - mozversion application_name: Firefox 10:12:30 INFO - mozversion application_remotingname: firefox 10:12:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:12:30 INFO - mozversion application_vendor: Mozilla 10:12:30 INFO - mozversion application_version: 50.0a1 10:12:30 INFO - mozversion platform_buildid: 20160616091425 10:12:30 INFO - mozversion platform_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 10:12:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:12:30 INFO - mozversion platform_version: 50.0a1 10:12:30 INFO - using testdate: 1466097150 10:12:30 INFO - actual date: 1466097150 10:12:30 INFO - starting webserver on 'localhost:58681' 10:12:30 INFO - SUITE-START | Running 2 tests 10:12:30 INFO - TEST-START | dromaeo_css 10:12:30 INFO - operating with platform_type : linux_ 10:12:30 INFO - Initialising browser for dromaeo_css test... 10:12:30 INFO - TEST-INFO | started process 17903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOU7O1e/profile http://localhost:58681/getInfo.html) 10:12:35 INFO - PROCESS | 17903 | __metrics Screen width/height:1600/1200 10:12:35 INFO - PROCESS | 17903 | colorDepth:24 10:12:35 INFO - PROCESS | 17903 | Browser inner width/height: 1024/697 10:12:35 INFO - PROCESS | 17903 | __metrics 10:12:36 INFO - PROCESS | 17903 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:12:37 INFO - PROCESS | 17903 | console.error: PushService: 10:12:37 INFO - PROCESS | 17903 | stateChangeProcessEnqueue: Error transitioning state 10:12:37 INFO - PROCESS | 17903 | UnknownError 10:12:37 INFO - TEST-INFO | 17903: exit 0 10:12:37 INFO - Browser initialized. 10:12:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:38 INFO - TEST-INFO | started process 17982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOU7O1e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:50 INFO - PROCESS | 17982 | RSS: Main: 175808512 10:12:50 INFO - PROCESS | 17982 | 10:13:41 INFO - PROCESS | 17982 | 1466097221364 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] 10:15:54 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58681/tests/dromaeo/cssquery-ext.html) 10:15:55 INFO - PROCESS | 17982 | RSS: Main: 257245184 10:15:55 INFO - PROCESS | 17982 | 10:18:58 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-ext.html (next: http://localhost:58681/tests/dromaeo/cssquery-jquery.html) 10:18:58 INFO - PROCESS | 17982 | RSS: Main: 259301376 10:18:58 INFO - PROCESS | 17982 | 10:22:01 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58681/tests/dromaeo/cssquery-mootools.html) 10:22:01 INFO - PROCESS | 17982 | RSS: Main: 252141568 10:22:01 INFO - PROCESS | 17982 | 10:25:03 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58681/tests/dromaeo/cssquery-prototype.html) 10:25:04 INFO - PROCESS | 17982 | RSS: Main: 258342912 10:25:04 INFO - PROCESS | 17982 | 10:28:07 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58681/tests/dromaeo/cssquery-yui.html) 10:28:08 INFO - PROCESS | 17982 | RSS: Main: 239656960 10:28:08 INFO - PROCESS | 17982 | 10:31:10 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:58681/tests/dromaeo/cssquery-yui.html (next: http://localhost:58681/tests/dromaeo/cssquery-dojo.html) 10:31:11 INFO - PROCESS | 17982 | RSS: Main: 293871616 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | __start_tp_report 10:31:11 INFO - PROCESS | 17982 | _x_x_mozilla_page_load 10:31:11 INFO - PROCESS | 17982 | _x_x_mozilla_page_load_details 10:31:11 INFO - PROCESS | 17982 | |i|pagename|runs| 10:31:11 INFO - PROCESS | 17982 | |0;dojo.html;2637.6834779826418;2643.2863126955713;2678.678558572971;2688.2607282997174;2697.0829917827937;4642.303654451834;4723.197056500395;4752.287156926463;4811.182099043162;4852.150873597119;4746.62027037837;4790.736509491977;4791.808327666889;4832.420109586855;4842.9031419371595;4334.43652325198;4402.647788176938;4423.181711383389;4456.465224173104;4573.839915602938;4468.463784345883;4499.730016199022;4521.502634710179;4532.501424843281;4551.840685576006;4283.464566929134;4325.329573916048;4333.046729719456;4391.297392417198;4436.7116137451285;4386.385905973167;4399.494058183318;4411.580899814512;4451.9332210016555;4472.508024117345;4407.537208593084;4430.313301438282;4436.0240747035605;4467.463904331501;4469.396631454744;4682.180618391768;4723.4331880174595;4736.313234580966;4797;4806.927896081562;5181.870453238662;5182.404023537304;5210.869728256786;5226.425093239741;5227.294315267466;5176;5249.790008399659;5264.2893209416625;5266.789328426858;5270.1040823060175;4696.812127514895;4802.135615589157;4835.323054772335;4857.077155340474;4921.138800709933;5356.4107948125675;5356.598255130881;5381.246625472437;5401.432849550819;5416.187571864252;5121.923171152435;5170.819021334235;5176.404713457925;5178.818741344035;5181.481851814864;5062.82280120194;5081.2632168335385;5103.489651034867;5106;5261.131913234273;5066.923996140061;5069.391672999263;5074.492550744896;5075.213341932006;5155.716435596079;5097.388313402415;5105.923411148836;5106.744662766847;5107.080725469377;5108.744562771846;4269.359596060615;4312.439382880206;4313.84901528445;4360.585744354281;4368.017196130909;3814.275287695329;3848.0572259796527;3858.9035274118373;3865.942010869839;3873.3802591585213;4423.535528769433;4443.488998765119;4456.554344565582;4466.173757854807;4467;5242.135047717084;5243.056249874983;5247.947520524746;5266.210068489757;5283.1546952487415;4451.399061126706;4463.5313292103865;4463.799129039201;4468.173387923244;4509.549045095529;4466.508684044752;4529.6376289896725;4532.546745325441;4586.266197408466;4621.399218101626;4820.4456487504385;4851.175300198904;4852.539008794159;4862.4651288357545;4911.386076740408;5137.049645815536;5196.142636464941;5201.47985201492;5202.921956170736;5251.684898906078;4639.86080417588;4793.9280910785665;4826.565609095198;4855.053264613508;4912.6561140719805;5105.412877518985;5119.078565858182;5119.180931051014;5124.103281925573;5166.276721259102;5204.869878253074;5207.71357575337;5218.791248350023;5224.111900976767;5270.841874743764;4906.852794416173;4963.801447942186;5002.999400120063;5028.823991160292;5047.041062198317;5046.823361182341;5047.974760126176;5066.746662666926;5067.5185857343495;5117.667351622282;4936.654434189572;4963.057019166346;5004.024215277986;5006.824761133343;5007.098722230034;4941.110600092018;5008.77460514285;5052.924206136984;5069.138246498031;5086.593072554261;4966.6771659842;4997.075541024922;5002.299678045004;5019.52314530119;5066.645334826674 10:31:11 INFO - PROCESS | 17982 | |1;ext.html;549.3374932409477;570.6747154122149;590.1767034986194;595.2737660054731;601.0713447723268;26786.464270714576;38691;39572.99999999996;39795;39835.60164398355;39964;40340.19319613606;40493.7975310123;40504.59495405045;40626.796866015706;7516.586587737672;7849.529028258323;8008.5595292259195;8011.759647210564;10100.89899101007;9868.309218354718;10261.897381026207;10272.691819245434;10278.074973252405;10285.33145345554;10246.231532635045;10294.073533381994;10299.382037077761;10307;10307.072363487285;7529.774106776833;7722.150563438017;7722.420818438583;10016.198704103654;10242.231832612584;10127.189824813997;10229.897701023043;10245.436500992442;10260.794784104351;10277.434741089237;38079.809600952096;38519.61480385188;38544.22911541782;38554.22891542153;38557.614423855965;3008.503596906508;3213.614366276062;3332.800031998088;3339.9499007514905;3430.9656903430896;29237.26906827325;29382.41235175306;29660.8516957416;29761.25596860074;30211;3321.568196134487;3491.441369380887;3622.873199438033;3647.5805282392334;3695.6858667013335;254892;258792;258819;259084;259343;52534;52636;53215.20177197345;53237.7338113307;53280;31821.52267715986;32766.180845479055;32767.344653106804;34934.47598286028;55984.16023759647;13746.793798093036;13963.371648275648;14048.929755351157;14049.859501405059;14057.367418466194;8978.551072446351;10215.795684086277;10457.477126143662;10463.215258855616;10712.303700259457;17935.282588696307;17998.640027199384;18009.18958646838;18009.18958646864;18019.819801801816;6846.349596788297;6886.067873821893;6988.126484189476;7111.395531379787;7190.9280907191305;774.2644487736673;882.9779255518663;955.2071780422233;960.4045491795132;970.6166064404521;27929.62598179137;28060.43879122447;28277.29306767306;28809.279768005967;28943.42113157725;950.8003319302885;955.5938726041404;965.9042767928771;1061.193492945367;1074.7474343529263;14834.851651483563;14916.179610121331;14934.954553181173;15255;15257.542273731806;379934;380753;381039;382940;385127;48767.75616121897;49261;49285.26072108921;49350.25974610384;49391.50608493941;1055.2771351624008;1123.0790751583622;1167.5271515036425;1171.1801738782885;1187.1986409173774;27171.1848644541;28832.567511487763;28870.278243044093;28973.565396518647;29112.27219319534;35586.46620300749;35746.64253357433;35829;35875.28249435049;35936;292461;292966;293656;294373;294787;21725.13099476003;23796.405089872893;24869.87565062163;24875.01499820033;26365.34086647849;40194.799026004686;40350.798246009756;40406.39390409087;40703.79648101741;41532.1693566133;34850.30299394049;35074.29851403009;35285.47071793977;35374.64625353713;35908;35858.28283434369;35891.282174356886;35901.461478078374;35982.8200858994;36147.819260903525;34712.82643586766;35054.824725876206;35696.64303356933;35707.642923570435;36161.09597259984;30942.845285773426;31726;31728.682713172573;31986.52020219652;32120.196995075312;24460.266192014267;24610.261692149263;24797;24990.75009249957;25079.24762257135 10:31:11 INFO - PROCESS | 17982 | |2;jquery.html;375.65064490024275;378.203880830851;378.57032268375406;389.70382509292926;390.61719514875404;16889.662206755856;17039;17354.82645173548;17854.999999999967;17881.04962681158;16725.414610488635;16785.16074196288;17057.744133837972;17372.826271737278;17396.652066958686;5097.592192624581;5258.1849813279005;5262.289590905236;5304.389995150568;5308.283381743473;3693.409054551259;3918;3933.5279766427925;6126.203593532835;6149.29283132441;5985.461308482236;6091.177691011723;6144.662043587601;6165.599236049665;6166.506679465654;5913.224471591054;5942.257217847769;6097.725602347905;6105.664188469633;6106.236720409926;3357.647447018077;4900.558949694545;5206.114960456732;5207.140821764404;5429.837104886859;20992.580148396948;21023.159073637034;21178.78821211799;21272;21340;1739.1565090930887;1858.2102606392364;1961.3135402608973;2022.4337185588058;2069.2033567076633;5135.897282054375;9382.483963382012;9396.50108034374;9430.528473576362;9482.95258523703;1740.6779745747078;1815.963680726378;1849.5098798818324;1857.3313607101434;1876.4558278099335;62660.37339626637;64668;65186.41474718889;66810.66594667044;68175.65912170407;9252.537373131316;9323.953380233055;10137.949310253402;10241.23190760696;10366.222533310032;14180.432782688576;14227.14637121776;14259.21574313402;14265.215413152377;14271.429142834171;7219.422446204291;7231.674574644154;7237.819054523679;7280.089988751406;7356.852862942818;6749.865002700017;6749.932500675029;6751.594904305757;6799.150106236721;6890.1731792184255;4489.438820147481;4491.393661855608;4512.458504979423;4537.750423726727;4590.563896429834;1823.680855850221;1836.6418548382937;1857.3220774417512;1859.414284500405;1925.7977912319284;800.319728230999;819.3240576524391;848.7793173774863;894.4052205283543;962.4898803634085;16611.584710382336;16744.162791860603;17090.914545427193;17175.398861039805;17260.482185534453;827.5862068965517;842.4313588327976;844.3709436469869;894.1460904835997;922.6263363337858;9415.952920235492;9528.618855245852;9841.114299713061;9863.901360986441;10032.749181270527;370375;371939;373941;375791;380784;53710.7314463433;72914.27085729074;73026.26973730301;73313.26686733065;76004;885.0795173019987;896.3143195455482;903.846346121161;929.110466449342;932.0539652252833;15607.84392156064;15704.842951570337;15855.127967961873;16044.919775401047;16227.918860405622;36045.81977090098;36846.44730329101;37446.25107497889;37733.24533509369;38121.42817857679;49966.25050624316;51659;51896.74051629718;52383.476165239386;52943.73528132489;7713.537187768752;7739.883901741366;7747.418943579141;7804.921950780419;7806.102298235775;5230.555402790806;5288.65623734456;11804.70488237801;12402.5659101931;12404.875951240372;10540.262181647211;10556.419396932935;10575.841362379724;10634.361938283728;10895.945520272347;10572.471376431302;10591.205659575717;10713.678589642323;10896.291741037125;11097;10819.459027048459;10967.451627418757;11085.113190944543;11160.665180044612;11237.157213208879;7542.170361260147;7542.434317426105;7652.04349456318;7745.608263045683;8136.22705842944;8038.959805200937;10086.697399078039;10256.38461692301;10287.331323463952;10349.327293725884 10:31:11 INFO - PROCESS | 17982 | |3;mootools.html;1223.7736018836522;1393.4913756478882;1400.8529104444033;1507.5175943698014;1719.123247143957;6827.351401616845;7605.391568674507;7879.684812607496;7918.406119541029;8137.796555086125;7856.567888766115;7997.720079797208;8002.719904803318;8004.919950800505;8017.158198389173;1901.5246188452886;2103.4951611613255;2182.2907555044594;2203.6804663323887;2211.071350032982;2280.783325584075;2297.908083676651;2302.2862912497094;2302.7121609798774;2304.493011537459;2219.2676416782506;2234.1510226114056;2234.4078819112947;2239.585676649825;2240.820734341257;1821.9089045547669;2059.4439501334705;2130.3715403955794;2154.2998525479284;2162.4810045588947;2208.5582883423217;2216.34617787753;2220.3560967319618;2227.086894373299;2231.141010710872;8007.159248278964;8059.032916050111;8067.919320806835;8073.919260807375;8077.273045425881;4607.654425918069;4709.058188362307;4709.882252943669;4750.097481478542;4755.643326750507;2849.216465471991;2935.66239882412;3030.7423868971164;3042.4675681755825;3056.312329725816;950.9857352139724;958.8274110660078;962.2927148545813;974.4591751577872;983.2576404814391;10931.617393391192;10943.616973405971;10951.83572246417;10962.397068161248;10991.230613857033;4305.052888364555;4371.650267978554;4406.317020861771;4423.911521769611;4426;9291.163795258459;9366.859497107549;9373.390729602554;9380.061993800566;9388.2020028297;4779.498152693986;4782.0914026334885;4787.664863459594;4788.281757736298;4791.329213910055;3701.5002974598083;4117.711760176819;4296.61330480252;4299.527052024275;4364.192624364439;3676.7793932364143;3732.4401339798706;3793.4499497572697;3827.27281816454;3875.806209689504;1073.9140868730483;1226.7117227451542;1241.1126044877956;1243.0801207106676;1265.342022148496;729.8759210934154;766.3332900376708;840;841.3017195727532;849.9277561407226;4895.828645997444;4997.650164488524;5013.498650134958;5079.87300317495;5324.760385782649;820.6881385073754;823.2302796884932;835.4026870787416;852.1648784191403;865.2861389353683;3526.4886591444097;3579.391503444421;3608.3685355062757;3617.692496137805;3641.890743277706;9737;9817.460039697886;9873.210143188528;9968.302218844756;9981.401115933068;9924.40453572788;9934.15559677421;9934.602615895428;9944.204463642891;9948;7460.664270107858;7465.29079737424;7538.849223015619;7618.390528757686;7631.503952243086;5125.769340379767;5151;5155.561777248976;5182.6113041521285;5208.5051920067535;8879.511626860585;9168.266538676757;9241.953790231006;9330.393524420891;9355.251579873458;9331.860022099538;9442.38624489406;9459.621615135318;9460.763480913032;9578.233741300819;5963.642181468952;6349.68251587428;6561.835954101186;6595.043718660863;6717.395434410926;7716.421268405004;7724.497907636211;7787.610619469117;7796.259355361231;7804.6878124874365;6923.480738944499;7108.822279443055;7161.534500257467;7224.13310402734;7302.890456643048;6921.2386637470845;6928.688209030706;6949.513534052568;7049.224585295716;7068.151821781419;6078.787242446493;6170.969145154425;6310.5898116622275;6322.2729386119345;6324.209473815773;4549.931751023803;4569.36028955953;4577.862664120082;4580.816767329269;4626.676132670681;4544.272916333503;4564.041551274269;4593.540645935514;4602.815887364468;4645.790939407802 10:31:11 INFO - PROCESS | 17982 | |4;prototype.html;294.1337760295929;296.73886979458075;304.7455374762073;304.94206100840836;307.03743763302043;4720.103180395722;4827.275908613709;4903.136808012954;4952.900941981163;4969.900601987958;4720;4808.783604737787;4862.829800956967;4869.951300486994;4870.634702397326;3843.730938834283;3846.6922646188236;3853.3834586466173;3861.7876016819064;3863.497745293108;3636.4727114568373;3743.794091324976;3860.7104467164936;3868.6324799144177;3898.7660740355527;3833.8658146964863;3846.8461261549646;3870.4774855394585;3877.1664092220167;3882.223555288939;3805.7906815125157;3836.884893453187;3845.9615403845883;3849;3866.516685414323;3414.607320158189;3417;3424.9315013699834;3432.1934345428804;3433.1588760753775;4560.7035542689955;4740.1230772307235;4746.240601503778;4746.928796068062;4751.192297309466;4373.103513779667;4373.212821692094;4374.803133858953;4382.802773875183;4383.583559561868;4953.405591329028;5062.367204099488;5120.795168193268;5170.97414512925;5197.818076367347;3646.2342907989355;3648.9817550912076;3650.233450975298;3650.3976843820737;3650.4341827016856;5406.243125962368;5429.457054294618;5432.343135343718;5438.347398312228;5456.863578410532;3664.6152154023976;3761.4390028138564;3763.34141525232;3763.962360376361;3764.661180493769;3733.178700685845;3769.3403654360377;3778.414345776409;3782.432635104756;3785.716071294664;4320.935185972213;4328.718633288826;4343.196508645848;4347.413099231563;4349.565043495625;5121.769520371592;5122.129238029544;5129.487051294841;5138.460461651547;5191.598268467568;1226.582961792977;1243.3783108445778;1271.1483306184878;1297.4550688710765;1301.8502872169822;820.9204895562317;821.4988856797349;827.1728271728272;834.7770516193805;835.908050114487;4051.8987025324604;4096.877093687194;4101.539076554043;4103.589641035873;4114.465119534441;4711.6807293957745;4716.528347165325;4750.382450281441;4786.760661966888;4812.735299558488;4074.5721699221153;4081.9795901020307;4112.856050038295;4128.236276288836;4148.884069124768;2346.601077816775;2468.4322605800767;2523.2808649534795;2524.0660955446233;2534.5944648856093;4351.607485604576;4368.907773056736;4399;4426.911461770746;4441.645298184085;4778.761061946889;4837.854864354075;4851.442084160367;4869.683470574401;4871.391076115486;4493.977530112328;4497.280435130363;4590.357349971006;5087.168619296976;5089.549478398639;5327.108876348841;5366.436524164907;5378.193271009223;5389.407165211902;5409.404965453876;5231.267622532772;5274.600056973991;5277.920831187612;5303.681779093266;5312.760925758427;4916.115099282163;4974.527419895249;5023.899522009467;5032.521910418504;5032.949670503248;3682.134698345833;3688.63113688629;3722.9441558376107;3728.5339332583426;3752.5684546277525;5133.974330128325;5413.188021796762;5420.208592574748;5421.512063914109;5422.566194704335;5067.6199285053035;5139.486051394831;5152.6650767699975;5213.556847667991;5217.208793295568;5120.48795120485;5139.563137133386;5154.484551544965;5180.663256888291;5201;4920.286558449076;5080.644354895122;5105.693658380361;5131.461196574455;5145.3568303962;5183.922241166461;5199.55803756685;5203.427622961547;5214;5229.6862188267305;5110.214932861525;5130.256112863689;5142.434332223527;5142.8971420572125;5196.454372291007 10:31:11 INFO - PROCESS | 17982 | |5;yui.html;655.7016557466353;707.1825408699642;715.5885365914597;732.377479142729;742.3615690506164;12563.811542826865;13207;13666.794998075036;13671.384787684554;13676.726465470698;13901.096428732126;14732.484363047295;14734.705305893902;15427.768583471257;15428.460003899865;621.0435928669843;776.4021703288493;807.3783186946048;808.7412028150994;814.1980149552686;803.6182813163759;814.2020819596798;814.3770015937782;815.0301141641428;815.2051749544206;849.7960489482541;852.0542198160038;855.3072011670566;855.9144085591422;856.1353033436243;659.1496968910076;814.2793627639581;845.3364109174269;848.3213429256601;849.4605925237488;621.4686443091138;621.7419770795115;622.2377587455376;622.4024936061387;622.8131560531867;14039.719205615933;14071.859281407158;14087.295635218197;14111.576652700436;14112.364943577564;11943.701407464796;12241.387930603434;12294;12368.75262494745;12889.871101288962;11775;11842;11989.100817438726;12199.634010979686;12257;4126.195391898581;4158.688098392602;4164.437800896871;4206.642435392995;4262.041040765803;44039.33940990888;44288.3356749649;60917;62769.6861515694;62825.371746282864;9330.300227482965;9879.703608891745;9925.900740992498;10124.949375253076;10373.222008349254;17837.732434013502;18114.81885181158;18782.436526904214;18796.436106916815;18865.528361791065;6591.439727623206;6652.933470665328;6667.766628168088;6714.060031595581;6946.9652651736415;3636.709063274932;3655.8903232903053;3656.2321912398693;3701.481792549045;3723.5345581802276;2764.8202866813995;2858.3854471288355;2859.027930503639;2860.685324614291;2860.9427811443657;510.22445882258756;511.125974583459;512.7461906356303;512.7641285008863;532.3000254665103;488.4480536993175;498.2028753993581;500.42701107232017;503.1948881789108;528.3844321365643;7215.783526494213;7338;7359.816004599821;7423.331900129015;7743.5353878767455;489.883066608134;504.5635525270688;511.79272394680214;514.8738559052981;518.3080587415842;3414.5902491701154;3502.6847583717586;3554.2180720241504;3557.964420355815;3657.122290650225;50604;84266.5786671075;84951.57524212463;85178.14821851825;86420.56789716012;78103.31380117212;78624.60687696525;78650.49446538802;79854.600726996;80213;68795;69470.3052969474;69629;69797.30202698009;70079.64960175166;6905.689243983932;7094.6097964612445;7155.391791697764;7194.172670143001;7202.71189152449;30338.54492182575;36723.062155027;41332.79333603313;42185.36721949235;42360.364594531726;39562.2087558253;39869.60130398659;39979.60020399875;41730;60219.69890150521;9254.259659227111;9279.443233406017;9326.253899687874;9543.713688589354;9551.331406801457;9552.522373881417;9685.854712179182;9880.752981175241;9933;9978.850317245102;9292.16370526656;9294.209992150743;9442.291828113057;9683.564239609093;9770.218382529523;9332.860007099764;9493.810123797348;9587.808243834945;9620.13418792312;10008.949955250177;9357.672481463116;9411.341206115507;9463.432194068379;9792.608295668093;9846.704598862045;7935.444518883623;8087.514749115072;8181.877271841046;8265.752027439186;8328.958355208186;8019.198080191934;8323.750287491384;8344.374171937008;8420.284275836622;8432.915670843213 10:31:11 INFO - PROCESS | 17982 | __end_tp_report 10:31:11 INFO - PROCESS | 17982 | __start_cc_report 10:31:11 INFO - PROCESS | 17982 | _x_x_mozilla_cycle_collect,1077 10:31:11 INFO - PROCESS | 17982 | __end_cc_report 10:31:11 INFO - PROCESS | 17982 | __startTimestamp1466098271198__endTimestamp 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | ------- Summary: start ------- 10:31:11 INFO - PROCESS | 17982 | Number of tests: 6 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#0] dojo.html Cycles:165 Average:4772.44 Median:4906.85 stddev:514.84 (10.5%) stddev-sans-first:488.42 10:31:11 INFO - PROCESS | 17982 | Values: 2637.7 2643.3 2678.7 2688.3 2697.1 4642.3 4723.2 4752.3 4811.2 4852.2 4746.6 4790.7 4791.8 4832.4 4842.9 4334.4 4402.6 4423.2 4456.5 4573.8 4468.5 4499.7 4521.5 4532.5 4551.8 4283.5 4325.3 4333.0 4391.3 4436.7 4386.4 4399.5 4411.6 4451.9 4472.5 4407.5 4430.3 4436.0 4467.5 4469.4 4682.2 4723.4 4736.3 4797.0 4806.9 5181.9 5182.4 5210.9 5226.4 5227.3 5176.0 5249.8 5264.3 5266.8 5270.1 4696.8 4802.1 4835.3 4857.1 4921.1 5356.4 5356.6 5381.2 5401.4 5416.2 5121.9 5170.8 5176.4 5178.8 5181.5 5062.8 5081.3 5103.5 5106.0 5261.1 5066.9 5069.4 5074.5 5075.2 5155.7 5097.4 5105.9 5106.7 5107.1 5108.7 4269.4 4312.4 4313.8 4360.6 4368.0 3814.3 3848.1 3858.9 3865.9 3873.4 4423.5 4443.5 4456.6 4466.2 4467.0 5242.1 5243.1 5247.9 5266.2 5283.2 4451.4 4463.5 4463.8 4468.2 4509.5 4466.5 4529.6 4532.5 4586.3 4621.4 4820.4 4851.2 4852.5 4862.5 4911.4 5137.0 5196.1 5201.5 5202.9 5251.7 4639.9 4793.9 4826.6 4855.1 4912.7 5105.4 5119.1 5119.2 5124.1 5166.3 5204.9 5207.7 5218.8 5224.1 5270.8 4906.9 4963.8 5003.0 5028.8 5047.0 5046.8 5048.0 5066.7 5067.5 5117.7 4936.7 4963.1 5004.0 5006.8 5007.1 4941.1 5008.8 5052.9 5069.1 5086.6 4966.7 4997.1 5002.3 5019.5 5066.6 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#1] ext.html Cycles:180 Average:46175.42 Median:3336.37 stddev:82910.67 (2485.1%) stddev-sans-first:83072.48 10:31:11 INFO - PROCESS | 17982 | Values: 549.3 570.7 590.2 595.3 601.1 26786.5 38691.0 39573.0 39795.0 39835.6 39964.0 40340.2 40493.8 40504.6 40626.8 7516.6 7849.5 8008.6 8011.8 10100.9 9868.3 10261.9 10272.7 10278.1 10285.3 10246.2 10294.1 10299.4 10307.0 10307.1 7529.8 7722.2 7722.4 10016.2 10242.2 10127.2 10229.9 10245.4 10260.8 10277.4 38079.8 38519.6 38544.2 38554.2 38557.6 3008.5 3213.6 3332.8 3339.9 3431.0 29237.3 29382.4 29660.9 29761.3 30211.0 3321.6 3491.4 3622.9 3647.6 3695.7 254892.0 258792.0 258819.0 259084.0 259343.0 52534.0 52636.0 53215.2 53237.7 53280.0 31821.5 32766.2 32767.3 34934.5 55984.2 13746.8 13963.4 14048.9 14049.9 14057.4 8978.6 10215.8 10457.5 10463.2 10712.3 17935.3 17998.6 18009.2 18009.2 18019.8 6846.3 6886.1 6988.1 7111.4 7190.9 774.3 883.0 955.2 960.4 970.6 27929.6 28060.4 28277.3 28809.3 28943.4 950.8 955.6 965.9 1061.2 1074.7 14834.9 14916.2 14935.0 15255.0 15257.5 379934.0 380753.0 381039.0 382940.0 385127.0 48767.8 49261.0 49285.3 49350.3 49391.5 1055.3 1123.1 1167.5 1171.2 1187.2 27171.2 28832.6 28870.3 28973.6 29112.3 35586.5 35746.6 35829.0 35875.3 35936.0 292461.0 292966.0 293656.0 294373.0 294787.0 21725.1 23796.4 24869.9 24875.0 26365.3 40194.8 40350.8 40406.4 40703.8 41532.2 34850.3 35074.3 35285.5 35374.6 35908.0 35858.3 35891.3 35901.5 35982.8 36147.8 34712.8 35054.8 35696.6 35707.6 36161.1 30942.8 31726.0 31728.7 31986.5 32120.2 24460.3 24610.3 24797.0 24990.8 25079.2 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#2] jquery.html Cycles:180 Average:23643.09 Median:4490.42 stddev:61746.68 (1375.1%) stddev-sans-first:61895.18 10:31:11 INFO - PROCESS | 17982 | Values: 375.7 378.2 378.6 389.7 390.6 16889.7 17039.0 17354.8 17855.0 17881.0 16725.4 16785.2 17057.7 17372.8 17396.7 5097.6 5258.2 5262.3 5304.4 5308.3 3693.4 3918.0 3933.5 6126.2 6149.3 5985.5 6091.2 6144.7 6165.6 6166.5 5913.2 5942.3 6097.7 6105.7 6106.2 3357.6 4900.6 5206.1 5207.1 5429.8 20992.6 21023.2 21178.8 21272.0 21340.0 1739.2 1858.2 1961.3 2022.4 2069.2 5135.9 9382.5 9396.5 9430.5 9483.0 1740.7 1816.0 1849.5 1857.3 1876.5 62660.4 64668.0 65186.4 66810.7 68175.7 9252.5 9324.0 10137.9 10241.2 10366.2 14180.4 14227.1 14259.2 14265.2 14271.4 7219.4 7231.7 7237.8 7280.1 7356.9 6749.9 6749.9 6751.6 6799.2 6890.2 4489.4 4491.4 4512.5 4537.8 4590.6 1823.7 1836.6 1857.3 1859.4 1925.8 800.3 819.3 848.8 894.4 962.5 16611.6 16744.2 17090.9 17175.4 17260.5 827.6 842.4 844.4 894.1 922.6 9416.0 9528.6 9841.1 9863.9 10032.7 370375.0 371939.0 373941.0 375791.0 380784.0 53710.7 72914.3 73026.3 73313.3 76004.0 885.1 896.3 903.8 929.1 932.1 15607.8 15704.8 15855.1 16044.9 16227.9 36045.8 36846.4 37446.3 37733.2 38121.4 49966.3 51659.0 51896.7 52383.5 52943.7 7713.5 7739.9 7747.4 7804.9 7806.1 5230.6 5288.7 11804.7 12402.6 12404.9 10540.3 10556.4 10575.8 10634.4 10895.9 10572.5 10591.2 10713.7 10896.3 11097.0 10819.5 10967.5 11085.1 11160.7 11237.2 7542.2 7542.4 7652.0 7745.6 8136.2 8039.0 10086.7 10256.4 10287.3 10349.3 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#3] mootools.html Cycles:180 Average:5238.88 Median:5153.28 stddev:2975.74 (57.7%) stddev-sans-first:2968.78 10:31:11 INFO - PROCESS | 17982 | Values: 1223.8 1393.5 1400.9 1507.5 1719.1 6827.4 7605.4 7879.7 7918.4 8137.8 7856.6 7997.7 8002.7 8004.9 8017.2 1901.5 2103.5 2182.3 2203.7 2211.1 2280.8 2297.9 2302.3 2302.7 2304.5 2219.3 2234.2 2234.4 2239.6 2240.8 1821.9 2059.4 2130.4 2154.3 2162.5 2208.6 2216.3 2220.4 2227.1 2231.1 8007.2 8059.0 8067.9 8073.9 8077.3 4607.7 4709.1 4709.9 4750.1 4755.6 2849.2 2935.7 3030.7 3042.5 3056.3 951.0 958.8 962.3 974.5 983.3 10931.6 10943.6 10951.8 10962.4 10991.2 4305.1 4371.7 4406.3 4423.9 4426.0 9291.2 9366.9 9373.4 9380.1 9388.2 4779.5 4782.1 4787.7 4788.3 4791.3 3701.5 4117.7 4296.6 4299.5 4364.2 3676.8 3732.4 3793.4 3827.3 3875.8 1073.9 1226.7 1241.1 1243.1 1265.3 729.9 766.3 840.0 841.3 849.9 4895.8 4997.7 5013.5 5079.9 5324.8 820.7 823.2 835.4 852.2 865.3 3526.5 3579.4 3608.4 3617.7 3641.9 9737.0 9817.5 9873.2 9968.3 9981.4 9924.4 9934.2 9934.6 9944.2 9948.0 7460.7 7465.3 7538.8 7618.4 7631.5 5125.8 5151.0 5155.6 5182.6 5208.5 8879.5 9168.3 9242.0 9330.4 9355.3 9331.9 9442.4 9459.6 9460.8 9578.2 5963.6 6349.7 6561.8 6595.0 6717.4 7716.4 7724.5 7787.6 7796.3 7804.7 6923.5 7108.8 7161.5 7224.1 7302.9 6921.2 6928.7 6949.5 7049.2 7068.2 6078.8 6171.0 6310.6 6322.3 6324.2 4549.9 4569.4 4577.9 4580.8 4626.7 4544.3 4564.0 4593.5 4602.8 4645.8 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#4] prototype.html Cycles:180 Average:4195.67 Median:4718.26 stddev:1237.59 (26.2%) stddev-sans-first:1205.91 10:31:11 INFO - PROCESS | 17982 | Values: 294.1 296.7 304.7 304.9 307.0 4720.1 4827.3 4903.1 4952.9 4969.9 4720.0 4808.8 4862.8 4870.0 4870.6 3843.7 3846.7 3853.4 3861.8 3863.5 3636.5 3743.8 3860.7 3868.6 3898.8 3833.9 3846.8 3870.5 3877.2 3882.2 3805.8 3836.9 3846.0 3849.0 3866.5 3414.6 3417.0 3424.9 3432.2 3433.2 4560.7 4740.1 4746.2 4746.9 4751.2 4373.1 4373.2 4374.8 4382.8 4383.6 4953.4 5062.4 5120.8 5171.0 5197.8 3646.2 3649.0 3650.2 3650.4 3650.4 5406.2 5429.5 5432.3 5438.3 5456.9 3664.6 3761.4 3763.3 3764.0 3764.7 3733.2 3769.3 3778.4 3782.4 3785.7 4320.9 4328.7 4343.2 4347.4 4349.6 5121.8 5122.1 5129.5 5138.5 5191.6 1226.6 1243.4 1271.1 1297.5 1301.9 820.9 821.5 827.2 834.8 835.9 4051.9 4096.9 4101.5 4103.6 4114.5 4711.7 4716.5 4750.4 4786.8 4812.7 4074.6 4082.0 4112.9 4128.2 4148.9 2346.6 2468.4 2523.3 2524.1 2534.6 4351.6 4368.9 4399.0 4426.9 4441.6 4778.8 4837.9 4851.4 4869.7 4871.4 4494.0 4497.3 4590.4 5087.2 5089.5 5327.1 5366.4 5378.2 5389.4 5409.4 5231.3 5274.6 5277.9 5303.7 5312.8 4916.1 4974.5 5023.9 5032.5 5032.9 3682.1 3688.6 3722.9 3728.5 3752.6 5134.0 5413.2 5420.2 5421.5 5422.6 5067.6 5139.5 5152.7 5213.6 5217.2 5120.5 5139.6 5154.5 5180.7 5201.0 4920.3 5080.6 5105.7 5131.5 5145.4 5183.9 5199.6 5203.4 5214.0 5229.7 5110.2 5130.3 5142.4 5142.9 5196.5 10:31:11 INFO - PROCESS | 17982 | 10:31:11 INFO - PROCESS | 17982 | [#5] yui.html Cycles:180 Average:15714.63 Median:657.43 stddev:21978.96 (3343.2%) stddev-sans-first:22011.53 10:31:11 INFO - PROCESS | 17982 | Values: 655.7 707.2 715.6 732.4 742.4 12563.8 13207.0 13666.8 13671.4 13676.7 13901.1 14732.5 14734.7 15427.8 15428.5 621.0 776.4 807.4 808.7 814.2 803.6 814.2 814.4 815.0 815.2 849.8 852.1 855.3 855.9 856.1 659.1 814.3 845.3 848.3 849.5 621.5 621.7 622.2 622.4 622.8 14039.7 14071.9 14087.3 14111.6 14112.4 11943.7 12241.4 12294.0 12368.8 12889.9 11775.0 11842.0 11989.1 12199.6 12257.0 4126.2 4158.7 4164.4 4206.6 4262.0 44039.3 44288.3 60917.0 62769.7 62825.4 9330.3 9879.7 9925.9 10124.9 10373.2 17837.7 18114.8 18782.4 18796.4 18865.5 6591.4 6652.9 6667.8 6714.1 6947.0 3636.7 3655.9 3656.2 3701.5 3723.5 2764.8 2858.4 2859.0 2860.7 2860.9 510.2 511.1 512.7 512.8 532.3 488.4 498.2 500.4 503.2 528.4 7215.8 7338.0 7359.8 7423.3 7743.5 489.9 504.6 511.8 514.9 518.3 3414.6 3502.7 3554.2 3558.0 3657.1 50604.0 84266.6 84951.6 85178.1 86420.6 78103.3 78624.6 78650.5 79854.6 80213.0 68795.0 69470.3 69629.0 69797.3 70079.6 6905.7 7094.6 7155.4 7194.2 7202.7 30338.5 36723.1 41332.8 42185.4 42360.4 39562.2 39869.6 39979.6 41730.0 60219.7 9254.3 9279.4 9326.3 9543.7 9551.3 9552.5 9685.9 9880.8 9933.0 9978.9 9292.2 9294.2 9442.3 9683.6 9770.2 9332.9 9493.8 9587.8 9620.1 10008.9 9357.7 9411.3 9463.4 9792.6 9846.7 7935.4 8087.5 8181.9 8265.8 8329.0 8019.2 8323.8 8344.4 8420.3 8432.9 10:31:11 INFO - PROCESS | 17982 | -------- Summary: end -------- 10:31:11 INFO - PROCESS | 17982 | 10:31:12 INFO - TEST-INFO | 17982: exit 0 10:31:12 INFO - TEST-OK | dromaeo_css | took 1121293ms 10:31:12 INFO - TEST-START | kraken 10:31:12 INFO - operating with platform_type : linux_ 10:31:12 INFO - Initialising browser for kraken test... 10:31:12 INFO - TEST-INFO | started process 18162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFoYDr/profile http://localhost:58681/getInfo.html) 10:31:16 INFO - PROCESS | 18162 | __metrics Screen width/height:1600/1200 10:31:16 INFO - PROCESS | 18162 | colorDepth:24 10:31:16 INFO - PROCESS | 18162 | Browser inner width/height: 1024/697 10:31:16 INFO - PROCESS | 18162 | __metrics 10:31:17 INFO - PROCESS | 18162 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:31:18 INFO - TEST-INFO | 18162: exit 0 10:31:18 INFO - Browser initialized. 10:31:18 INFO - Running cycle 1/1 for kraken test... 10:31:18 INFO - TEST-INFO | started process 18242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFoYDr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:30 INFO - PROCESS | 18242 | RSS: Main: 175583232 10:31:30 INFO - PROCESS | 18242 | 10:31:33 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58681/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:34 INFO - PROCESS | 18242 | RSS: Main: 234434560 10:31:34 INFO - PROCESS | 18242 | 10:31:36 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58681/tests/kraken/driver.html?testName=audio-dft) 10:31:37 INFO - PROCESS | 18242 | RSS: Main: 222056448 10:31:37 INFO - PROCESS | 18242 | 10:31:40 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58681/tests/kraken/driver.html?testName=audio-fft) 10:31:41 INFO - PROCESS | 18242 | RSS: Main: 289222656 10:31:41 INFO - PROCESS | 18242 | 10:31:43 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58681/tests/kraken/driver.html?testName=audio-oscillator) 10:31:44 INFO - PROCESS | 18242 | RSS: Main: 198864896 10:31:44 INFO - PROCESS | 18242 | 10:31:46 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:47 INFO - PROCESS | 18242 | RSS: Main: 202833920 10:31:47 INFO - PROCESS | 18242 | 10:31:50 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58681/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:50 INFO - PROCESS | 18242 | RSS: Main: 239181824 10:31:50 INFO - PROCESS | 18242 | 10:31:54 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58681/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:54 INFO - PROCESS | 18242 | RSS: Main: 234852352 10:31:54 INFO - PROCESS | 18242 | 10:31:57 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58681/tests/kraken/driver.html?testName=json-parse-financial) 10:31:58 INFO - PROCESS | 18242 | RSS: Main: 238067712 10:31:58 INFO - PROCESS | 18242 | 10:32:00 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:00 INFO - PROCESS | 18242 | RSS: Main: 227446784 10:32:00 INFO - PROCESS | 18242 | 10:32:02 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:03 INFO - PROCESS | 18242 | RSS: Main: 232185856 10:32:03 INFO - PROCESS | 18242 | 10:32:05 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:06 INFO - PROCESS | 18242 | RSS: Main: 238620672 10:32:06 INFO - PROCESS | 18242 | 10:32:08 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:09 INFO - PROCESS | 18242 | RSS: Main: 239583232 10:32:09 INFO - PROCESS | 18242 | 10:32:12 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:12 INFO - PROCESS | 18242 | RSS: Main: 240435200 10:32:12 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:58681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58681/tests/kraken/driver.html?testName=ai-astar) 10:32:14 INFO - PROCESS | 18242 | RSS: Main: 283402240 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | __start_tp_report 10:32:14 INFO - PROCESS | 18242 | _x_x_mozilla_page_load 10:32:14 INFO - PROCESS | 18242 | _x_x_mozilla_page_load_details 10:32:14 INFO - PROCESS | 18242 | |i|pagename|runs| 10:32:14 INFO - PROCESS | 18242 | |0;ai-astar;112;108;112;112;112;112;111;113;112;112 10:32:14 INFO - PROCESS | 18242 | |1;audio-beat-detection;161;132;133;182;138;133;159;138;194;131 10:32:14 INFO - PROCESS | 18242 | |2;audio-dft;161;163;162;162;162;161;161;163;162;162 10:32:14 INFO - PROCESS | 18242 | |3;audio-fft;76;75;78;127;76;77;75;75;98;76 10:32:14 INFO - PROCESS | 18242 | |4;audio-oscillator;86;87;113;86;86;86;116;86;86;123 10:32:14 INFO - PROCESS | 18242 | |5;imaging-gaussian-blur;117;118;117;116;117;117;117;118;117;117 10:32:14 INFO - PROCESS | 18242 | |6;imaging-darkroom;146;146;146;147;147;146;146;148;147;146 10:32:14 INFO - PROCESS | 18242 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 10:32:14 INFO - PROCESS | 18242 | |8;json-parse-financial;64;62;62;63;62;63;63;62;63;63 10:32:14 INFO - PROCESS | 18242 | |9;json-stringify-tinderbox;66;64;65;65;65;65;65;66;66;64 10:32:14 INFO - PROCESS | 18242 | |10;stanford-crypto-aes;83;83;83;82;83;85;84;86;117;84 10:32:14 INFO - PROCESS | 18242 | |11;stanford-crypto-ccm;132;130;131;135;132;129;130;143;130;136 10:32:14 INFO - PROCESS | 18242 | |12;stanford-crypto-pbkdf2;167;168;167;170;168;170;173;172;169;171 10:32:14 INFO - PROCESS | 18242 | |13;stanford-crypto-sha256-iterative;67;67;68;66;69;66;73;66;64;65 10:32:14 INFO - PROCESS | 18242 | __end_tp_report 10:32:14 INFO - PROCESS | 18242 | __start_cc_report 10:32:14 INFO - PROCESS | 18242 | _x_x_mozilla_cycle_collect,1892 10:32:14 INFO - PROCESS | 18242 | __end_cc_report 10:32:14 INFO - PROCESS | 18242 | __startTimestamp1466098334929__endTimestamp 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | ------- Summary: start ------- 10:32:14 INFO - PROCESS | 18242 | Number of tests: 14 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 10:32:14 INFO - PROCESS | 18242 | Values: 112.0 108.0 112.0 112.0 112.0 112.0 111.0 113.0 112.0 112.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:148.50 stddev:22.88 (15.4%) stddev-sans-first:23.93 10:32:14 INFO - PROCESS | 18242 | Values: 161.0 132.0 133.0 182.0 138.0 133.0 159.0 138.0 194.0 131.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:32:14 INFO - PROCESS | 18242 | Values: 161.0 163.0 162.0 162.0 162.0 161.0 161.0 163.0 162.0 162.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.87 (22.2%) stddev-sans-first:17.68 10:32:14 INFO - PROCESS | 18242 | Values: 76.0 75.0 78.0 127.0 76.0 77.0 75.0 75.0 98.0 76.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:86.00 stddev:15.26 (17.7%) stddev-sans-first:15.80 10:32:14 INFO - PROCESS | 18242 | Values: 86.0 87.0 113.0 86.0 86.0 86.0 116.0 86.0 86.0 123.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:32:14 INFO - PROCESS | 18242 | Values: 117.0 118.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:32:14 INFO - PROCESS | 18242 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 146.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:32:14 INFO - PROCESS | 18242 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 10:32:14 INFO - PROCESS | 18242 | Values: 64.0 62.0 62.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 10:32:14 INFO - PROCESS | 18242 | Values: 66.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 64.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:83.50 stddev:10.60 (12.7%) stddev-sans-first:11.15 10:32:14 INFO - PROCESS | 18242 | Values: 83.0 83.0 83.0 82.0 83.0 85.0 84.0 86.0 117.0 84.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:4.24 (3.2%) stddev-sans-first:4.48 10:32:14 INFO - PROCESS | 18242 | Values: 132.0 130.0 131.0 135.0 132.0 129.0 130.0 143.0 130.0 136.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:2.07 (1.2%) stddev-sans-first:1.99 10:32:14 INFO - PROCESS | 18242 | Values: 167.0 168.0 167.0 170.0 168.0 170.0 173.0 172.0 169.0 171.0 10:32:14 INFO - PROCESS | 18242 | 10:32:14 INFO - PROCESS | 18242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.51 (3.8%) stddev-sans-first:2.67 10:32:14 INFO - PROCESS | 18242 | Values: 67.0 67.0 68.0 66.0 69.0 66.0 73.0 66.0 64.0 65.0 10:32:14 INFO - PROCESS | 18242 | -------- Summary: end -------- 10:32:14 INFO - PROCESS | 18242 | 10:32:15 INFO - TEST-INFO | 18242: exit 0 10:32:16 INFO - TEST-OK | kraken | took 64055ms 10:32:16 INFO - SUITE-END | took 1185s 10:32:16 INFO - Completed test suite (00:19:45) 10:32:16 INFO - javascript benchmark 10:32:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.6834779826418, 2643.2863126955713, 2678.678558572971, 2688.2607282997174, 2697.0829917827937, 4642.303654451834, 4723.197056500395, 4752.287156926463, 4811.182099043162, 4852.150873597119, 4746.62027037837, 4790.736509491977, 4791.808327666889, 4832.420109586855, 4842.9031419371595, 4334.43652325198, 4402.647788176938, 4423.181711383389, 4456.465224173104, 4573.839915602938, 4468.463784345883, 4499.730016199022, 4521.502634710179, 4532.501424843281, 4551.840685576006, 4283.464566929134, 4325.329573916048, 4333.046729719456, 4391.297392417198, 4436.7116137451285, 4386.385905973167, 4399.494058183318, 4411.580899814512, 4451.9332210016555, 4472.508024117345, 4407.537208593084, 4430.313301438282, 4436.0240747035605, 4467.463904331501, 4469.396631454744, 4682.180618391768, 4723.4331880174595, 4736.313234580966, 4797.0, 4806.927896081562, 5181.870453238662, 5182.404023537304, 5210.869728256786, 5226.425093239741, 5227.294315267466, 5176.0, 5249.790008399659, 5264.2893209416625, 5266.789328426858, 5270.1040823060175, 4696.812127514895, 4802.135615589157, 4835.323054772335, 4857.077155340474, 4921.138800709933, 5356.4107948125675, 5356.598255130881, 5381.246625472437, 5401.432849550819, 5416.187571864252, 5121.923171152435, 5170.819021334235, 5176.404713457925, 5178.818741344035, 5181.481851814864, 5062.82280120194, 5081.2632168335385, 5103.489651034867, 5106.0, 5261.131913234273, 5066.923996140061, 5069.391672999263, 5074.492550744896, 5075.213341932006, 5155.716435596079, 5097.388313402415, 5105.923411148836, 5106.744662766847, 5107.080725469377, 5108.744562771846, 4269.359596060615, 4312.439382880206, 4313.84901528445, 4360.585744354281, 4368.017196130909, 3814.275287695329, 3848.0572259796527, 3858.9035274118373, 3865.942010869839, 3873.3802591585213, 4423.535528769433, 4443.488998765119, 4456.554344565582, 4466.173757854807, 4467.0, 5242.135047717084, 5243.056249874983, 5247.947520524746, 5266.210068489757, 5283.1546952487415, 4451.399061126706, 4463.5313292103865, 4463.799129039201, 4468.173387923244, 4509.549045095529, 4466.508684044752, 4529.6376289896725, 4532.546745325441, 4586.266197408466, 4621.399218101626, 4820.4456487504385, 4851.175300198904, 4852.539008794159, 4862.4651288357545, 4911.386076740408, 5137.049645815536, 5196.142636464941, 5201.47985201492, 5202.921956170736, 5251.684898906078, 4639.86080417588, 4793.9280910785665, 4826.565609095198, 4855.053264613508, 4912.6561140719805, 5105.412877518985, 5119.078565858182, 5119.180931051014, 5124.103281925573, 5166.276721259102, 5204.869878253074, 5207.71357575337, 5218.791248350023, 5224.111900976767, 5270.841874743764, 4906.852794416173, 4963.801447942186, 5002.999400120063, 5028.823991160292, 5047.041062198317, 5046.823361182341, 5047.974760126176, 5066.746662666926, 5067.5185857343495, 5117.667351622282, 4936.654434189572, 4963.057019166346, 5004.024215277986, 5006.824761133343, 5007.098722230034, 4941.110600092018, 5008.77460514285, 5052.924206136984, 5069.138246498031, 5086.593072554261, 4966.6771659842, 4997.075541024922, 5002.299678045004, 5019.52314530119, 5066.645334826674], "value": 4738.732656828266, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3374932409477, 570.6747154122149, 590.1767034986194, 595.2737660054731, 601.0713447723268, 26786.464270714576, 38691.0, 39572.99999999996, 39795.0, 39835.60164398355, 39964.0, 40340.19319613606, 40493.7975310123, 40504.59495405045, 40626.796866015706, 7516.586587737672, 7849.529028258323, 8008.5595292259195, 8011.759647210564, 10100.89899101007, 9868.309218354718, 10261.897381026207, 10272.691819245434, 10278.074973252405, 10285.33145345554, 10246.231532635045, 10294.073533381994, 10299.382037077761, 10307.0, 10307.072363487285, 7529.774106776833, 7722.150563438017, 7722.420818438583, 10016.198704103654, 10242.231832612584, 10127.189824813997, 10229.897701023043, 10245.436500992442, 10260.794784104351, 10277.434741089237, 38079.809600952096, 38519.61480385188, 38544.22911541782, 38554.22891542153, 38557.614423855965, 3008.503596906508, 3213.614366276062, 3332.800031998088, 3339.9499007514905, 3430.9656903430896, 29237.26906827325, 29382.41235175306, 29660.8516957416, 29761.25596860074, 30211.0, 3321.568196134487, 3491.441369380887, 3622.873199438033, 3647.5805282392334, 3695.6858667013335, 254892.0, 258792.0, 258819.0, 259084.0, 259343.0, 52534.0, 52636.0, 53215.20177197345, 53237.7338113307, 53280.0, 31821.52267715986, 32766.180845479055, 32767.344653106804, 34934.47598286028, 55984.16023759647, 13746.793798093036, 13963.371648275648, 14048.929755351157, 14049.859501405059, 14057.367418466194, 8978.551072446351, 10215.795684086277, 10457.477126143662, 10463.215258855616, 10712.303700259457, 17935.282588696307, 17998.640027199384, 18009.18958646838, 18009.18958646864, 18019.819801801816, 6846.349596788297, 6886.067873821893, 6988.126484189476, 7111.395531379787, 7190.9280907191305, 774.2644487736673, 882.9779255518663, 955.2071780422233, 960.4045491795132, 970.6166064404521, 27929.62598179137, 28060.43879122447, 28277.29306767306, 28809.279768005967, 28943.42113157725, 950.8003319302885, 955.5938726041404, 965.9042767928771, 1061.193492945367, 1074.7474343529263, 14834.851651483563, 14916.179610121331, 14934.954553181173, 15255.0, 15257.542273731806, 379934.0, 380753.0, 381039.0, 382940.0, 385127.0, 48767.75616121897, 49261.0, 49285.26072108921, 49350.25974610384, 49391.50608493941, 1055.2771351624008, 1123.0790751583622, 1167.5271515036425, 1171.1801738782885, 1187.1986409173774, 27171.1848644541, 28832.567511487763, 28870.278243044093, 28973.565396518647, 29112.27219319534, 35586.46620300749, 35746.64253357433, 35829.0, 35875.28249435049, 35936.0, 292461.0, 292966.0, 293656.0, 294373.0, 294787.0, 21725.13099476003, 23796.405089872893, 24869.87565062163, 24875.01499820033, 26365.34086647849, 40194.799026004686, 40350.798246009756, 40406.39390409087, 40703.79648101741, 41532.1693566133, 34850.30299394049, 35074.29851403009, 35285.47071793977, 35374.64625353713, 35908.0, 35858.28283434369, 35891.282174356886, 35901.461478078374, 35982.8200858994, 36147.819260903525, 34712.82643586766, 35054.824725876206, 35696.64303356933, 35707.642923570435, 36161.09597259984, 30942.845285773426, 31726.0, 31728.682713172573, 31986.52020219652, 32120.196995075312, 24460.266192014267, 24610.261692149263, 24797.0, 24990.75009249957, 25079.24762257135], "value": 17619.413565509014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.65064490024275, 378.203880830851, 378.57032268375406, 389.70382509292926, 390.61719514875404, 16889.662206755856, 17039.0, 17354.82645173548, 17854.999999999967, 17881.04962681158, 16725.414610488635, 16785.16074196288, 17057.744133837972, 17372.826271737278, 17396.652066958686, 5097.592192624581, 5258.1849813279005, 5262.289590905236, 5304.389995150568, 5308.283381743473, 3693.409054551259, 3918.0, 3933.5279766427925, 6126.203593532835, 6149.29283132441, 5985.461308482236, 6091.177691011723, 6144.662043587601, 6165.599236049665, 6166.506679465654, 5913.224471591054, 5942.257217847769, 6097.725602347905, 6105.664188469633, 6106.236720409926, 3357.647447018077, 4900.558949694545, 5206.114960456732, 5207.140821764404, 5429.837104886859, 20992.580148396948, 21023.159073637034, 21178.78821211799, 21272.0, 21340.0, 1739.1565090930887, 1858.2102606392364, 1961.3135402608973, 2022.4337185588058, 2069.2033567076633, 5135.897282054375, 9382.483963382012, 9396.50108034374, 9430.528473576362, 9482.95258523703, 1740.6779745747078, 1815.963680726378, 1849.5098798818324, 1857.3313607101434, 1876.4558278099335, 62660.37339626637, 64668.0, 65186.41474718889, 66810.66594667044, 68175.65912170407, 9252.537373131316, 9323.953380233055, 10137.949310253402, 10241.23190760696, 10366.222533310032, 14180.432782688576, 14227.14637121776, 14259.21574313402, 14265.215413152377, 14271.429142834171, 7219.422446204291, 7231.674574644154, 7237.819054523679, 7280.089988751406, 7356.852862942818, 6749.865002700017, 6749.932500675029, 6751.594904305757, 6799.150106236721, 6890.1731792184255, 4489.438820147481, 4491.393661855608, 4512.458504979423, 4537.750423726727, 4590.563896429834, 1823.680855850221, 1836.6418548382937, 1857.3220774417512, 1859.414284500405, 1925.7977912319284, 800.319728230999, 819.3240576524391, 848.7793173774863, 894.4052205283543, 962.4898803634085, 16611.584710382336, 16744.162791860603, 17090.914545427193, 17175.398861039805, 17260.482185534453, 827.5862068965517, 842.4313588327976, 844.3709436469869, 894.1460904835997, 922.6263363337858, 9415.952920235492, 9528.618855245852, 9841.114299713061, 9863.901360986441, 10032.749181270527, 370375.0, 371939.0, 373941.0, 375791.0, 380784.0, 53710.7314463433, 72914.27085729074, 73026.26973730301, 73313.26686733065, 76004.0, 885.0795173019987, 896.3143195455482, 903.846346121161, 929.110466449342, 932.0539652252833, 15607.84392156064, 15704.842951570337, 15855.127967961873, 16044.919775401047, 16227.918860405622, 36045.81977090098, 36846.44730329101, 37446.25107497889, 37733.24533509369, 38121.42817857679, 49966.25050624316, 51659.0, 51896.74051629718, 52383.476165239386, 52943.73528132489, 7713.537187768752, 7739.883901741366, 7747.418943579141, 7804.921950780419, 7806.102298235775, 5230.555402790806, 5288.65623734456, 11804.70488237801, 12402.5659101931, 12404.875951240372, 10540.262181647211, 10556.419396932935, 10575.841362379724, 10634.361938283728, 10895.945520272347, 10572.471376431302, 10591.205659575717, 10713.678589642323, 10896.291741037125, 11097.0, 10819.459027048459, 10967.451627418757, 11085.113190944543, 11160.665180044612, 11237.157213208879, 7542.170361260147, 7542.434317426105, 7652.04349456318, 7745.608263045683, 8136.22705842944, 8038.959805200937, 10086.697399078039, 10256.38461692301, 10287.331323463952, 10349.327293725884], "value": 8198.859986759822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.7736018836522, 1393.4913756478882, 1400.8529104444033, 1507.5175943698014, 1719.123247143957, 6827.351401616845, 7605.391568674507, 7879.684812607496, 7918.406119541029, 8137.796555086125, 7856.567888766115, 7997.720079797208, 8002.719904803318, 8004.919950800505, 8017.158198389173, 1901.5246188452886, 2103.4951611613255, 2182.2907555044594, 2203.6804663323887, 2211.071350032982, 2280.783325584075, 2297.908083676651, 2302.2862912497094, 2302.7121609798774, 2304.493011537459, 2219.2676416782506, 2234.1510226114056, 2234.4078819112947, 2239.585676649825, 2240.820734341257, 1821.9089045547669, 2059.4439501334705, 2130.3715403955794, 2154.2998525479284, 2162.4810045588947, 2208.5582883423217, 2216.34617787753, 2220.3560967319618, 2227.086894373299, 2231.141010710872, 8007.159248278964, 8059.032916050111, 8067.919320806835, 8073.919260807375, 8077.273045425881, 4607.654425918069, 4709.058188362307, 4709.882252943669, 4750.097481478542, 4755.643326750507, 2849.216465471991, 2935.66239882412, 3030.7423868971164, 3042.4675681755825, 3056.312329725816, 950.9857352139724, 958.8274110660078, 962.2927148545813, 974.4591751577872, 983.2576404814391, 10931.617393391192, 10943.616973405971, 10951.83572246417, 10962.397068161248, 10991.230613857033, 4305.052888364555, 4371.650267978554, 4406.317020861771, 4423.911521769611, 4426.0, 9291.163795258459, 9366.859497107549, 9373.390729602554, 9380.061993800566, 9388.2020028297, 4779.498152693986, 4782.0914026334885, 4787.664863459594, 4788.281757736298, 4791.329213910055, 3701.5002974598083, 4117.711760176819, 4296.61330480252, 4299.527052024275, 4364.192624364439, 3676.7793932364143, 3732.4401339798706, 3793.4499497572697, 3827.27281816454, 3875.806209689504, 1073.9140868730483, 1226.7117227451542, 1241.1126044877956, 1243.0801207106676, 1265.342022148496, 729.8759210934154, 766.3332900376708, 840.0, 841.3017195727532, 849.9277561407226, 4895.828645997444, 4997.650164488524, 5013.498650134958, 5079.87300317495, 5324.760385782649, 820.6881385073754, 823.2302796884932, 835.4026870787416, 852.1648784191403, 865.2861389353683, 3526.4886591444097, 3579.391503444421, 3608.3685355062757, 3617.692496137805, 3641.890743277706, 9737.0, 9817.460039697886, 9873.210143188528, 9968.302218844756, 9981.401115933068, 9924.40453572788, 9934.15559677421, 9934.602615895428, 9944.204463642891, 9948.0, 7460.664270107858, 7465.29079737424, 7538.849223015619, 7618.390528757686, 7631.503952243086, 5125.769340379767, 5151.0, 5155.561777248976, 5182.6113041521285, 5208.5051920067535, 8879.511626860585, 9168.266538676757, 9241.953790231006, 9330.393524420891, 9355.251579873458, 9331.860022099538, 9442.38624489406, 9459.621615135318, 9460.763480913032, 9578.233741300819, 5963.642181468952, 6349.68251587428, 6561.835954101186, 6595.043718660863, 6717.395434410926, 7716.421268405004, 7724.497907636211, 7787.610619469117, 7796.259355361231, 7804.6878124874365, 6923.480738944499, 7108.822279443055, 7161.534500257467, 7224.13310402734, 7302.890456643048, 6921.2386637470845, 6928.688209030706, 6949.513534052568, 7049.224585295716, 7068.151821781419, 6078.787242446493, 6170.969145154425, 6310.5898116622275, 6322.2729386119345, 6324.209473815773, 4549.931751023803, 4569.36028955953, 4577.862664120082, 4580.816767329269, 4626.676132670681, 4544.272916333503, 4564.041551274269, 4593.540645935514, 4602.815887364468, 4645.790939407802], "value": 4196.688538070323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.1337760295929, 296.73886979458075, 304.7455374762073, 304.94206100840836, 307.03743763302043, 4720.103180395722, 4827.275908613709, 4903.136808012954, 4952.900941981163, 4969.900601987958, 4720.0, 4808.783604737787, 4862.829800956967, 4869.951300486994, 4870.634702397326, 3843.730938834283, 3846.6922646188236, 3853.3834586466173, 3861.7876016819064, 3863.497745293108, 3636.4727114568373, 3743.794091324976, 3860.7104467164936, 3868.6324799144177, 3898.7660740355527, 3833.8658146964863, 3846.8461261549646, 3870.4774855394585, 3877.1664092220167, 3882.223555288939, 3805.7906815125157, 3836.884893453187, 3845.9615403845883, 3849.0, 3866.516685414323, 3414.607320158189, 3417.0, 3424.9315013699834, 3432.1934345428804, 3433.1588760753775, 4560.7035542689955, 4740.1230772307235, 4746.240601503778, 4746.928796068062, 4751.192297309466, 4373.103513779667, 4373.212821692094, 4374.803133858953, 4382.802773875183, 4383.583559561868, 4953.405591329028, 5062.367204099488, 5120.795168193268, 5170.97414512925, 5197.818076367347, 3646.2342907989355, 3648.9817550912076, 3650.233450975298, 3650.3976843820737, 3650.4341827016856, 5406.243125962368, 5429.457054294618, 5432.343135343718, 5438.347398312228, 5456.863578410532, 3664.6152154023976, 3761.4390028138564, 3763.34141525232, 3763.962360376361, 3764.661180493769, 3733.178700685845, 3769.3403654360377, 3778.414345776409, 3782.432635104756, 3785.716071294664, 4320.935185972213, 4328.718633288826, 4343.196508645848, 4347.413099231563, 4349.565043495625, 5121.769520371592, 5122.129238029544, 5129.487051294841, 5138.460461651547, 5191.598268467568, 1226.582961792977, 1243.3783108445778, 1271.1483306184878, 1297.4550688710765, 1301.8502872169822, 820.9204895562317, 821.4988856797349, 827.1728271728272, 834.7770516193805, 835.908050114487, 4051.8987025324604, 4096.877093687194, 4101.539076554043, 4103.589641035873, 4114.465119534441, 4711.6807293957745, 4716.528347165325, 4750.382450281441, 4786.760661966888, 4812.735299558488, 4074.5721699221153, 4081.9795901020307, 4112.856050038295, 4128.236276288836, 4148.884069124768, 2346.601077816775, 2468.4322605800767, 2523.2808649534795, 2524.0660955446233, 2534.5944648856093, 4351.607485604576, 4368.907773056736, 4399.0, 4426.911461770746, 4441.645298184085, 4778.761061946889, 4837.854864354075, 4851.442084160367, 4869.683470574401, 4871.391076115486, 4493.977530112328, 4497.280435130363, 4590.357349971006, 5087.168619296976, 5089.549478398639, 5327.108876348841, 5366.436524164907, 5378.193271009223, 5389.407165211902, 5409.404965453876, 5231.267622532772, 5274.600056973991, 5277.920831187612, 5303.681779093266, 5312.760925758427, 4916.115099282163, 4974.527419895249, 5023.899522009467, 5032.521910418504, 5032.949670503248, 3682.134698345833, 3688.63113688629, 3722.9441558376107, 3728.5339332583426, 3752.5684546277525, 5133.974330128325, 5413.188021796762, 5420.208592574748, 5421.512063914109, 5422.566194704335, 5067.6199285053035, 5139.486051394831, 5152.6650767699975, 5213.556847667991, 5217.208793295568, 5120.48795120485, 5139.563137133386, 5154.484551544965, 5180.663256888291, 5201.0, 4920.286558449076, 5080.644354895122, 5105.693658380361, 5131.461196574455, 5145.3568303962, 5183.922241166461, 5199.55803756685, 5203.427622961547, 5214.0, 5229.6862188267305, 5110.214932861525, 5130.256112863689, 5142.434332223527, 5142.8971420572125, 5196.454372291007], "value": 3800.460104465378, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.7016557466353, 707.1825408699642, 715.5885365914597, 732.377479142729, 742.3615690506164, 12563.811542826865, 13207.0, 13666.794998075036, 13671.384787684554, 13676.726465470698, 13901.096428732126, 14732.484363047295, 14734.705305893902, 15427.768583471257, 15428.460003899865, 621.0435928669843, 776.4021703288493, 807.3783186946048, 808.7412028150994, 814.1980149552686, 803.6182813163759, 814.2020819596798, 814.3770015937782, 815.0301141641428, 815.2051749544206, 849.7960489482541, 852.0542198160038, 855.3072011670566, 855.9144085591422, 856.1353033436243, 659.1496968910076, 814.2793627639581, 845.3364109174269, 848.3213429256601, 849.4605925237488, 621.4686443091138, 621.7419770795115, 622.2377587455376, 622.4024936061387, 622.8131560531867, 14039.719205615933, 14071.859281407158, 14087.295635218197, 14111.576652700436, 14112.364943577564, 11943.701407464796, 12241.387930603434, 12294.0, 12368.75262494745, 12889.871101288962, 11775.0, 11842.0, 11989.100817438726, 12199.634010979686, 12257.0, 4126.195391898581, 4158.688098392602, 4164.437800896871, 4206.642435392995, 4262.041040765803, 44039.33940990888, 44288.3356749649, 60917.0, 62769.6861515694, 62825.371746282864, 9330.300227482965, 9879.703608891745, 9925.900740992498, 10124.949375253076, 10373.222008349254, 17837.732434013502, 18114.81885181158, 18782.436526904214, 18796.436106916815, 18865.528361791065, 6591.439727623206, 6652.933470665328, 6667.766628168088, 6714.060031595581, 6946.9652651736415, 3636.709063274932, 3655.8903232903053, 3656.2321912398693, 3701.481792549045, 3723.5345581802276, 2764.8202866813995, 2858.3854471288355, 2859.027930503639, 2860.685324614291, 2860.9427811443657, 510.22445882258756, 511.125974583459, 512.7461906356303, 512.7641285008863, 532.3000254665103, 488.4480536993175, 498.2028753993581, 500.42701107232017, 503.1948881789108, 528.3844321365643, 7215.783526494213, 7338.0, 7359.816004599821, 7423.331900129015, 7743.5353878767455, 489.883066608134, 504.5635525270688, 511.79272394680214, 514.8738559052981, 518.3080587415842, 3414.5902491701154, 3502.6847583717586, 3554.2180720241504, 3557.964420355815, 3657.122290650225, 50604.0, 84266.5786671075, 84951.57524212463, 85178.14821851825, 86420.56789716012, 78103.31380117212, 78624.60687696525, 78650.49446538802, 79854.600726996, 80213.0, 68795.0, 69470.3052969474, 69629.0, 69797.30202698009, 70079.64960175166, 6905.689243983932, 7094.6097964612445, 7155.391791697764, 7194.172670143001, 7202.71189152449, 30338.54492182575, 36723.062155027, 41332.79333603313, 42185.36721949235, 42360.364594531726, 39562.2087558253, 39869.60130398659, 39979.60020399875, 41730.0, 60219.69890150521, 9254.259659227111, 9279.443233406017, 9326.253899687874, 9543.713688589354, 9551.331406801457, 9552.522373881417, 9685.854712179182, 9880.752981175241, 9933.0, 9978.850317245102, 9292.16370526656, 9294.209992150743, 9442.291828113057, 9683.564239609093, 9770.218382529523, 9332.860007099764, 9493.810123797348, 9587.808243834945, 9620.13418792312, 10008.949955250177, 9357.672481463116, 9411.341206115507, 9463.432194068379, 9792.608295668093, 9846.704598862045, 7935.444518883623, 8087.514749115072, 8181.877271841046, 8265.752027439186, 8328.958355208186, 8019.198080191934, 8323.750287491384, 8344.374171937008, 8420.284275836622, 8432.915670843213], "value": 6135.696179060564, "unit": "score"}], "name": "dromaeo_css", "value": 6372.998279009716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 133.0, 182.0, 138.0, 133.0, 159.0, 138.0, 194.0, 131.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 127.0, 76.0, 77.0, 75.0, 75.0, 98.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 113.0, 86.0, 86.0, 86.0, 116.0, 86.0, 86.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 83.0, 85.0, 84.0, 86.0, 117.0, 84.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 131.0, 135.0, 132.0, 129.0, 130.0, 143.0, 130.0, 136.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 170.0, 168.0, 170.0, 173.0, 172.0, 169.0, 171.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 69.0, 66.0, 73.0, 66.0, 64.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1545.1, "alertThreshold": 2.0}]} 10:32:16 INFO - Return code: 0 10:32:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:16 INFO - # TBPL SUCCESS # 10:32:16 INFO - Running post-action listener: _resource_record_post_action 10:32:16 INFO - ##### 10:32:16 INFO - ##### Finished run-tests step (success) 10:32:16 INFO - ##### 10:32:16 INFO - Running post-run listener: _resource_record_post_run 10:32:16 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544436224; Read time: 36; Write time: 461496 10:32:16 INFO - TinderboxPrint: CPU usage
13.2% 10:32:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 10:32:16 INFO - TinderboxPrint: I/O write bytes / time
544,436,224 / 461,496 10:32:16 INFO - TinderboxPrint: CPU idle
8,330.4 (86.8%) 10:32:16 INFO - TinderboxPrint: CPU user
1,219.9 (12.7%) 10:32:16 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245604352; Read time: 0; Write time: 245392 10:32:16 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298831872; Read time: 36; Write time: 216104 10:32:17 INFO - Running post-run listener: _upload_blobber_files 10:32:17 INFO - Blob upload gear active. 10:32:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:17 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 10:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:32:17 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:18 INFO - (blobuploader) - INFO - Done attempting. 10:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:19 INFO - (blobuploader) - INFO - Done attempting. 10:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:23 INFO - (blobuploader) - INFO - Done attempting. 10:32:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:23 INFO - Return code: 0 10:32:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53190ad0ef6fb537c4a9ed41e94c0f723bc1eb3e3b4bd0ecc7570cf94c198eafd345d2b9b51e2b597339c374e28b19e766fcca65ad97145798ec0b528036a9df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d94d3925a550779756acb219d9b7eca495f95d0ad6c7f05485b129d84562ec86e73ba5ea2c34d1218bf9cf5941be69368eb3ac5f3404b772dfadd7cabf951606", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc010f9c22f70670d8da59c4fba0f1d7cfc32dd65513592584dad3c8f7460ebd35a4ef2ac365be8243f7d5b2cdbd307c9f24e2b025eccfb922afc47578cd2467"} 10:32:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:23 INFO - Contents: 10:32:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53190ad0ef6fb537c4a9ed41e94c0f723bc1eb3e3b4bd0ecc7570cf94c198eafd345d2b9b51e2b597339c374e28b19e766fcca65ad97145798ec0b528036a9df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d94d3925a550779756acb219d9b7eca495f95d0ad6c7f05485b129d84562ec86e73ba5ea2c34d1218bf9cf5941be69368eb3ac5f3404b772dfadd7cabf951606", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc010f9c22f70670d8da59c4fba0f1d7cfc32dd65513592584dad3c8f7460ebd35a4ef2ac365be8243f7d5b2cdbd307c9f24e2b025eccfb922afc47578cd2467"} 10:32:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:23 INFO - Copying logs to upload dir... 10:32:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.698034 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-16 10:32:23.200253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 10:32:23.204059) ========= 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=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 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-Non-PGO/sha512/53190ad0ef6fb537c4a9ed41e94c0f723bc1eb3e3b4bd0ecc7570cf94c198eafd345d2b9b51e2b597339c374e28b19e766fcca65ad97145798ec0b528036a9df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d94d3925a550779756acb219d9b7eca495f95d0ad6c7f05485b129d84562ec86e73ba5ea2c34d1218bf9cf5941be69368eb3ac5f3404b772dfadd7cabf951606", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc010f9c22f70670d8da59c4fba0f1d7cfc32dd65513592584dad3c8f7460ebd35a4ef2ac365be8243f7d5b2cdbd307c9f24e2b025eccfb922afc47578cd2467"} build_url:https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/T6CLTuCqSR6ej3uNMCVH6Q/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-Non-PGO/sha512/53190ad0ef6fb537c4a9ed41e94c0f723bc1eb3e3b4bd0ecc7570cf94c198eafd345d2b9b51e2b597339c374e28b19e766fcca65ad97145798ec0b528036a9df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d94d3925a550779756acb219d9b7eca495f95d0ad6c7f05485b129d84562ec86e73ba5ea2c34d1218bf9cf5941be69368eb3ac5f3404b772dfadd7cabf951606", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc010f9c22f70670d8da59c4fba0f1d7cfc32dd65513592584dad3c8f7460ebd35a4ef2ac365be8243f7d5b2cdbd307c9f24e2b025eccfb922afc47578cd2467"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 10:32:23.230023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:32:23.230385) ========= 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=7de08804244eb36560b44971000001c3-1466093534.845881-826466114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 10:32:23.313884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 10:32:23.314326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 10:32:23.314727) ========= ========= Total master_lag: 0.17 =========