builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1466126785.56 results: success (0) buildid: 20160616170426 builduid: 55626b7eaafe417e8841ec3f50270bc4 revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.565257) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.565750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.566076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.630446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.630778) ========= 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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 18:26:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.7M=0s 2016-06-16 18:26:26 (36.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148295 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.805922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.806254) ========= 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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017327 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:25.861492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 18:26:25.862256) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f95858f8ddf21ea2271a12810332efd09eff138 --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 5f95858f8ddf21ea2271a12810332efd09eff138 --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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 18:26:26,868 truncating revision to first 12 chars 2016-06-16 18:26:26,868 Setting DEBUG logging. 2016-06-16 18:26:26,868 attempt 1/10 2016-06-16 18:26:26,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f95858f8ddf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 18:26:28,245 unpacking tar archive at: fx-team-5f95858f8ddf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.712493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 18:26:27.595848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:27.596586) ========= script_repo_revision: 5f95858f8ddf21ea2271a12810332efd09eff138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:27.597522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:27.597842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:26:27.612169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-16 18:26:27.612489) ========= /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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:28 INFO - MultiFileLogger online at 20160616 18:26:28 in /builds/slave/test 18:26:28 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 18:26:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:28 INFO - {'append_to_log': False, 18:26:28 INFO - 'base_work_dir': '/builds/slave/test', 18:26:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:26:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:28 INFO - 'branch': 'Fx-Team-Non-PGO', 18:26:28 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:28 INFO - 'config_files': ('talos/linux_config.py',), 18:26:28 INFO - 'default_actions': ('clobber', 18:26:28 INFO - 'read-buildbot-config', 18:26:28 INFO - 'download-and-extract', 18:26:28 INFO - 'populate-webroot', 18:26:28 INFO - 'create-virtualenv', 18:26:28 INFO - 'install', 18:26:28 INFO - 'run-tests'), 18:26:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:28 INFO - 'download_minidump_stackwalk': True, 18:26:28 INFO - 'download_symbols': 'ondemand', 18:26:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:28 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:28 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:28 INFO - 'installer_path': 'installer.exe', 18:26:28 INFO - 'log_level': 'info', 18:26:28 INFO - 'log_name': 'talos', 18:26:28 INFO - 'log_to_console': True, 18:26:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:28 INFO - 'opt_config_files': (), 18:26:28 INFO - 'pip_index': False, 18:26:28 INFO - 'sps_profile': False, 18:26:28 INFO - 'sps_profile_interval': 0, 18:26:28 INFO - 'suite': 'dromaeojs', 18:26:28 INFO - 'system_bits': '32', 18:26:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:28 INFO - 'title': 'talos-linux64-ix-025', 18:26:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:28 INFO - 'use_talos_json': True, 18:26:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:28 INFO - 'work_dir': 'build'} 18:26:28 INFO - ##### 18:26:28 INFO - ##### Running clobber step. 18:26:28 INFO - ##### 18:26:28 INFO - Running pre-action listener: _resource_record_pre_action 18:26:28 INFO - Running main action method: clobber 18:26:28 INFO - rmtree: /builds/slave/test/build 18:26:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:29 INFO - Running post-action listener: _resource_record_post_action 18:26:29 INFO - ##### 18:26:29 INFO - ##### Finished clobber step (success) 18:26:29 INFO - ##### 18:26:29 INFO - ##### 18:26:29 INFO - ##### Running read-buildbot-config step. 18:26:29 INFO - ##### 18:26:29 INFO - Running pre-action listener: _resource_record_pre_action 18:26:29 INFO - Running main action method: read_buildbot_config 18:26:29 INFO - Using buildbot properties: 18:26:29 INFO - { 18:26:29 INFO - "project": "", 18:26:29 INFO - "product": "firefox", 18:26:29 INFO - "script_repo_revision": "production", 18:26:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:26:29 INFO - "repository": "", 18:26:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:26:29 INFO - "buildid": "20160616170426", 18:26:29 INFO - "pgo_build": "False", 18:26:29 INFO - "basedir": "/builds/slave/test", 18:26:29 INFO - "buildnumber": 1871, 18:26:29 INFO - "slavename": "talos-linux64-ix-025", 18:26:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:26:29 INFO - "platform": "ubuntu64_hw", 18:26:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:26:29 INFO - "branch": "fx-team", 18:26:29 INFO - "repo_path": "integration/fx-team", 18:26:29 INFO - "revision": "5f95858f8ddf21ea2271a12810332efd09eff138", 18:26:29 INFO - "stage_platform": "linux64", 18:26:29 INFO - "builduid": "55626b7eaafe417e8841ec3f50270bc4", 18:26:29 INFO - "slavebuilddir": "test" 18:26:29 INFO - } 18:26:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:26:29 INFO - Running post-action listener: _resource_record_post_action 18:26:29 INFO - ##### 18:26:29 INFO - ##### Finished read-buildbot-config step (success) 18:26:29 INFO - ##### 18:26:29 INFO - ##### 18:26:29 INFO - ##### Running download-and-extract step. 18:26:29 INFO - ##### 18:26:29 INFO - Running pre-action listener: _resource_record_pre_action 18:26:29 INFO - Running main action method: download_and_extract 18:26:29 INFO - mkdir: /builds/slave/test/build/tests 18:26: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')]} 18:26:29 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:32 INFO - Downloaded 1361 bytes. 18:26:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:26:32 INFO - Using the following test package requirements: 18:26:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:26:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:26:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'jsshell-linux-x86_64.zip'], 18:26:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:26:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:26:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:26:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:26:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:26:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:32 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:33 INFO - Downloaded 22654592 bytes. 18:26:33 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'] 18:26:33 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 18:26:34 INFO - Return code: 0 18:26:34 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 18:26: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')]} 18:26:34 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:38 INFO - Downloaded 22654592 bytes. 18:26:38 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'] 18:26:38 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 18:26:39 INFO - Return code: 0 18:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:39 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:41 INFO - Downloaded 14405384 bytes. 18:26:41 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'] 18:26:41 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 18:26:41 INFO - Return code: 0 18:26:41 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')]} 18:26:41 INFO - https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GD0ntWAwQimRItXulKQV0w/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 18:26:42 INFO - Downloaded 55448507 bytes. 18:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:42 INFO - mkdir: /builds/slave/test/properties 18:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:42 INFO - Contents: 18:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:26:43 INFO - Running post-action listener: _resource_record_post_action 18:26:43 INFO - Running post-action listener: set_extra_try_arguments 18:26:43 INFO - ##### 18:26:43 INFO - ##### Finished download-and-extract step (success) 18:26:43 INFO - ##### 18:26:43 INFO - ##### 18:26:43 INFO - ##### Running populate-webroot step. 18:26:43 INFO - ##### 18:26:43 INFO - Running pre-action listener: _resource_record_pre_action 18:26:43 INFO - Running main action method: populate_webroot 18:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:43 INFO - '--tppagecycles', 18:26:43 INFO - '7'], 18:26:43 INFO - 'tests': ['tsvgm']}}, 18:26:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['damp', 'tps']}, 18:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'tests': ['damp', 'tps']}, 18:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['dromaeo_dom']}, 18:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['basic_compositor_video']}, 18:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['a11yr', 18:26:43 INFO - 'ts_paint', 18:26:43 INFO - 'tpaint', 18:26:43 INFO - 'sessionrestore', 18:26:43 INFO - 'sessionrestore_no_auto_restore', 18:26:43 INFO - 'tabpaint']}, 18:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['tsvgx', 18:26:43 INFO - 'tsvgr_opacity', 18:26:43 INFO - 'tart', 18:26:43 INFO - 'tscrollx', 18:26:43 INFO - 'cart']}, 18:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:43 INFO - 'tsvgr_opacity', 18:26:43 INFO - 'tart', 18:26:43 INFO - 'tscrollx', 18:26:43 INFO - 'cart']}, 18:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'talos_options': ['--disable-e10s'], 18:26:43 INFO - 'tests': ['tp5o']}, 18:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'tests': ['tp5o']}, 18:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'talos_options': ['--disable-e10s', 18:26:43 INFO - '--xperf_path', 18:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:43 INFO - 'tests': ['tp5n']}, 18:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:43 INFO - 'talos_options': ['--xperf_path', 18:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:43 INFO - 'tests': ['tp5n']}}, 18:26:43 INFO - 'talos.zip': {'path': '', 18:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:43 INFO - Running post-action listener: _resource_record_post_action 18:26:43 INFO - ##### 18:26:43 INFO - ##### Finished populate-webroot step (success) 18:26:43 INFO - ##### 18:26:43 INFO - ##### 18:26:43 INFO - ##### Running create-virtualenv step. 18:26:43 INFO - ##### 18:26:43 INFO - Running pre-action listener: _resource_record_pre_action 18:26:43 INFO - Running main action method: create_virtualenv 18:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:43 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 18:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:43 INFO - Using real prefix '/usr' 18:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:46 INFO - Installing pip.................done. 18:26:46 INFO - Return code: 0 18:26:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:46 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26:46 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 18:26:46 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 18:26:46 INFO - Using env: {'DISPLAY': ':0', 18:26:46 INFO - 'HOME': '/home/cltbld', 18:26:46 INFO - 'LANG': 'en_US.UTF-8', 18:26:46 INFO - 'LANGUAGE': 'en_US:en', 18:26:46 INFO - 'LOGNAME': 'cltbld', 18:26:46 INFO - 'MAIL': '/var/mail/cltbld', 18:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:46 INFO - 'MOZ_NO_REMOTE': '1', 18:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:46 INFO - 'NO_EM_RESTART': '1', 18:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:46 INFO - 'PWD': '/builds/slave/test', 18:26:46 INFO - 'SHELL': '/bin/bash', 18:26:46 INFO - 'SHLVL': '1', 18:26:46 INFO - 'TERM': 'linux', 18:26:46 INFO - 'TMOUT': '86400', 18:26:46 INFO - 'USER': 'cltbld', 18:26:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:46 INFO - '_': '/tools/buildbot/bin/python'} 18:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:46 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 18:26:46 INFO - Cleaning up... 18:26:46 INFO - Return code: 0 18:26:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:46 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26:46 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 18:26:46 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 18:26:46 INFO - Using env: {'DISPLAY': ':0', 18:26:46 INFO - 'HOME': '/home/cltbld', 18:26:46 INFO - 'LANG': 'en_US.UTF-8', 18:26:46 INFO - 'LANGUAGE': 'en_US:en', 18:26:46 INFO - 'LOGNAME': 'cltbld', 18:26:46 INFO - 'MAIL': '/var/mail/cltbld', 18:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:46 INFO - 'MOZ_NO_REMOTE': '1', 18:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:46 INFO - 'NO_EM_RESTART': '1', 18:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:46 INFO - 'PWD': '/builds/slave/test', 18:26:46 INFO - 'SHELL': '/bin/bash', 18:26:46 INFO - 'SHLVL': '1', 18:26:46 INFO - 'TERM': 'linux', 18:26:46 INFO - 'TMOUT': '86400', 18:26:46 INFO - 'USER': 'cltbld', 18:26:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:46 INFO - '_': '/tools/buildbot/bin/python'} 18:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:46 INFO - Downloading/unpacking psutil>=3.1.1 18:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:48 INFO - Installing collected packages: psutil 18:26:48 INFO - Running setup.py install for psutil 18:26:48 INFO - building 'psutil._psutil_linux' extension 18:26:48 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 18:26:48 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 18:26:48 INFO - building 'psutil._psutil_posix' extension 18:26:48 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 18:26:49 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 18:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:49 INFO - Successfully installed psutil 18:26:49 INFO - Cleaning up... 18:26:49 INFO - Return code: 0 18:26:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26:49 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')]} 18:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:49 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')]} 18:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:49 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26:49 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 18:26:49 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 18:26:49 INFO - Using env: {'DISPLAY': ':0', 18:26:49 INFO - 'HOME': '/home/cltbld', 18:26:49 INFO - 'LANG': 'en_US.UTF-8', 18:26:49 INFO - 'LANGUAGE': 'en_US:en', 18:26:49 INFO - 'LOGNAME': 'cltbld', 18:26:49 INFO - 'MAIL': '/var/mail/cltbld', 18:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:49 INFO - 'MOZ_NO_REMOTE': '1', 18:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:49 INFO - 'NO_EM_RESTART': '1', 18:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:49 INFO - 'PWD': '/builds/slave/test', 18:26:49 INFO - 'SHELL': '/bin/bash', 18:26:49 INFO - 'SHLVL': '1', 18:26:49 INFO - 'TERM': 'linux', 18:26:49 INFO - 'TMOUT': '86400', 18:26:49 INFO - 'USER': 'cltbld', 18:26:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:49 INFO - '_': '/tools/buildbot/bin/python'} 18:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:51 INFO - Installing collected packages: mozsystemmonitor 18:26:51 INFO - Running setup.py install for mozsystemmonitor 18:26:51 INFO - Successfully installed mozsystemmonitor 18:26:51 INFO - Cleaning up... 18:26:51 INFO - Return code: 0 18:26:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', '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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:26: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 jsonschema==2.5.1 18:26:51 INFO - Using env: {'DISPLAY': ':0', 18:26:51 INFO - 'HOME': '/home/cltbld', 18:26:51 INFO - 'LANG': 'en_US.UTF-8', 18:26:51 INFO - 'LANGUAGE': 'en_US:en', 18:26:51 INFO - 'LOGNAME': 'cltbld', 18:26:51 INFO - 'MAIL': '/var/mail/cltbld', 18:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:51 INFO - 'MOZ_NO_REMOTE': '1', 18:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:51 INFO - 'NO_EM_RESTART': '1', 18:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:51 INFO - 'PWD': '/builds/slave/test', 18:26:51 INFO - 'SHELL': '/bin/bash', 18:26:51 INFO - 'SHLVL': '1', 18:26:51 INFO - 'TERM': 'linux', 18:26:51 INFO - 'TMOUT': '86400', 18:26:51 INFO - 'USER': 'cltbld', 18:26:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:51 INFO - '_': '/tools/buildbot/bin/python'} 18:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:51 INFO - Downloading/unpacking jsonschema==2.5.1 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:53 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 18:26:53 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 18:26:53 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 18:26:53 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 18:26:53 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 18:26:53 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 18:26:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:53 INFO - warning: no files found matching '*.txt' 18:26:53 INFO - no previously-included directories found matching 'build' 18:26:53 INFO - no previously-included directories found matching 'dist' 18:26:53 INFO - no previously-included directories found matching '.git*' 18:26:53 INFO - Installing collected packages: jsonschema, functools32 18:26:53 INFO - Running setup.py install for functools32 18:26:54 INFO - warning: no files found matching '*.txt' 18:26:54 INFO - no previously-included directories found matching 'build' 18:26:54 INFO - no previously-included directories found matching 'dist' 18:26:54 INFO - no previously-included directories found matching '.git*' 18:26:54 INFO - Successfully installed jsonschema functools32 18:26:54 INFO - Cleaning up... 18:26:54 INFO - Return code: 0 18:26:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', '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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:26: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 blobuploader==1.2.4 18:26:54 INFO - Using env: {'DISPLAY': ':0', 18:26:54 INFO - 'HOME': '/home/cltbld', 18:26:54 INFO - 'LANG': 'en_US.UTF-8', 18:26:54 INFO - 'LANGUAGE': 'en_US:en', 18:26:54 INFO - 'LOGNAME': 'cltbld', 18:26:54 INFO - 'MAIL': '/var/mail/cltbld', 18:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:54 INFO - 'MOZ_NO_REMOTE': '1', 18:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:54 INFO - 'NO_EM_RESTART': '1', 18:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:54 INFO - 'PWD': '/builds/slave/test', 18:26:54 INFO - 'SHELL': '/bin/bash', 18:26:54 INFO - 'SHLVL': '1', 18:26:54 INFO - 'TERM': 'linux', 18:26:54 INFO - 'TMOUT': '86400', 18:26:54 INFO - 'USER': 'cltbld', 18:26:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:54 INFO - '_': '/tools/buildbot/bin/python'} 18:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:56 INFO - Downloading docopt-0.6.1.tar.gz 18:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:57 INFO - Running setup.py install for blobuploader 18:26:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:57 INFO - Running setup.py install for requests 18:26:57 INFO - Running setup.py install for docopt 18:26:57 INFO - Successfully installed blobuploader requests docopt 18:26:57 INFO - Cleaning up... 18:26:57 INFO - Return code: 0 18:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:57 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')]} 18:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:57 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')]} 18:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:57 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:26:57 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 18:26:57 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 18:26:57 INFO - Using env: {'DISPLAY': ':0', 18:26:57 INFO - 'HOME': '/home/cltbld', 18:26:57 INFO - 'LANG': 'en_US.UTF-8', 18:26:57 INFO - 'LANGUAGE': 'en_US:en', 18:26:57 INFO - 'LOGNAME': 'cltbld', 18:26:57 INFO - 'MAIL': '/var/mail/cltbld', 18:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:57 INFO - 'MOZ_NO_REMOTE': '1', 18:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:57 INFO - 'NO_EM_RESTART': '1', 18:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:57 INFO - 'PWD': '/builds/slave/test', 18:26:57 INFO - 'SHELL': '/bin/bash', 18:26:57 INFO - 'SHLVL': '1', 18:26:57 INFO - 'TERM': 'linux', 18:26:57 INFO - 'TMOUT': '86400', 18:26:57 INFO - 'USER': 'cltbld', 18:26:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:57 INFO - '_': '/tools/buildbot/bin/python'} 18:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:57 INFO - Running setup.py (path:/tmp/pip-uPx2ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:57 INFO - Running setup.py (path:/tmp/pip-FaG6iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:58 INFO - Running setup.py (path:/tmp/pip-ROVTF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:58 INFO - Running setup.py (path:/tmp/pip-83MSO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:58 INFO - Running setup.py (path:/tmp/pip-rJZWau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:58 INFO - Running setup.py (path:/tmp/pip-R9EYIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:58 INFO - Running setup.py (path:/tmp/pip-7Y11dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:58 INFO - Running setup.py (path:/tmp/pip-FXKQft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:58 INFO - Running setup.py (path:/tmp/pip-6R4NG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:58 INFO - Running setup.py (path:/tmp/pip-GkhpZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:58 INFO - Running setup.py (path:/tmp/pip-stJwee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:58 INFO - Running setup.py (path:/tmp/pip-5x2lFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:58 INFO - Running setup.py (path:/tmp/pip-gEWb4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:58 INFO - Running setup.py (path:/tmp/pip-JSo9dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:58 INFO - Running setup.py (path:/tmp/pip-xfpAGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:58 INFO - Running setup.py (path:/tmp/pip-4tvKni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:59 INFO - Running setup.py (path:/tmp/pip-rPRlye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:59 INFO - Running setup.py install for manifestparser 18:26:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Running setup.py install for mozcrash 18:26:59 INFO - Running setup.py install for mozdebug 18:26:59 INFO - Running setup.py install for mozdevice 18:26:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Running setup.py install for mozfile 18:26:59 INFO - Running setup.py install for mozhttpd 18:26:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Running setup.py install for mozinfo 18:26:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Running setup.py install for mozInstall 18:26:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:59 INFO - Running setup.py install for mozleak 18:27:00 INFO - Running setup.py install for mozlog 18:27:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Running setup.py install for moznetwork 18:27:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Running setup.py install for mozprocess 18:27:00 INFO - Running setup.py install for mozprofile 18:27:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Running setup.py install for mozrunner 18:27:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Running setup.py install for mozscreenshot 18:27:00 INFO - Running setup.py install for moztest 18:27:00 INFO - Running setup.py install for mozversion 18:27:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:27:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:27:00 INFO - Cleaning up... 18:27:00 INFO - Return code: 0 18:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:00 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')]} 18:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:00 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')]} 18:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:00 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:27:00 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 18:27:00 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 18:27:00 INFO - Using env: {'DISPLAY': ':0', 18:27:00 INFO - 'HOME': '/home/cltbld', 18:27:00 INFO - 'LANG': 'en_US.UTF-8', 18:27:00 INFO - 'LANGUAGE': 'en_US:en', 18:27:00 INFO - 'LOGNAME': 'cltbld', 18:27:00 INFO - 'MAIL': '/var/mail/cltbld', 18:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:00 INFO - 'MOZ_NO_REMOTE': '1', 18:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:00 INFO - 'NO_EM_RESTART': '1', 18:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:00 INFO - 'PWD': '/builds/slave/test', 18:27:00 INFO - 'SHELL': '/bin/bash', 18:27:00 INFO - 'SHLVL': '1', 18:27:00 INFO - 'TERM': 'linux', 18:27:00 INFO - 'TMOUT': '86400', 18:27:00 INFO - 'USER': 'cltbld', 18:27:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:00 INFO - '_': '/tools/buildbot/bin/python'} 18:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:01 INFO - Running setup.py (path:/tmp/pip-KWmjFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:01 INFO - Running setup.py (path:/tmp/pip-kdAITZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:01 INFO - Running setup.py (path:/tmp/pip-OpV8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:01 INFO - Running setup.py (path:/tmp/pip-g5lPp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:01 INFO - Running setup.py (path:/tmp/pip-Bjy6_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:01 INFO - Running setup.py (path:/tmp/pip-LEMtt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:01 INFO - Running setup.py (path:/tmp/pip-aVElQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:01 INFO - Running setup.py (path:/tmp/pip-lQiZD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:01 INFO - Running setup.py (path:/tmp/pip-4yHR0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:01 INFO - Running setup.py (path:/tmp/pip-3WRoLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:01 INFO - Running setup.py (path:/tmp/pip-_sciW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:01 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)) 18:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:01 INFO - Running setup.py (path:/tmp/pip-v8ULVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:02 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)) 18:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:02 INFO - Running setup.py (path:/tmp/pip-P9puWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:02 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)) 18:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:02 INFO - Running setup.py (path:/tmp/pip-FpS9Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:02 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)) 18:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:02 INFO - Running setup.py (path:/tmp/pip-vPW4kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:02 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)) 18:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:02 INFO - Running setup.py (path:/tmp/pip-nvUDfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:02 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)) 18:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:02 INFO - Running setup.py (path:/tmp/pip-Xi58xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:02 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)) 18:27:02 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)) 18:27:02 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)) 18:27:02 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)) 18:27:02 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)) 18:27:02 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)) 18:27:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:02 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 18:27:02 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 18:27:02 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 18:27:02 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 18:27:02 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 18:27:02 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 18:27:04 INFO - Downloading blessings-1.6.tar.gz 18:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:27:04 INFO - Installing collected packages: blessings 18:27:04 INFO - Running setup.py install for blessings 18:27:04 INFO - Successfully installed blessings 18:27:04 INFO - Cleaning up... 18:27:04 INFO - Return code: 0 18:27:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:04 INFO - Reading from file tmpfile_stdout 18:27:04 INFO - Current package versions: 18:27:04 INFO - argparse == 1.2.1 18:27:04 INFO - blessings == 1.6 18:27:04 INFO - blobuploader == 1.2.4 18:27:04 INFO - docopt == 0.6.1 18:27:04 INFO - functools32 == 3.2.3-2 18:27:04 INFO - jsonschema == 2.5.1 18:27:04 INFO - manifestparser == 1.1 18:27:04 INFO - mozInstall == 1.12 18:27:04 INFO - mozcrash == 0.17 18:27:04 INFO - mozdebug == 0.1 18:27:04 INFO - mozdevice == 0.48 18:27:04 INFO - mozfile == 1.2 18:27:04 INFO - mozhttpd == 0.7 18:27:04 INFO - mozinfo == 0.9 18:27:04 INFO - mozleak == 0.1 18:27:04 INFO - mozlog == 3.2 18:27:04 INFO - moznetwork == 0.27 18:27:04 INFO - mozprocess == 0.22 18:27:04 INFO - mozprofile == 0.28 18:27:04 INFO - mozrunner == 6.11 18:27:04 INFO - mozscreenshot == 0.1 18:27:04 INFO - mozsystemmonitor == 0.3 18:27:04 INFO - moztest == 0.7 18:27:04 INFO - mozversion == 1.4 18:27:04 INFO - psutil == 3.1.1 18:27:04 INFO - requests == 1.2.3 18:27:04 INFO - wsgiref == 0.1.2 18:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:04 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')]} 18:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:04 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')]} 18:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:04 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:27:04 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 18:27:04 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 18:27:04 INFO - Using env: {'DISPLAY': ':0', 18:27:04 INFO - 'HOME': '/home/cltbld', 18:27:04 INFO - 'LANG': 'en_US.UTF-8', 18:27:04 INFO - 'LANGUAGE': 'en_US:en', 18:27:04 INFO - 'LOGNAME': 'cltbld', 18:27:04 INFO - 'MAIL': '/var/mail/cltbld', 18:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:04 INFO - 'MOZ_NO_REMOTE': '1', 18:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:04 INFO - 'NO_EM_RESTART': '1', 18:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:04 INFO - 'PWD': '/builds/slave/test', 18:27:04 INFO - 'SHELL': '/bin/bash', 18:27:04 INFO - 'SHLVL': '1', 18:27:04 INFO - 'TERM': 'linux', 18:27:04 INFO - 'TMOUT': '86400', 18:27:04 INFO - 'USER': 'cltbld', 18:27:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:04 INFO - '_': '/tools/buildbot/bin/python'} 18:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 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)) 18:27:04 INFO - Cleaning up... 18:27:04 INFO - Return code: 0 18:27:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:27:04 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')]} 18:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:04 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')]} 18:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:04 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:27:04 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 18:27:04 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 18:27:04 INFO - Using env: {'DISPLAY': ':0', 18:27:04 INFO - 'HOME': '/home/cltbld', 18:27:04 INFO - 'LANG': 'en_US.UTF-8', 18:27:04 INFO - 'LANGUAGE': 'en_US:en', 18:27:04 INFO - 'LOGNAME': 'cltbld', 18:27:04 INFO - 'MAIL': '/var/mail/cltbld', 18:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:04 INFO - 'MOZ_NO_REMOTE': '1', 18:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:04 INFO - 'NO_EM_RESTART': '1', 18:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:04 INFO - 'PWD': '/builds/slave/test', 18:27:04 INFO - 'SHELL': '/bin/bash', 18:27:04 INFO - 'SHLVL': '1', 18:27:04 INFO - 'TERM': 'linux', 18:27:04 INFO - 'TMOUT': '86400', 18:27:04 INFO - 'USER': 'cltbld', 18:27:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:04 INFO - '_': '/tools/buildbot/bin/python'} 18:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:27:05 INFO - Cleaning up... 18:27:05 INFO - Return code: 0 18:27:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:05 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 0x7f4814b51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, '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': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', '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 18:27:05 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 18:27:05 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 18:27:05 INFO - Using env: {'DISPLAY': ':0', 18:27:05 INFO - 'HOME': '/home/cltbld', 18:27:05 INFO - 'LANG': 'en_US.UTF-8', 18:27:05 INFO - 'LANGUAGE': 'en_US:en', 18:27:05 INFO - 'LOGNAME': 'cltbld', 18:27:05 INFO - 'MAIL': '/var/mail/cltbld', 18:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:05 INFO - 'MOZ_NO_REMOTE': '1', 18:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:05 INFO - 'NO_EM_RESTART': '1', 18:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:05 INFO - 'PWD': '/builds/slave/test', 18:27:05 INFO - 'SHELL': '/bin/bash', 18:27:05 INFO - 'SHLVL': '1', 18:27:05 INFO - 'TERM': 'linux', 18:27:05 INFO - 'TMOUT': '86400', 18:27:05 INFO - 'USER': 'cltbld', 18:27:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:05 INFO - '_': '/tools/buildbot/bin/python'} 18:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:05 INFO - Downloading/unpacking flake8 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:05 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 18:27:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:27:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:27:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:27:07 INFO - no previously-included directories found matching 'docs/_build' 18:27:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:27:08 INFO - Running setup.py install for pep8 18:27:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:27:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:27:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:27:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:27:08 INFO - no previously-included directories found matching 'docs/_build' 18:27:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:27:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:27:08 INFO - Cleaning up... 18:27:08 INFO - Return code: 0 18:27:08 INFO - Running post-action listener: _resource_record_post_action 18:27:08 INFO - Running post-action listener: _start_resource_monitoring 18:27:08 INFO - Starting resource monitoring. 18:27:08 INFO - ##### 18:27:08 INFO - ##### Finished create-virtualenv step (success) 18:27:08 INFO - ##### 18:27:08 INFO - ##### 18:27:08 INFO - ##### Running install step. 18:27:08 INFO - ##### 18:27:08 INFO - Running pre-action listener: _resource_record_pre_action 18:27:08 INFO - Running main action method: install 18:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:08 INFO - Reading from file tmpfile_stdout 18:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 18:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:27:08 INFO - Reading from file tmpfile_stdout 18:27:08 INFO - Output received: 18:27:08 INFO - Usage: mozinstall [options] installer 18:27:08 INFO - Options: 18:27:08 INFO - -h, --help show this help message and exit 18:27:08 INFO - -d DEST, --destination=DEST 18:27:08 INFO - Directory to install application into. [default: 18:27:08 INFO - "/builds/slave/test"] 18:27:08 INFO - --app=APP Application being installed. [default: firefox] 18:27:08 INFO - mkdir: /builds/slave/test/build/application 18:27:08 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'] 18:27:08 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 18:27:24 INFO - Reading from file tmpfile_stdout 18:27:24 INFO - Output received: 18:27:24 INFO - /builds/slave/test/build/application/firefox/firefox 18:27:24 INFO - Running post-action listener: _resource_record_post_action 18:27:24 INFO - ##### 18:27:24 INFO - ##### Finished install step (success) 18:27:24 INFO - ##### 18:27:24 INFO - ##### 18:27:24 INFO - ##### Running run-tests step. 18:27:24 INFO - ##### 18:27:24 INFO - Running pre-action listener: _resource_record_pre_action 18:27:24 INFO - Running main action method: run_tests 18:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:27:24 INFO - Python 2.7.3 18:27:24 INFO - Return code: 0 18:27:24 INFO - grabbing minidump binary from tooltool 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:24 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 0x2d351c0>, '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 0x2d360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d36550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:27:24 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 18:27:24 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 18:27:24 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 18:27:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:27:24 INFO - Return code: 0 18:27:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:27:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:27:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:27:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:27:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:27:25 INFO - Return code: 0 18:27:25 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:27:25 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 18:27:25 INFO - Using env: {'DISPLAY': ':0', 18:27:25 INFO - 'HOME': '/home/cltbld', 18:27:25 INFO - 'LANG': 'en_US.UTF-8', 18:27:25 INFO - 'LANGUAGE': 'en_US:en', 18:27:25 INFO - 'LOGNAME': 'cltbld', 18:27:25 INFO - 'MAIL': '/var/mail/cltbld', 18:27:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:27:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:25 INFO - 'MOZ_NO_REMOTE': '1', 18:27:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:25 INFO - 'NO_EM_RESTART': '1', 18:27:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:25 INFO - 'PWD': '/builds/slave/test', 18:27:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:27:25 INFO - 'SHELL': '/bin/bash', 18:27:25 INFO - 'SHLVL': '1', 18:27:25 INFO - 'TERM': 'linux', 18:27:25 INFO - 'TMOUT': '86400', 18:27:25 INFO - 'USER': 'cltbld', 18:27:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575', 18:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:25 INFO - '_': '/tools/buildbot/bin/python'} 18:27:25 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/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:27:25 INFO - mozversion application_buildid: 20160616170426 18:27:25 INFO - mozversion application_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 18:27:25 INFO - mozversion application_display_name: Nightly 18:27:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:25 INFO - mozversion application_name: Firefox 18:27:25 INFO - mozversion application_remotingname: firefox 18:27:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:27:25 INFO - mozversion application_vendor: Mozilla 18:27:25 INFO - mozversion application_version: 50.0a1 18:27:25 INFO - mozversion platform_buildid: 20160616170426 18:27:25 INFO - mozversion platform_changeset: 5f95858f8ddf21ea2271a12810332efd09eff138 18:27:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:27:25 INFO - mozversion platform_version: 50.0a1 18:27:25 INFO - using testdate: 1466126845 18:27:25 INFO - actual date: 1466126845 18:27:25 INFO - starting webserver on 'localhost:36553' 18:27:25 INFO - SUITE-START | Running 2 tests 18:27:25 INFO - TEST-START | dromaeo_css 18:27:25 INFO - operating with platform_type : linux_ 18:27:25 INFO - Initialising browser for dromaeo_css test... 18:27:25 INFO - TEST-INFO | started process 25254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprIdyQ1/profile http://localhost:36553/getInfo.html) 18:27:30 INFO - PROCESS | 25254 | __metrics Screen width/height:1600/1200 18:27:30 INFO - PROCESS | 25254 | colorDepth:24 18:27:30 INFO - PROCESS | 25254 | Browser inner width/height: 1024/697 18:27:30 INFO - PROCESS | 25254 | __metrics 18:27:31 INFO - PROCESS | 25254 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:27:32 INFO - TEST-INFO | 25254: exit 0 18:27:32 INFO - Browser initialized. 18:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:32 INFO - TEST-INFO | started process 25336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprIdyQ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:44 INFO - PROCESS | 25336 | RSS: Main: 175378432 18:27:44 INFO - PROCESS | 25336 | 18:28:35 INFO - PROCESS | 25336 | 1466126915565 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] 18:30:48 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36553/tests/dromaeo/cssquery-ext.html) 18:30:49 INFO - PROCESS | 25336 | RSS: Main: 265146368 18:30:49 INFO - PROCESS | 25336 | 18:33:52 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-ext.html (next: http://localhost:36553/tests/dromaeo/cssquery-jquery.html) 18:33:52 INFO - PROCESS | 25336 | RSS: Main: 261136384 18:33:52 INFO - PROCESS | 25336 | 18:36:55 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36553/tests/dromaeo/cssquery-mootools.html) 18:36:55 INFO - PROCESS | 25336 | RSS: Main: 258297856 18:36:55 INFO - PROCESS | 25336 | 18:39:58 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36553/tests/dromaeo/cssquery-prototype.html) 18:39:58 INFO - PROCESS | 25336 | RSS: Main: 256782336 18:39:58 INFO - PROCESS | 25336 | 18:43:01 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36553/tests/dromaeo/cssquery-yui.html) 18:43:02 INFO - PROCESS | 25336 | RSS: Main: 247664640 18:43:02 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | Cycle 1(1): loaded http://localhost:36553/tests/dromaeo/cssquery-yui.html (next: http://localhost:36553/tests/dromaeo/cssquery-dojo.html) 18:46:05 INFO - PROCESS | 25336 | RSS: Main: 304128000 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | __start_tp_report 18:46:05 INFO - PROCESS | 25336 | _x_x_mozilla_page_load 18:46:05 INFO - PROCESS | 25336 | _x_x_mozilla_page_load_details 18:46:05 INFO - PROCESS | 25336 | |i|pagename|runs| 18:46:05 INFO - PROCESS | 25336 | |0;dojo.html;2651.9734802651974;2663.8934442622294;2695.110613497546;2702.540568103422;2709.8916043358267;4665.440147182335;4736;4775.594074503667;4843.200871856144;4884.511548845114;4722.64580156488;4774.618030557555;4779.90440191196;4788.928166077511;4800.967791924744;4311.051568654891;4408.581184787457;4435.534268901751;4458.4872739634875;4612.0545288215835;4456.59890609845;4500.0549884524125;4506.414166158411;4510.278355463127;4552.8634140975655;4344.087741574242;4372.1255748850035;4374.825006999748;4392.275274579691;4445.199864024475;4311.396404503372;4325.178216138924;4330.328799036123;4370.628496577795;4385.3641222022625;4339.739615623042;4345.435093437864;4376.212281789277;4380.956190438119;4387.648988080946;4699.624030077585;4761.428628564595;4776.331313616097;4788.353572267769;4833.661643684944;5214.921776173361;5268.1834315681135;5281.788728450896;5283.313169288006;5288.762005709752;5294.205869119624;5311;5329;5333.986542556901;5339.41266460689;4756.405449318835;4788.377510923628;4825.445073816486;4832.685875418087;4933.45731969483;5299.920501192485;5309.840704778863;5316.627836051517;5377.623566350396;5385.703786291791;5106.259592359087;5114.33513643224;5150.639455238173;5167.509086636764;5172.301739265151;5019.372578427697;5132.692038477703;5133.486651334912;5169.095408303532;5262.289590905255;5153.819616313486;5158.071547121479;5158.97420512895;5159.355080614923;5176.171812510056;5120.436751957282;5131.512506311969;5131.794728210904;5133.7689803958165;5181.663191892515;4332.610065094157;4370.781460926941;4378.474583050054;4435.268180750205;4444.488883778342;3872.2642697887313;3891.1828516011956;3912.0611053346993;3912.56961734209;3913.412988051815;4399.604035636744;4421.53573874745;4422.181896349186;4426.9778651106535;4429.2913133899065;5218.9739051304505;5222.843314700565;5226.189940559143;5231.163013917831;5271.6309858310315;4418.8453404130705;4460.977695111504;4461.866144015685;4495.977520112444;4511.255642818964;4514.232580461264;4646.4888862225125;4690.507496712796;4692.7653617319;4709.811607535728;4890.462049174588;4899.314096026488;4899.975500122477;4902.828401005948;4948.38145231846;5226.294450249167;5229.320188375486;5237.528622424;5239.973800130975;5245.7114858683135;4727.976360118178;4829.323894654681;4830.637702172281;4856.150173719656;4878.195097808822;5084.898302034013;5111.539961403491;5112.795488180431;5114.514121158484;5161.148410512374;5049.34358533403;5187.610929180402;5196.298499702643;5197.480251974924;5203.843884683465;5015.899682006267;5038.445770965264;5072.492750724898;5073.061483625541;5092.159793634157;5071.0872043032605;5075.11185542536;5081.898362032813;5086.669366491166;5132.486751324837;4882.267659851051;4932.383452068491;5004.47453017428;5024.673396229234;5065.392152941523;5059.721715305694;5086.440491546001;5109.20807274873;5120.897582048413;5160.845174644766;4997.725125118153;5012.899742005066;5015.774290156879;5017.899642007213;5069.670471419346 18:46:05 INFO - PROCESS | 25336 | |1;ext.html;555.571743543421;576.2278546747358;578.1530058464349;581.4389114504502;597.8505373656584;26893.731062689367;39962.80018599907;41005.9245556583;41057.384139237896;44401.77799111008;41434.79282603583;41838.58161418385;41854.37218441726;42152.78923605385;42278;7881.330086942617;7908.644111014989;8013.198680131998;8016.759497215093;8022.358211343078;7800.687972481122;7916.762497125067;7919.24767147123;7921.326687231593;7921.603919804015;7889.250521200477;7936.404769642271;7937.206279372045;7944.324732397724;7945.165757595427;7864.764057078297;7919.524828510308;7929.167437419045;7960.363170946368;7962.402819788481;7934.3255823255095;7995.68017279314;8013.879791803128;8014.278714915686;8021.2379823916635;38990;39174.41238381426;39258.03709814498;39260.21479570393;39273.87624299436;3072.2780146665514;3253.723433508155;3267.0362243138093;3466.584009918801;3736.7197460190323;29514.70485295141;29691.109266722033;29967.250818729706;30608.2347941301;31056.378872422425;3277.918052048694;3452.7928324300624;3531.646835316448;3542.096765324826;3564.28714257147;211334;266043;266848;267026.9999999981;267696;30578;32859.67140328614;54176;54854.725726371114;54857.177142342895;33760.831195843864;33791.493127603106;33865.83067084649;33919.49120763191;33957.151071223416;13061.21632702041;13083.215007099605;13183.53857614998;13271.402786874614;13307.401166947317;10635.20235982289;10871.782564348669;10876.782464350668;10878.61924832643;10881.401522916158;7788.376929845712;7903.960480197562;7904.446688731849;7971.880421793678;7992.40056995716;3118.828464434478;3145.6697046809754;3151.795133316327;3189.059227527885;3190.3938251732097;888.0630934364308;943.4999450291357;956.7082039977873;981.2346369831542;1007.4005966449951;27125.457490850073;28081.578776318373;28289.57565636517;28431.43137137287;28590.142295731162;989.8515222716507;1000.2698030437675;1002.1932344462632;1066.290916540492;1071.4482041748506;14176.291185440687;14713.411463541339;14735.263236838115;14880.92559537217;14984.62538436526;382420;385653;386567;386738;387283;49745.75127124414;50143;50154.24768628473;50220.74889625528;50304.748476258115;1067.423591260726;1155.2375432214699;1194.6177223288464;1203.3080978437433;1212.2908098762323;28357.291067723472;29395.265118372212;29550.261243469085;29796.85101574478;29978;42200;42864;42943.78528107465;42990.35514467223;43008.13983720371;257396;265949;266160;267208;268205;22242;23726.406839829142;24055.40370320619;24570.262892113264;25713.485730285665;40504.392434112924;41064.38403424011;41298.58701412947;41440.79279603583;42377.36433953555;35483.82258088693;36609.81695091614;37146.25707485889;37374.252514950094;37431.81284093562;35157.12107197341;35366.82316588401;35392.82303588569;35631;35723.46414803728;35444.29111417705;35524.822375887954;35929.64070359263;36733.26533469369;36881.07797305089;31580.210494737814;33382.49926251157;33768;33973.49039764455;34189;25305.367365816;25980.8700956494;26035.218943431726;26352;26471 18:46:05 INFO - PROCESS | 25336 | |2;jquery.html;372.4022943176202;376.5274580401597;383.560822857828;385.12000079817585;388.7667399560264;15780.684386312267;16538.669226615475;17362.91318543409;17516.912415437906;17566.648667026668;11211.271267367616;16572.254248558813;17229.164811461702;17449.563760905985;17468.475945721617;4600.217962946299;4799.664023518355;4835.05716385305;4836.613070954315;4837.0567739290855;3382.1037425082372;3611.133328001274;5169.147090730025;5454.045542030129;5473.31583552056;5516.862078448031;5523.7790488380415;5534.612577119583;5546.140348246008;5548.140038294051;5307.761150748225;5616.494515493625;5620.297462817169;5622.184783206412;5625.353084395286;3312.453445181542;5006.499350065001;5324.547413469821;5332.760025798849;5430.13117901134;12673.366331683379;12696.746065078647;12737.617871463779;15072.698546029127;21090.683639745264;1884.5382881194057;1938.2731475696614;2046.1508473983429;2392.83250172488;2447.5104979004273;9208.401453905475;9282.535873206312;9375.53122343887;9713.514324283828;9813.264005199568;1665.608581983233;1772.7075032619603;1779.7953235377838;1789.642071585675;1810.411616224719;45730.54269457296;69662.30337696659;69672.651636742;70782.64608676975;71860.28139718588;10056.899431005742;10210;10267.383956962607;10365.222608304408;10476.947615262028;14242;14305.85694143066;14358.353874075692;14376.784348234785;14404.927975360057;6863.622500762506;7052.823679408056;7124.536905101152;7145.285471452917;7160.820979475555;6566.146400967844;6612.603243805387;6700.83247918806;6770.8645827084165;6805.761798337035;4382.276924307454;4448.55514448559;4525.456945166601;4571.634269258451;4619.514950930171;1676.3713607397226;1688.1474855198046;1787.4012205911165;1811.6467288878805;1833.834954854043;788.3496115704452;896.1755185229605;909.9135582119688;915.6657819895823;929.8047410043966;16417;16655.583610409594;16725.6654866902;16795.664086718196;17168;839.0602525171846;849.6389034660368;850.3324889961351;873.6505397840914;898.1377877237794;9097.363184577016;9561.61753529851;9614.807703845883;9647.886620091364;9719.125278724949;382356;389649;391459;392939;393895;77539;78992;79196.20803791888;81472.59263703643;81880;885;898.1198425543005;913.2055112052557;916.2578311567519;926.536731634183;14679.366474704406;15051.247437628293;15151.924240378728;15218.706409954835;15284.159371234244;34106;34327.65672343245;34985.65014349824;35430.46854297136;36126.09684757902;45746.542534574226;47919;49515.25727114168;49711;49786.50213497819;7499.850003000019;7510.061242344707;7565.4325925556905;7641.7707468776025;7693.345930624942;10760.677179684622;11132.666020019413;11719.824202636797;11847.348395838311;11871.347075910908;9953.701388958054;9957.701268961942;10047.346922450017;10205.693829185137;10491.895081049091;10000.24998125129;10100.84848727255;10130.240231982778;10189.286749927434;10197.541110650187;10118.342307749972;10202.030807073315;10207.132393746615;10242.897571024194;10325.225608079274;6761.661916904233;7503.624818758931;7506.24937506245;7518.360939320219;7974.162712915292;5184.066867963803;9115;9698.9030109698;10055.346402483816;10600.628977985734 18:46:05 INFO - PROCESS | 25336 | |3;mootools.html;1201.6575276046328;1383.2599559235812;1409.6546346145196;1468.7282852672256;1675.0870775427397;6737.898931516025;7528.284812942768;7776.7278145265;7791.961040194791;8149.551774652392;7791.805204869881;7891.131975482693;7934.166912474179;7935.642896069677;7945.364370850332;1920.395075551197;2160.708304378912;2216.9113235470604;2259.9322020339414;2261.163369553268;2230.832687548432;2250.8987095580655;2253.3690566641285;2254.9098036078535;2255.2444930948154;2175.695402643631;2180.7819218078225;2254.289898681918;2254.7407048189502;2257.571061498318;1847.1595424082077;2077.366403247009;2147.6778483227486;2165.3936897668677;2169.5227050048966;2192;2219.833512486554;2221.2891874600136;2222.5999320122373;2224.2659922225625;7967.521948683097;7971.083325417593;7987.081485629169;7999.0801057877925;8065.112837587861;4395.9889225478;4500.50494445614;4533.116042371739;4575.702579332333;4577.9771101144615;2790.9581356279673;2816.7183281671873;2920.561915712639;2925.0786002409386;2929.0480593807097;918.1094338491653;921.6589861751195;923.054092157007;947.1522986926731;954.4941181173989;10992.340459572371;11017.11863050954;11022.44887755609;11033.117350611932;11038.227324087316;4187.283213882293;4275.123599662124;4375.212461756914;4379.868603941887;4439.556044395535;9167.037461066626;9199.080091990747;9258.398204116711;9267.490288034223;9274.768130796649;4706.458757242893;4706.976465117653;4708.364370809965;4709.952900470951;4713.3872596562915;3652.634736526326;4023.295923213426;4118.949667834683;4151.232022075926;4224.4508213931995;3662.5788034375855;3726;3760.793156376371;3794.0704527390412;3842.442845787345;1201.645514573203;1239.1449899569268;1244.819501172343;1251.5869762978195;1254.2537190371713;655.6623338980429;800.1078797141262;805.9274665280153;814.645629151321;816.1348970091722;5007.899842003139;5014.197728363444;5114.130597798383;5236.031334203185;5333.866653333697;829.1832544943226;852.7868032991752;852.9744107676779;876.0363600039905;888.9155530224618;3287.293231955141;3374.4263475209273;3428.0915557377316;3434.4676575130893;3447.9482807757904;9393.5303234838;9822.950885245527;9873.802523949624;9906.257030722725;9908.058734420218;9023.097690231056;9791.951040244896;9794.853077203848;9796.755081123029;9805.754856128653;7120.572765634079;7327.45044121693;7395.704171833174;7402.925970740332;7403.814904627319;5419.458054194549;5510.972445137749;5589.5807814413265;5636.746346414503;5709.885802284014;8655.134486551546;9284.350095493252;9295.76760580991;9300.39547429415;9306.208972237435;8989;9301.72094837156;9315.906840931504;9427.104425079606;9429.811403772022;5938.228030356199;5974.880502389841;6161.969190154021;6993.370596646327;7129.679164437509;7475.738349157753;7741.341985931033;7742.806429839299;7745.22547745221;7784.494007889469;6835.282295358916;6941.687624056828;6951.409130223988;6970.546914450544;7155.284471552803;6904.723811047502;6945.131858517685;6966.303369662993;7023.508354415142;7034.226235114235;5679.602427830012;5906.26171728534;5910.054391297372;6042.637441753509;6082.878342433215;4513.345564893138;4541.613962813066;4567.977160114178;4610;4648.395708557866;4659.953400465952;4665.603423708887;4704.153252414599;4731.148393289103;4743.027679325661 18:46:05 INFO - PROCESS | 25336 | |4;prototype.html;293.53767815690287;295.2780451795361;303.0499384429813;311.47516434807335;311.91266445395286;4747.192977193877;4870.586000189988;4905.3132561441425;4923.212286034235;4951.900961980758;4639.976800115995;4810.302506136617;4817.566419022287;4836.879078023051;4848.97575512122;3832.923341533168;3843.444109667068;3886.514185726784;3888.4361767543687;3896.357101078333;3699.130704284491;3737;3864.1305706216017;3913.0804260998643;3918.6473217410426;3823.3309170895122;3841.4621952926614;3848.8845334640005;3859.1316953685337;3862.671672907806;3835.271298453285;3845.1732877431486;3852.9579322958875;3861.9034524137123;3866.729328946975;3415.5389022481895;3428.451447768345;3434.9828250858836;3437.9484307735406;3438.6905178533802;4582.725036497787;4695.483496815347;4697.436307643071;4705.247160454345;4760.785764640599;4306.504751953503;4318.4170137031415;4350.390945267665;4376.343548467724;4376.89057773555;5052.8484145475695;5074.503021608634;5078.898422031539;5091.847244582668;5096.898062038738;3577.94633080504;3671.3391589513876;3680.723945704056;3690.095926498025;3701.9814900925594;5257.579393648499;5288.867778305535;5301.496357845998;5311.725185955343;5338.97330513345;3776.811159442017;3787.394016957329;3814.3515602347666;3814.6376094271;3814.961850381461;3731.7312113880866;3832.9808350958065;3853.4412510185866;3865.9226815463535;3876.7867767272505;4286.799696085039;4304.139172165579;4324.243257429937;4332.978335108304;4341.587549182886;5076;5082.567981721595;5094.465081166498;5101.464346243665;5121.897562048738;1222.9388530573435;1242.0001898471637;1249.2442072545978;1252.067209928609;1255.234307072685;851.2976794144855;919.4850883505259;928.3269629518545;930.50683137937;935.8081593273363;4411.360352748898;4418.293073108287;4430.825831154747;4433.756143412079;4446.822127114944;5216.347956505437;5237.450067742909;5237.921431178535;5252.1596544552685;5260.395054568774;4303.483581970184;4435.866923992286;4451.844185453494;4452.510223875371;4547.884698981208;2778.4165325281515;2783.5546312590295;2805.5931889875856;2812.7890408219464;2829.462402143586;4920.286558449005;4951.430585482643;4976.751162441863;4980.850574482772;5015.548600625962;5106;5390.5742415913;5408.3509978802795;5435.891282174334;5447.809326673548;4914.852554423302;4934;4934.358533390637;4944.25836124577;4951.678140920829;5253.71104589236;5273.209018647233;5274.841754747364;5284.603654725834;5285.154375299933;4896.90206195867;5128.230765385222;5133.486651334986;5177.689338639693;5203.19350500673;4896.167651499325;4924.153442459078;4931.841017360845;4939.580135688363;4951.628627852998;3662.4872517848057;3703.685186759156;3710.2764960833456;3740.0836794984316;3743.3074881147077;5216.217567364925;5278.868028299324;5290.418054014132;5292;5375.3012108425655;5070.41690205631;5077.619178561697;5103.617228707936;5115.462876397924;5134.383873935151;5100.311457953128;5120.359955005624;5135.614828887923;5149.150390185578;5174.4566820484815;4881.90236195267;4993.975030124971;5034.874128146826;5037.471065538212;5050.166722490895;5069.239614057921;5094.541491265803;5098.490150984871;5099.745012749274;5110.540051395392;4887.804487820589;5008.87477813043;5012.598992080698;5030.899382012412;5030.974845125751 18:46:05 INFO - PROCESS | 25336 | |5;yui.html;646.8318237258313;656.5273003437526;714.2678754276869;722.3967986731079;768.8270139218674;12024.338661373631;13396;13822.585322440318;13864.09883357581;13892.861071389283;12210.084243681715;12243.938780306109;12248;12257.325847078408;12264.264144151335;618.8545691762432;759.4721668440436;787.2442455242974;788.3220430429826;790.8971833661616;762.5196126440335;767.1561282589163;770.1374460604103;770.445279398832;770.8458308338355;652.438902543812;833.8540755367817;836.456303402787;837.8031162676766;837.9455335403179;808.3977436809556;831.3100126894662;831.7587899509135;833.4957350802798;834.2700137379793;612.8559788449711;613.3314686991201;613.6594190224424;614.5636598015415;614.8678034222619;13105.14816536922;13134.60596182116;13193.538226162134;13219.20684758908;13240.20558766477;12606.235127082216;12858.421371038326;13005.86994130056;13010.934945325213;13132.409041593151;11089.05743011845;11147.554097836077;11424.543018279259;11462.312261264351;11622.883771162265;4093.774842383668;4135.937960930589;4180.456540649727;4182.163567286555;4280.4221430106845;58556.70721646407;58604.70697646527;58626.41373586252;58629;58736.706316468146;10008.949955250322;10110.69667909964;10181.389116653025;10730.731731706614;10762.46187690628;18679.346222882134;18738.344157954405;18820.905895470434;18822.341218057303;18837.05814709259;6497.057926600616;6535.575187612885;6538.673066346663;6541.443977261986;6544.345565443417;3369.309291595217;3428.6571342866014;3472.3055388922317;3581.8746343877838;3581.964180358163;2560.884760185796;2648.11288218449;2651.2178907222415;2651.9337016574354;2652.071774878777;456.7533531892807;466.02833093000794;486.23418116466706;498.95758860497267;534.6498043781329;418.52288391234015;420.53740885026224;435.8627032484757;444.7820567921695;535.1651423778917;7723.613819309012;7868.44920855546;7934.920650793533;7988.201179882081;8102.51384916895;483.5188986957999;500.9373828271466;526.3289306134633;528.1997773373342;534.671177226011;3787.4318852172396;3875.2249550090096;3917.843286268517;3929.9017524562114;3978.781167035783;103167.48416257871;103523;104164;105107;105575.47212264044;88229.55885220533;89722;89987.55006224927;90241;90537.54731226302;47198;47342;59203.70398148068;69672.65163674149;82504;6893.827654308682;6912.93087069143;6949.930500694928;6994.825129371807;7271.41828653717;45987.54012459832;46431.303530447745;47003.52996470128;48029;48204;59547;67266.66366668136;68321.65839170772;68756.65621671859;70862.64568677124;9381.718548443558;9639.9036009639;9661.855072173783;9814.75463113428;9962.302638815214;9801;9857.704268871945;10018.448985305879;10234.130098941674;10327.070563649308;8014.19858014194;9819.312648114563;9821.36161149523;10860;11087.944560277147;11370.94314528422;11914.225575337576;12001.1599188056;12026.75946481048;12506.749865002466;11098.722531936766;11169.888301116885;11627.767444651228;11777.411129443664;11951.342676152895;10077;10232.53953572106;10468.947655261674;10633.8936610636;10742.516586753458;10459.947700261755;10532.684019479428;10586.153107751516;10639.414832184304;10844.295120817122 18:46:05 INFO - PROCESS | 25336 | __end_tp_report 18:46:05 INFO - PROCESS | 25336 | __start_cc_report 18:46:05 INFO - PROCESS | 25336 | _x_x_mozilla_cycle_collect,853 18:46:05 INFO - PROCESS | 25336 | __end_cc_report 18:46:05 INFO - PROCESS | 25336 | __startTimestamp1466127965762__endTimestamp 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | ------- Summary: start ------- 18:46:05 INFO - PROCESS | 25336 | Number of tests: 6 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#0] dojo.html Cycles:165 Average:4787.21 Median:4899.98 stddev:517.27 (10.6%) stddev-sans-first:490.98 18:46:05 INFO - PROCESS | 25336 | Values: 2652.0 2663.9 2695.1 2702.5 2709.9 4665.4 4736.0 4775.6 4843.2 4884.5 4722.6 4774.6 4779.9 4788.9 4801.0 4311.1 4408.6 4435.5 4458.5 4612.1 4456.6 4500.1 4506.4 4510.3 4552.9 4344.1 4372.1 4374.8 4392.3 4445.2 4311.4 4325.2 4330.3 4370.6 4385.4 4339.7 4345.4 4376.2 4381.0 4387.6 4699.6 4761.4 4776.3 4788.4 4833.7 5214.9 5268.2 5281.8 5283.3 5288.8 5294.2 5311.0 5329.0 5334.0 5339.4 4756.4 4788.4 4825.4 4832.7 4933.5 5299.9 5309.8 5316.6 5377.6 5385.7 5106.3 5114.3 5150.6 5167.5 5172.3 5019.4 5132.7 5133.5 5169.1 5262.3 5153.8 5158.1 5159.0 5159.4 5176.2 5120.4 5131.5 5131.8 5133.8 5181.7 4332.6 4370.8 4378.5 4435.3 4444.5 3872.3 3891.2 3912.1 3912.6 3913.4 4399.6 4421.5 4422.2 4427.0 4429.3 5219.0 5222.8 5226.2 5231.2 5271.6 4418.8 4461.0 4461.9 4496.0 4511.3 4514.2 4646.5 4690.5 4692.8 4709.8 4890.5 4899.3 4900.0 4902.8 4948.4 5226.3 5229.3 5237.5 5240.0 5245.7 4728.0 4829.3 4830.6 4856.2 4878.2 5084.9 5111.5 5112.8 5114.5 5161.1 5049.3 5187.6 5196.3 5197.5 5203.8 5015.9 5038.4 5072.5 5073.1 5092.2 5071.1 5075.1 5081.9 5086.7 5132.5 4882.3 4932.4 5004.5 5024.7 5065.4 5059.7 5086.4 5109.2 5120.9 5160.8 4997.7 5012.9 5015.8 5017.9 5069.7 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#1] ext.html Cycles:180 Average:44984.09 Median:35504.32 stddev:81208.16 (228.7%) stddev-sans-first:81367.46 18:46:05 INFO - PROCESS | 25336 | Values: 555.6 576.2 578.2 581.4 597.9 26893.7 39962.8 41005.9 41057.4 44401.8 41434.8 41838.6 41854.4 42152.8 42278.0 7881.3 7908.6 8013.2 8016.8 8022.4 7800.7 7916.8 7919.2 7921.3 7921.6 7889.3 7936.4 7937.2 7944.3 7945.2 7864.8 7919.5 7929.2 7960.4 7962.4 7934.3 7995.7 8013.9 8014.3 8021.2 38990.0 39174.4 39258.0 39260.2 39273.9 3072.3 3253.7 3267.0 3466.6 3736.7 29514.7 29691.1 29967.3 30608.2 31056.4 3277.9 3452.8 3531.6 3542.1 3564.3 211334.0 266043.0 266848.0 267027.0 267696.0 30578.0 32859.7 54176.0 54854.7 54857.2 33760.8 33791.5 33865.8 33919.5 33957.2 13061.2 13083.2 13183.5 13271.4 13307.4 10635.2 10871.8 10876.8 10878.6 10881.4 7788.4 7904.0 7904.4 7971.9 7992.4 3118.8 3145.7 3151.8 3189.1 3190.4 888.1 943.5 956.7 981.2 1007.4 27125.5 28081.6 28289.6 28431.4 28590.1 989.9 1000.3 1002.2 1066.3 1071.4 14176.3 14713.4 14735.3 14880.9 14984.6 382420.0 385653.0 386567.0 386738.0 387283.0 49745.8 50143.0 50154.2 50220.7 50304.7 1067.4 1155.2 1194.6 1203.3 1212.3 28357.3 29395.3 29550.3 29796.9 29978.0 42200.0 42864.0 42943.8 42990.4 43008.1 257396.0 265949.0 266160.0 267208.0 268205.0 22242.0 23726.4 24055.4 24570.3 25713.5 40504.4 41064.4 41298.6 41440.8 42377.4 35483.8 36609.8 37146.3 37374.3 37431.8 35157.1 35366.8 35392.8 35631.0 35723.5 35444.3 35524.8 35929.6 36733.3 36881.1 31580.2 33382.5 33768.0 33973.5 34189.0 25305.4 25980.9 26035.2 26352.0 26471.0 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#2] jquery.html Cycles:180 Average:23901.24 Median:4548.55 stddev:64432.79 (1416.6%) stddev-sans-first:64589.32 18:46:05 INFO - PROCESS | 25336 | Values: 372.4 376.5 383.6 385.1 388.8 15780.7 16538.7 17362.9 17516.9 17566.6 11211.3 16572.3 17229.2 17449.6 17468.5 4600.2 4799.7 4835.1 4836.6 4837.1 3382.1 3611.1 5169.1 5454.0 5473.3 5516.9 5523.8 5534.6 5546.1 5548.1 5307.8 5616.5 5620.3 5622.2 5625.4 3312.5 5006.5 5324.5 5332.8 5430.1 12673.4 12696.7 12737.6 15072.7 21090.7 1884.5 1938.3 2046.2 2392.8 2447.5 9208.4 9282.5 9375.5 9713.5 9813.3 1665.6 1772.7 1779.8 1789.6 1810.4 45730.5 69662.3 69672.7 70782.6 71860.3 10056.9 10210.0 10267.4 10365.2 10476.9 14242.0 14305.9 14358.4 14376.8 14404.9 6863.6 7052.8 7124.5 7145.3 7160.8 6566.1 6612.6 6700.8 6770.9 6805.8 4382.3 4448.6 4525.5 4571.6 4619.5 1676.4 1688.1 1787.4 1811.6 1833.8 788.3 896.2 909.9 915.7 929.8 16417.0 16655.6 16725.7 16795.7 17168.0 839.1 849.6 850.3 873.7 898.1 9097.4 9561.6 9614.8 9647.9 9719.1 382356.0 389649.0 391459.0 392939.0 393895.0 77539.0 78992.0 79196.2 81472.6 81880.0 885.0 898.1 913.2 916.3 926.5 14679.4 15051.2 15151.9 15218.7 15284.2 34106.0 34327.7 34985.7 35430.5 36126.1 45746.5 47919.0 49515.3 49711.0 49786.5 7499.9 7510.1 7565.4 7641.8 7693.3 10760.7 11132.7 11719.8 11847.3 11871.3 9953.7 9957.7 10047.3 10205.7 10491.9 10000.2 10100.8 10130.2 10189.3 10197.5 10118.3 10202.0 10207.1 10242.9 10325.2 6761.7 7503.6 7506.2 7518.4 7974.2 5184.1 9115.0 9698.9 10055.3 10600.6 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#3] mootools.html Cycles:180 Average:5187.60 Median:5465.22 stddev:2945.27 (53.9%) stddev-sans-first:2938.30 18:46:05 INFO - PROCESS | 25336 | Values: 1201.7 1383.3 1409.7 1468.7 1675.1 6737.9 7528.3 7776.7 7792.0 8149.6 7791.8 7891.1 7934.2 7935.6 7945.4 1920.4 2160.7 2216.9 2259.9 2261.2 2230.8 2250.9 2253.4 2254.9 2255.2 2175.7 2180.8 2254.3 2254.7 2257.6 1847.2 2077.4 2147.7 2165.4 2169.5 2192.0 2219.8 2221.3 2222.6 2224.3 7967.5 7971.1 7987.1 7999.1 8065.1 4396.0 4500.5 4533.1 4575.7 4578.0 2791.0 2816.7 2920.6 2925.1 2929.0 918.1 921.7 923.1 947.2 954.5 10992.3 11017.1 11022.4 11033.1 11038.2 4187.3 4275.1 4375.2 4379.9 4439.6 9167.0 9199.1 9258.4 9267.5 9274.8 4706.5 4707.0 4708.4 4710.0 4713.4 3652.6 4023.3 4118.9 4151.2 4224.5 3662.6 3726.0 3760.8 3794.1 3842.4 1201.6 1239.1 1244.8 1251.6 1254.3 655.7 800.1 805.9 814.6 816.1 5007.9 5014.2 5114.1 5236.0 5333.9 829.2 852.8 853.0 876.0 888.9 3287.3 3374.4 3428.1 3434.5 3447.9 9393.5 9823.0 9873.8 9906.3 9908.1 9023.1 9792.0 9794.9 9796.8 9805.8 7120.6 7327.5 7395.7 7402.9 7403.8 5419.5 5511.0 5589.6 5636.7 5709.9 8655.1 9284.4 9295.8 9300.4 9306.2 8989.0 9301.7 9315.9 9427.1 9429.8 5938.2 5974.9 6162.0 6993.4 7129.7 7475.7 7741.3 7742.8 7745.2 7784.5 6835.3 6941.7 6951.4 6970.5 7155.3 6904.7 6945.1 6966.3 7023.5 7034.2 5679.6 5906.3 5910.1 6042.6 6082.9 4513.3 4541.6 4568.0 4610.0 4648.4 4660.0 4665.6 4704.2 4731.1 4743.0 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#4] prototype.html Cycles:180 Average:4246.99 Median:4859.78 stddev:1223.32 (25.2%) stddev-sans-first:1190.22 18:46:05 INFO - PROCESS | 25336 | Values: 293.5 295.3 303.0 311.5 311.9 4747.2 4870.6 4905.3 4923.2 4951.9 4640.0 4810.3 4817.6 4836.9 4849.0 3832.9 3843.4 3886.5 3888.4 3896.4 3699.1 3737.0 3864.1 3913.1 3918.6 3823.3 3841.5 3848.9 3859.1 3862.7 3835.3 3845.2 3853.0 3861.9 3866.7 3415.5 3428.5 3435.0 3437.9 3438.7 4582.7 4695.5 4697.4 4705.2 4760.8 4306.5 4318.4 4350.4 4376.3 4376.9 5052.8 5074.5 5078.9 5091.8 5096.9 3577.9 3671.3 3680.7 3690.1 3702.0 5257.6 5288.9 5301.5 5311.7 5339.0 3776.8 3787.4 3814.4 3814.6 3815.0 3731.7 3833.0 3853.4 3865.9 3876.8 4286.8 4304.1 4324.2 4333.0 4341.6 5076.0 5082.6 5094.5 5101.5 5121.9 1222.9 1242.0 1249.2 1252.1 1255.2 851.3 919.5 928.3 930.5 935.8 4411.4 4418.3 4430.8 4433.8 4446.8 5216.3 5237.5 5237.9 5252.2 5260.4 4303.5 4435.9 4451.8 4452.5 4547.9 2778.4 2783.6 2805.6 2812.8 2829.5 4920.3 4951.4 4976.8 4980.9 5015.5 5106.0 5390.6 5408.4 5435.9 5447.8 4914.9 4934.0 4934.4 4944.3 4951.7 5253.7 5273.2 5274.8 5284.6 5285.2 4896.9 5128.2 5133.5 5177.7 5203.2 4896.2 4924.2 4931.8 4939.6 4951.6 3662.5 3703.7 3710.3 3740.1 3743.3 5216.2 5278.9 5290.4 5292.0 5375.3 5070.4 5077.6 5103.6 5115.5 5134.4 5100.3 5120.4 5135.6 5149.2 5174.5 4881.9 4994.0 5034.9 5037.5 5050.2 5069.2 5094.5 5098.5 5099.7 5110.5 4887.8 5008.9 5012.6 5030.9 5031.0 18:46:05 INFO - PROCESS | 25336 | 18:46:05 INFO - PROCESS | 25336 | [#5] yui.html Cycles:180 Average:17665.01 Median:46209.42 stddev:25917.77 (56.1%) stddev-sans-first:25958.98 18:46:05 INFO - PROCESS | 25336 | Values: 646.8 656.5 714.3 722.4 768.8 12024.3 13396.0 13822.6 13864.1 13892.9 12210.1 12243.9 12248.0 12257.3 12264.3 618.9 759.5 787.2 788.3 790.9 762.5 767.2 770.1 770.4 770.8 652.4 833.9 836.5 837.8 837.9 808.4 831.3 831.8 833.5 834.3 612.9 613.3 613.7 614.6 614.9 13105.1 13134.6 13193.5 13219.2 13240.2 12606.2 12858.4 13005.9 13010.9 13132.4 11089.1 11147.6 11424.5 11462.3 11622.9 4093.8 4135.9 4180.5 4182.2 4280.4 58556.7 58604.7 58626.4 58629.0 58736.7 10008.9 10110.7 10181.4 10730.7 10762.5 18679.3 18738.3 18820.9 18822.3 18837.1 6497.1 6535.6 6538.7 6541.4 6544.3 3369.3 3428.7 3472.3 3581.9 3582.0 2560.9 2648.1 2651.2 2651.9 2652.1 456.8 466.0 486.2 499.0 534.6 418.5 420.5 435.9 444.8 535.2 7723.6 7868.4 7934.9 7988.2 8102.5 483.5 500.9 526.3 528.2 534.7 3787.4 3875.2 3917.8 3929.9 3978.8 103167.5 103523.0 104164.0 105107.0 105575.5 88229.6 89722.0 89987.6 90241.0 90537.5 47198.0 47342.0 59203.7 69672.7 82504.0 6893.8 6912.9 6949.9 6994.8 7271.4 45987.5 46431.3 47003.5 48029.0 48204.0 59547.0 67266.7 68321.7 68756.7 70862.6 9381.7 9639.9 9661.9 9814.8 9962.3 9801.0 9857.7 10018.4 10234.1 10327.1 8014.2 9819.3 9821.4 10860.0 11087.9 11370.9 11914.2 12001.2 12026.8 12506.7 11098.7 11169.9 11627.8 11777.4 11951.3 10077.0 10232.5 10468.9 10633.9 10742.5 10459.9 10532.7 10586.2 10639.4 10844.3 18:46:05 INFO - PROCESS | 25336 | -------- Summary: end -------- 18:46:05 INFO - PROCESS | 25336 | 18:46:06 INFO - TEST-INFO | 25336: exit 0 18:46:06 INFO - TEST-OK | dromaeo_css | took 1120805ms 18:46:06 INFO - TEST-START | kraken 18:46:06 INFO - operating with platform_type : linux_ 18:46:06 INFO - Initialising browser for kraken test... 18:46:06 INFO - TEST-INFO | started process 25519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGF8QJ/profile http://localhost:36553/getInfo.html) 18:46:10 INFO - PROCESS | 25519 | __metrics Screen width/height:1600/1200 18:46:10 INFO - PROCESS | 25519 | colorDepth:24 18:46:10 INFO - PROCESS | 25519 | Browser inner width/height: 1024/697 18:46:10 INFO - PROCESS | 25519 | __metrics 18:46:11 INFO - PROCESS | 25519 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:46:12 INFO - TEST-INFO | 25519: exit 0 18:46:12 INFO - Browser initialized. 18:46:12 INFO - Running cycle 1/1 for kraken test... 18:46:12 INFO - TEST-INFO | started process 25603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGF8QJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:24 INFO - PROCESS | 25603 | RSS: Main: 176234496 18:46:24 INFO - PROCESS | 25603 | 18:46:27 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36553/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:28 INFO - PROCESS | 25603 | RSS: Main: 234213376 18:46:28 INFO - PROCESS | 25603 | 18:46:31 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36553/tests/kraken/driver.html?testName=audio-dft) 18:46:31 INFO - PROCESS | 25603 | RSS: Main: 222154752 18:46:31 INFO - PROCESS | 25603 | 18:46:35 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36553/tests/kraken/driver.html?testName=audio-fft) 18:46:35 INFO - PROCESS | 25603 | RSS: Main: 288747520 18:46:35 INFO - PROCESS | 25603 | 18:46:37 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36553/tests/kraken/driver.html?testName=audio-oscillator) 18:46:38 INFO - PROCESS | 25603 | RSS: Main: 199237632 18:46:38 INFO - PROCESS | 25603 | 18:46:40 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:41 INFO - PROCESS | 25603 | RSS: Main: 203149312 18:46:41 INFO - PROCESS | 25603 | 18:46:44 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36553/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:45 INFO - PROCESS | 25603 | RSS: Main: 239570944 18:46:45 INFO - PROCESS | 25603 | 18:46:48 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36553/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:49 INFO - PROCESS | 25603 | RSS: Main: 235171840 18:46:49 INFO - PROCESS | 25603 | 18:46:52 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36553/tests/kraken/driver.html?testName=json-parse-financial) 18:46:52 INFO - PROCESS | 25603 | RSS: Main: 237854720 18:46:52 INFO - PROCESS | 25603 | 18:46:54 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:55 INFO - PROCESS | 25603 | RSS: Main: 226652160 18:46:55 INFO - PROCESS | 25603 | 18:46:57 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:57 INFO - PROCESS | 25603 | RSS: Main: 232710144 18:46:57 INFO - PROCESS | 25603 | 18:46:59 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:47:00 INFO - PROCESS | 25603 | RSS: Main: 237268992 18:47:00 INFO - PROCESS | 25603 | 18:47:03 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:47:03 INFO - PROCESS | 25603 | RSS: Main: 240070656 18:47:03 INFO - PROCESS | 25603 | 18:47:06 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:47:07 INFO - PROCESS | 25603 | RSS: Main: 238837760 18:47:07 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | Cycle 1(1): loaded http://localhost:36553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36553/tests/kraken/driver.html?testName=ai-astar) 18:47:09 INFO - PROCESS | 25603 | RSS: Main: 281231360 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | __start_tp_report 18:47:09 INFO - PROCESS | 25603 | _x_x_mozilla_page_load 18:47:09 INFO - PROCESS | 25603 | _x_x_mozilla_page_load_details 18:47:09 INFO - PROCESS | 25603 | |i|pagename|runs| 18:47:09 INFO - PROCESS | 25603 | |0;ai-astar;114;108;113;113;112;111;112;113;113;112 18:47:09 INFO - PROCESS | 25603 | |1;audio-beat-detection;159;134;132;186;134;131;160;132;211;131 18:47:09 INFO - PROCESS | 25603 | |2;audio-dft;161;162;162;161;162;161;162;161;161;161 18:47:09 INFO - PROCESS | 25603 | |3;audio-fft;75;75;79;122;77;85;74;74;98;76 18:47:09 INFO - PROCESS | 25603 | |4;audio-oscillator;87;86;115;87;87;86;121;87;86;123 18:47:09 INFO - PROCESS | 25603 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 18:47:09 INFO - PROCESS | 25603 | |6;imaging-darkroom;146;146;147;147;147;146;146;146;146;146 18:47:09 INFO - PROCESS | 25603 | |7;imaging-desaturate;95;95;95;94;95;96;95;96;95;95 18:47:09 INFO - PROCESS | 25603 | |8;json-parse-financial;65;64;65;65;64;65;64;75;64;62 18:47:09 INFO - PROCESS | 25603 | |9;json-stringify-tinderbox;64;65;64;65;65;65;66;65;65;66 18:47:09 INFO - PROCESS | 25603 | |10;stanford-crypto-aes;83;83;83;84;85;84;84;84;117;90 18:47:09 INFO - PROCESS | 25603 | |11;stanford-crypto-ccm;133;134;140;135;135;132;131;134;140;150 18:47:09 INFO - PROCESS | 25603 | |12;stanford-crypto-pbkdf2;178;179;171;176;180;180;174;171;170;168 18:47:09 INFO - PROCESS | 25603 | |13;stanford-crypto-sha256-iterative;69;67;68;67;68;67;68;67;67;68 18:47:09 INFO - PROCESS | 25603 | __end_tp_report 18:47:09 INFO - PROCESS | 25603 | __start_cc_report 18:47:09 INFO - PROCESS | 25603 | _x_x_mozilla_cycle_collect,1884 18:47:09 INFO - PROCESS | 25603 | __end_cc_report 18:47:09 INFO - PROCESS | 25603 | __startTimestamp1466128029491__endTimestamp 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | ------- Summary: start ------- 18:47:09 INFO - PROCESS | 25603 | Number of tests: 14 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:1.66 (1.5%) stddev-sans-first:1.62 18:47:09 INFO - PROCESS | 25603 | Values: 114.0 108.0 113.0 113.0 112.0 111.0 112.0 113.0 113.0 112.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:146.50 stddev:28.03 (19.1%) stddev-sans-first:29.58 18:47:09 INFO - PROCESS | 25603 | Values: 159.0 134.0 132.0 186.0 134.0 131.0 160.0 132.0 211.0 131.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 18:47:09 INFO - PROCESS | 25603 | Values: 161.0 162.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:15.41 (20.1%) stddev-sans-first:16.04 18:47:09 INFO - PROCESS | 25603 | Values: 75.0 75.0 79.0 122.0 77.0 85.0 74.0 74.0 98.0 76.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.50 stddev:16.11 (18.6%) stddev-sans-first:16.72 18:47:09 INFO - PROCESS | 25603 | Values: 87.0 86.0 115.0 87.0 87.0 86.0 121.0 87.0 86.0 123.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:47:09 INFO - PROCESS | 25603 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 18:47:09 INFO - PROCESS | 25603 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:47:09 INFO - PROCESS | 25603 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 95.0 96.0 95.0 95.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:3.53 (5.4%) stddev-sans-first:3.74 18:47:09 INFO - PROCESS | 25603 | Values: 65.0 64.0 65.0 65.0 64.0 65.0 64.0 75.0 64.0 62.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 18:47:09 INFO - PROCESS | 25603 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.00 stddev:10.50 (12.5%) stddev-sans-first:11.00 18:47:09 INFO - PROCESS | 25603 | Values: 83.0 83.0 83.0 84.0 85.0 84.0 84.0 84.0 117.0 90.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:135.00 stddev:5.64 (4.2%) stddev-sans-first:5.85 18:47:09 INFO - PROCESS | 25603 | Values: 133.0 134.0 140.0 135.0 135.0 132.0 131.0 134.0 140.0 150.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:177.00 stddev:4.50 (2.5%) stddev-sans-first:4.61 18:47:09 INFO - PROCESS | 25603 | Values: 178.0 179.0 171.0 176.0 180.0 180.0 174.0 171.0 170.0 168.0 18:47:09 INFO - PROCESS | 25603 | 18:47:09 INFO - PROCESS | 25603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 18:47:09 INFO - PROCESS | 25603 | Values: 69.0 67.0 68.0 67.0 68.0 67.0 68.0 67.0 67.0 68.0 18:47:09 INFO - PROCESS | 25603 | -------- Summary: end -------- 18:47:09 INFO - PROCESS | 25603 | 18:47:10 INFO - TEST-INFO | 25603: exit 0 18:47:10 INFO - TEST-OK | kraken | took 64069ms 18:47:10 INFO - SUITE-END | took 1184s 18:47:10 INFO - Completed test suite (00:19:44) 18:47:10 INFO - javascript benchmark 18:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.9734802651974, 2663.8934442622294, 2695.110613497546, 2702.540568103422, 2709.8916043358267, 4665.440147182335, 4736.0, 4775.594074503667, 4843.200871856144, 4884.511548845114, 4722.64580156488, 4774.618030557555, 4779.90440191196, 4788.928166077511, 4800.967791924744, 4311.051568654891, 4408.581184787457, 4435.534268901751, 4458.4872739634875, 4612.0545288215835, 4456.59890609845, 4500.0549884524125, 4506.414166158411, 4510.278355463127, 4552.8634140975655, 4344.087741574242, 4372.1255748850035, 4374.825006999748, 4392.275274579691, 4445.199864024475, 4311.396404503372, 4325.178216138924, 4330.328799036123, 4370.628496577795, 4385.3641222022625, 4339.739615623042, 4345.435093437864, 4376.212281789277, 4380.956190438119, 4387.648988080946, 4699.624030077585, 4761.428628564595, 4776.331313616097, 4788.353572267769, 4833.661643684944, 5214.921776173361, 5268.1834315681135, 5281.788728450896, 5283.313169288006, 5288.762005709752, 5294.205869119624, 5311.0, 5329.0, 5333.986542556901, 5339.41266460689, 4756.405449318835, 4788.377510923628, 4825.445073816486, 4832.685875418087, 4933.45731969483, 5299.920501192485, 5309.840704778863, 5316.627836051517, 5377.623566350396, 5385.703786291791, 5106.259592359087, 5114.33513643224, 5150.639455238173, 5167.509086636764, 5172.301739265151, 5019.372578427697, 5132.692038477703, 5133.486651334912, 5169.095408303532, 5262.289590905255, 5153.819616313486, 5158.071547121479, 5158.97420512895, 5159.355080614923, 5176.171812510056, 5120.436751957282, 5131.512506311969, 5131.794728210904, 5133.7689803958165, 5181.663191892515, 4332.610065094157, 4370.781460926941, 4378.474583050054, 4435.268180750205, 4444.488883778342, 3872.2642697887313, 3891.1828516011956, 3912.0611053346993, 3912.56961734209, 3913.412988051815, 4399.604035636744, 4421.53573874745, 4422.181896349186, 4426.9778651106535, 4429.2913133899065, 5218.9739051304505, 5222.843314700565, 5226.189940559143, 5231.163013917831, 5271.6309858310315, 4418.8453404130705, 4460.977695111504, 4461.866144015685, 4495.977520112444, 4511.255642818964, 4514.232580461264, 4646.4888862225125, 4690.507496712796, 4692.7653617319, 4709.811607535728, 4890.462049174588, 4899.314096026488, 4899.975500122477, 4902.828401005948, 4948.38145231846, 5226.294450249167, 5229.320188375486, 5237.528622424, 5239.973800130975, 5245.7114858683135, 4727.976360118178, 4829.323894654681, 4830.637702172281, 4856.150173719656, 4878.195097808822, 5084.898302034013, 5111.539961403491, 5112.795488180431, 5114.514121158484, 5161.148410512374, 5049.34358533403, 5187.610929180402, 5196.298499702643, 5197.480251974924, 5203.843884683465, 5015.899682006267, 5038.445770965264, 5072.492750724898, 5073.061483625541, 5092.159793634157, 5071.0872043032605, 5075.11185542536, 5081.898362032813, 5086.669366491166, 5132.486751324837, 4882.267659851051, 4932.383452068491, 5004.47453017428, 5024.673396229234, 5065.392152941523, 5059.721715305694, 5086.440491546001, 5109.20807274873, 5120.897582048413, 5160.845174644766, 4997.725125118153, 5012.899742005066, 5015.774290156879, 5017.899642007213, 5069.670471419346], "value": 4753.392409068861, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.571743543421, 576.2278546747358, 578.1530058464349, 581.4389114504502, 597.8505373656584, 26893.731062689367, 39962.80018599907, 41005.9245556583, 41057.384139237896, 44401.77799111008, 41434.79282603583, 41838.58161418385, 41854.37218441726, 42152.78923605385, 42278.0, 7881.330086942617, 7908.644111014989, 8013.198680131998, 8016.759497215093, 8022.358211343078, 7800.687972481122, 7916.762497125067, 7919.24767147123, 7921.326687231593, 7921.603919804015, 7889.250521200477, 7936.404769642271, 7937.206279372045, 7944.324732397724, 7945.165757595427, 7864.764057078297, 7919.524828510308, 7929.167437419045, 7960.363170946368, 7962.402819788481, 7934.3255823255095, 7995.68017279314, 8013.879791803128, 8014.278714915686, 8021.2379823916635, 38990.0, 39174.41238381426, 39258.03709814498, 39260.21479570393, 39273.87624299436, 3072.2780146665514, 3253.723433508155, 3267.0362243138093, 3466.584009918801, 3736.7197460190323, 29514.70485295141, 29691.109266722033, 29967.250818729706, 30608.2347941301, 31056.378872422425, 3277.918052048694, 3452.7928324300624, 3531.646835316448, 3542.096765324826, 3564.28714257147, 211334.0, 266043.0, 266848.0, 267026.9999999981, 267696.0, 30578.0, 32859.67140328614, 54176.0, 54854.725726371114, 54857.177142342895, 33760.831195843864, 33791.493127603106, 33865.83067084649, 33919.49120763191, 33957.151071223416, 13061.21632702041, 13083.215007099605, 13183.53857614998, 13271.402786874614, 13307.401166947317, 10635.20235982289, 10871.782564348669, 10876.782464350668, 10878.61924832643, 10881.401522916158, 7788.376929845712, 7903.960480197562, 7904.446688731849, 7971.880421793678, 7992.40056995716, 3118.828464434478, 3145.6697046809754, 3151.795133316327, 3189.059227527885, 3190.3938251732097, 888.0630934364308, 943.4999450291357, 956.7082039977873, 981.2346369831542, 1007.4005966449951, 27125.457490850073, 28081.578776318373, 28289.57565636517, 28431.43137137287, 28590.142295731162, 989.8515222716507, 1000.2698030437675, 1002.1932344462632, 1066.290916540492, 1071.4482041748506, 14176.291185440687, 14713.411463541339, 14735.263236838115, 14880.92559537217, 14984.62538436526, 382420.0, 385653.0, 386567.0, 386738.0, 387283.0, 49745.75127124414, 50143.0, 50154.24768628473, 50220.74889625528, 50304.748476258115, 1067.423591260726, 1155.2375432214699, 1194.6177223288464, 1203.3080978437433, 1212.2908098762323, 28357.291067723472, 29395.265118372212, 29550.261243469085, 29796.85101574478, 29978.0, 42200.0, 42864.0, 42943.78528107465, 42990.35514467223, 43008.13983720371, 257396.0, 265949.0, 266160.0, 267208.0, 268205.0, 22242.0, 23726.406839829142, 24055.40370320619, 24570.262892113264, 25713.485730285665, 40504.392434112924, 41064.38403424011, 41298.58701412947, 41440.79279603583, 42377.36433953555, 35483.82258088693, 36609.81695091614, 37146.25707485889, 37374.252514950094, 37431.81284093562, 35157.12107197341, 35366.82316588401, 35392.82303588569, 35631.0, 35723.46414803728, 35444.29111417705, 35524.822375887954, 35929.64070359263, 36733.26533469369, 36881.07797305089, 31580.210494737814, 33382.49926251157, 33768.0, 33973.49039764455, 34189.0, 25305.367365816, 25980.8700956494, 26035.218943431726, 26352.0, 26471.0], "value": 16526.533327967776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.4022943176202, 376.5274580401597, 383.560822857828, 385.12000079817585, 388.7667399560264, 15780.684386312267, 16538.669226615475, 17362.91318543409, 17516.912415437906, 17566.648667026668, 11211.271267367616, 16572.254248558813, 17229.164811461702, 17449.563760905985, 17468.475945721617, 4600.217962946299, 4799.664023518355, 4835.05716385305, 4836.613070954315, 4837.0567739290855, 3382.1037425082372, 3611.133328001274, 5169.147090730025, 5454.045542030129, 5473.31583552056, 5516.862078448031, 5523.7790488380415, 5534.612577119583, 5546.140348246008, 5548.140038294051, 5307.761150748225, 5616.494515493625, 5620.297462817169, 5622.184783206412, 5625.353084395286, 3312.453445181542, 5006.499350065001, 5324.547413469821, 5332.760025798849, 5430.13117901134, 12673.366331683379, 12696.746065078647, 12737.617871463779, 15072.698546029127, 21090.683639745264, 1884.5382881194057, 1938.2731475696614, 2046.1508473983429, 2392.83250172488, 2447.5104979004273, 9208.401453905475, 9282.535873206312, 9375.53122343887, 9713.514324283828, 9813.264005199568, 1665.608581983233, 1772.7075032619603, 1779.7953235377838, 1789.642071585675, 1810.411616224719, 45730.54269457296, 69662.30337696659, 69672.651636742, 70782.64608676975, 71860.28139718588, 10056.899431005742, 10210.0, 10267.383956962607, 10365.222608304408, 10476.947615262028, 14242.0, 14305.85694143066, 14358.353874075692, 14376.784348234785, 14404.927975360057, 6863.622500762506, 7052.823679408056, 7124.536905101152, 7145.285471452917, 7160.820979475555, 6566.146400967844, 6612.603243805387, 6700.83247918806, 6770.8645827084165, 6805.761798337035, 4382.276924307454, 4448.55514448559, 4525.456945166601, 4571.634269258451, 4619.514950930171, 1676.3713607397226, 1688.1474855198046, 1787.4012205911165, 1811.6467288878805, 1833.834954854043, 788.3496115704452, 896.1755185229605, 909.9135582119688, 915.6657819895823, 929.8047410043966, 16417.0, 16655.583610409594, 16725.6654866902, 16795.664086718196, 17168.0, 839.0602525171846, 849.6389034660368, 850.3324889961351, 873.6505397840914, 898.1377877237794, 9097.363184577016, 9561.61753529851, 9614.807703845883, 9647.886620091364, 9719.125278724949, 382356.0, 389649.0, 391459.0, 392939.0, 393895.0, 77539.0, 78992.0, 79196.20803791888, 81472.59263703643, 81880.0, 885.0, 898.1198425543005, 913.2055112052557, 916.2578311567519, 926.536731634183, 14679.366474704406, 15051.247437628293, 15151.924240378728, 15218.706409954835, 15284.159371234244, 34106.0, 34327.65672343245, 34985.65014349824, 35430.46854297136, 36126.09684757902, 45746.542534574226, 47919.0, 49515.25727114168, 49711.0, 49786.50213497819, 7499.850003000019, 7510.061242344707, 7565.4325925556905, 7641.7707468776025, 7693.345930624942, 10760.677179684622, 11132.666020019413, 11719.824202636797, 11847.348395838311, 11871.347075910908, 9953.701388958054, 9957.701268961942, 10047.346922450017, 10205.693829185137, 10491.895081049091, 10000.24998125129, 10100.84848727255, 10130.240231982778, 10189.286749927434, 10197.541110650187, 10118.342307749972, 10202.030807073315, 10207.132393746615, 10242.897571024194, 10325.225608079274, 6761.661916904233, 7503.624818758931, 7506.24937506245, 7518.360939320219, 7974.162712915292, 5184.066867963803, 9115.0, 9698.9030109698, 10055.346402483816, 10600.628977985734], "value": 8020.868122795776, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.6575276046328, 1383.2599559235812, 1409.6546346145196, 1468.7282852672256, 1675.0870775427397, 6737.898931516025, 7528.284812942768, 7776.7278145265, 7791.961040194791, 8149.551774652392, 7791.805204869881, 7891.131975482693, 7934.166912474179, 7935.642896069677, 7945.364370850332, 1920.395075551197, 2160.708304378912, 2216.9113235470604, 2259.9322020339414, 2261.163369553268, 2230.832687548432, 2250.8987095580655, 2253.3690566641285, 2254.9098036078535, 2255.2444930948154, 2175.695402643631, 2180.7819218078225, 2254.289898681918, 2254.7407048189502, 2257.571061498318, 1847.1595424082077, 2077.366403247009, 2147.6778483227486, 2165.3936897668677, 2169.5227050048966, 2192.0, 2219.833512486554, 2221.2891874600136, 2222.5999320122373, 2224.2659922225625, 7967.521948683097, 7971.083325417593, 7987.081485629169, 7999.0801057877925, 8065.112837587861, 4395.9889225478, 4500.50494445614, 4533.116042371739, 4575.702579332333, 4577.9771101144615, 2790.9581356279673, 2816.7183281671873, 2920.561915712639, 2925.0786002409386, 2929.0480593807097, 918.1094338491653, 921.6589861751195, 923.054092157007, 947.1522986926731, 954.4941181173989, 10992.340459572371, 11017.11863050954, 11022.44887755609, 11033.117350611932, 11038.227324087316, 4187.283213882293, 4275.123599662124, 4375.212461756914, 4379.868603941887, 4439.556044395535, 9167.037461066626, 9199.080091990747, 9258.398204116711, 9267.490288034223, 9274.768130796649, 4706.458757242893, 4706.976465117653, 4708.364370809965, 4709.952900470951, 4713.3872596562915, 3652.634736526326, 4023.295923213426, 4118.949667834683, 4151.232022075926, 4224.4508213931995, 3662.5788034375855, 3726.0, 3760.793156376371, 3794.0704527390412, 3842.442845787345, 1201.645514573203, 1239.1449899569268, 1244.819501172343, 1251.5869762978195, 1254.2537190371713, 655.6623338980429, 800.1078797141262, 805.9274665280153, 814.645629151321, 816.1348970091722, 5007.899842003139, 5014.197728363444, 5114.130597798383, 5236.031334203185, 5333.866653333697, 829.1832544943226, 852.7868032991752, 852.9744107676779, 876.0363600039905, 888.9155530224618, 3287.293231955141, 3374.4263475209273, 3428.0915557377316, 3434.4676575130893, 3447.9482807757904, 9393.5303234838, 9822.950885245527, 9873.802523949624, 9906.257030722725, 9908.058734420218, 9023.097690231056, 9791.951040244896, 9794.853077203848, 9796.755081123029, 9805.754856128653, 7120.572765634079, 7327.45044121693, 7395.704171833174, 7402.925970740332, 7403.814904627319, 5419.458054194549, 5510.972445137749, 5589.5807814413265, 5636.746346414503, 5709.885802284014, 8655.134486551546, 9284.350095493252, 9295.76760580991, 9300.39547429415, 9306.208972237435, 8989.0, 9301.72094837156, 9315.906840931504, 9427.104425079606, 9429.811403772022, 5938.228030356199, 5974.880502389841, 6161.969190154021, 6993.370596646327, 7129.679164437509, 7475.738349157753, 7741.341985931033, 7742.806429839299, 7745.22547745221, 7784.494007889469, 6835.282295358916, 6941.687624056828, 6951.409130223988, 6970.546914450544, 7155.284471552803, 6904.723811047502, 6945.131858517685, 6966.303369662993, 7023.508354415142, 7034.226235114235, 5679.602427830012, 5906.26171728534, 5910.054391297372, 6042.637441753509, 6082.878342433215, 4513.345564893138, 4541.613962813066, 4567.977160114178, 4610.0, 4648.395708557866, 4659.953400465952, 4665.603423708887, 4704.153252414599, 4731.148393289103, 4743.027679325661], "value": 4158.274719801682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.53767815690287, 295.2780451795361, 303.0499384429813, 311.47516434807335, 311.91266445395286, 4747.192977193877, 4870.586000189988, 4905.3132561441425, 4923.212286034235, 4951.900961980758, 4639.976800115995, 4810.302506136617, 4817.566419022287, 4836.879078023051, 4848.97575512122, 3832.923341533168, 3843.444109667068, 3886.514185726784, 3888.4361767543687, 3896.357101078333, 3699.130704284491, 3737.0, 3864.1305706216017, 3913.0804260998643, 3918.6473217410426, 3823.3309170895122, 3841.4621952926614, 3848.8845334640005, 3859.1316953685337, 3862.671672907806, 3835.271298453285, 3845.1732877431486, 3852.9579322958875, 3861.9034524137123, 3866.729328946975, 3415.5389022481895, 3428.451447768345, 3434.9828250858836, 3437.9484307735406, 3438.6905178533802, 4582.725036497787, 4695.483496815347, 4697.436307643071, 4705.247160454345, 4760.785764640599, 4306.504751953503, 4318.4170137031415, 4350.390945267665, 4376.343548467724, 4376.89057773555, 5052.8484145475695, 5074.503021608634, 5078.898422031539, 5091.847244582668, 5096.898062038738, 3577.94633080504, 3671.3391589513876, 3680.723945704056, 3690.095926498025, 3701.9814900925594, 5257.579393648499, 5288.867778305535, 5301.496357845998, 5311.725185955343, 5338.97330513345, 3776.811159442017, 3787.394016957329, 3814.3515602347666, 3814.6376094271, 3814.961850381461, 3731.7312113880866, 3832.9808350958065, 3853.4412510185866, 3865.9226815463535, 3876.7867767272505, 4286.799696085039, 4304.139172165579, 4324.243257429937, 4332.978335108304, 4341.587549182886, 5076.0, 5082.567981721595, 5094.465081166498, 5101.464346243665, 5121.897562048738, 1222.9388530573435, 1242.0001898471637, 1249.2442072545978, 1252.067209928609, 1255.234307072685, 851.2976794144855, 919.4850883505259, 928.3269629518545, 930.50683137937, 935.8081593273363, 4411.360352748898, 4418.293073108287, 4430.825831154747, 4433.756143412079, 4446.822127114944, 5216.347956505437, 5237.450067742909, 5237.921431178535, 5252.1596544552685, 5260.395054568774, 4303.483581970184, 4435.866923992286, 4451.844185453494, 4452.510223875371, 4547.884698981208, 2778.4165325281515, 2783.5546312590295, 2805.5931889875856, 2812.7890408219464, 2829.462402143586, 4920.286558449005, 4951.430585482643, 4976.751162441863, 4980.850574482772, 5015.548600625962, 5106.0, 5390.5742415913, 5408.3509978802795, 5435.891282174334, 5447.809326673548, 4914.852554423302, 4934.0, 4934.358533390637, 4944.25836124577, 4951.678140920829, 5253.71104589236, 5273.209018647233, 5274.841754747364, 5284.603654725834, 5285.154375299933, 4896.90206195867, 5128.230765385222, 5133.486651334986, 5177.689338639693, 5203.19350500673, 4896.167651499325, 4924.153442459078, 4931.841017360845, 4939.580135688363, 4951.628627852998, 3662.4872517848057, 3703.685186759156, 3710.2764960833456, 3740.0836794984316, 3743.3074881147077, 5216.217567364925, 5278.868028299324, 5290.418054014132, 5292.0, 5375.3012108425655, 5070.41690205631, 5077.619178561697, 5103.617228707936, 5115.462876397924, 5134.383873935151, 5100.311457953128, 5120.359955005624, 5135.614828887923, 5149.150390185578, 5174.4566820484815, 4881.90236195267, 4993.975030124971, 5034.874128146826, 5037.471065538212, 5050.166722490895, 5069.239614057921, 5094.541491265803, 5098.490150984871, 5099.745012749274, 5110.540051395392, 4887.804487820589, 5008.87477813043, 5012.598992080698, 5030.899382012412, 5030.974845125751], "value": 3858.4314501778736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8318237258313, 656.5273003437526, 714.2678754276869, 722.3967986731079, 768.8270139218674, 12024.338661373631, 13396.0, 13822.585322440318, 13864.09883357581, 13892.861071389283, 12210.084243681715, 12243.938780306109, 12248.0, 12257.325847078408, 12264.264144151335, 618.8545691762432, 759.4721668440436, 787.2442455242974, 788.3220430429826, 790.8971833661616, 762.5196126440335, 767.1561282589163, 770.1374460604103, 770.445279398832, 770.8458308338355, 652.438902543812, 833.8540755367817, 836.456303402787, 837.8031162676766, 837.9455335403179, 808.3977436809556, 831.3100126894662, 831.7587899509135, 833.4957350802798, 834.2700137379793, 612.8559788449711, 613.3314686991201, 613.6594190224424, 614.5636598015415, 614.8678034222619, 13105.14816536922, 13134.60596182116, 13193.538226162134, 13219.20684758908, 13240.20558766477, 12606.235127082216, 12858.421371038326, 13005.86994130056, 13010.934945325213, 13132.409041593151, 11089.05743011845, 11147.554097836077, 11424.543018279259, 11462.312261264351, 11622.883771162265, 4093.774842383668, 4135.937960930589, 4180.456540649727, 4182.163567286555, 4280.4221430106845, 58556.70721646407, 58604.70697646527, 58626.41373586252, 58629.0, 58736.706316468146, 10008.949955250322, 10110.69667909964, 10181.389116653025, 10730.731731706614, 10762.46187690628, 18679.346222882134, 18738.344157954405, 18820.905895470434, 18822.341218057303, 18837.05814709259, 6497.057926600616, 6535.575187612885, 6538.673066346663, 6541.443977261986, 6544.345565443417, 3369.309291595217, 3428.6571342866014, 3472.3055388922317, 3581.8746343877838, 3581.964180358163, 2560.884760185796, 2648.11288218449, 2651.2178907222415, 2651.9337016574354, 2652.071774878777, 456.7533531892807, 466.02833093000794, 486.23418116466706, 498.95758860497267, 534.6498043781329, 418.52288391234015, 420.53740885026224, 435.8627032484757, 444.7820567921695, 535.1651423778917, 7723.613819309012, 7868.44920855546, 7934.920650793533, 7988.201179882081, 8102.51384916895, 483.5188986957999, 500.9373828271466, 526.3289306134633, 528.1997773373342, 534.671177226011, 3787.4318852172396, 3875.2249550090096, 3917.843286268517, 3929.9017524562114, 3978.781167035783, 103167.48416257871, 103523.0, 104164.0, 105107.0, 105575.47212264044, 88229.55885220533, 89722.0, 89987.55006224927, 90241.0, 90537.54731226302, 47198.0, 47342.0, 59203.70398148068, 69672.65163674149, 82504.0, 6893.827654308682, 6912.93087069143, 6949.930500694928, 6994.825129371807, 7271.41828653717, 45987.54012459832, 46431.303530447745, 47003.52996470128, 48029.0, 48204.0, 59547.0, 67266.66366668136, 68321.65839170772, 68756.65621671859, 70862.64568677124, 9381.718548443558, 9639.9036009639, 9661.855072173783, 9814.75463113428, 9962.302638815214, 9801.0, 9857.704268871945, 10018.448985305879, 10234.130098941674, 10327.070563649308, 8014.19858014194, 9819.312648114563, 9821.36161149523, 10860.0, 11087.944560277147, 11370.94314528422, 11914.225575337576, 12001.1599188056, 12026.75946481048, 12506.749865002466, 11098.722531936766, 11169.888301116885, 11627.767444651228, 11777.411129443664, 11951.342676152895, 10077.0, 10232.53953572106, 10468.947655261674, 10633.8936610636, 10742.516586753458, 10459.947700261755, 10532.684019479428, 10586.153107751516, 10639.414832184304, 10844.295120817122], "value": 6387.699266007443, "unit": "score"}], "name": "dromaeo_css", "value": 6334.12703180428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 113.0, 112.0, 111.0, 112.0, 113.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 132.0, 186.0, 134.0, 131.0, 160.0, 132.0, 211.0, 131.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 122.0, 77.0, 85.0, 74.0, 74.0, 98.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 115.0, 87.0, 87.0, 86.0, 121.0, 87.0, 86.0, 123.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 75.0, 64.0, 62.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 85.0, 84.0, 84.0, 84.0, 117.0, 90.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 140.0, 135.0, 135.0, 132.0, 131.0, 134.0, 140.0, 150.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 171.0, 176.0, 180.0, 180.0, 174.0, 171.0, 170.0, 168.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1559.4, "alertThreshold": 2.0}]} 18:47:10 INFO - Return code: 0 18:47:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:47:10 INFO - # TBPL SUCCESS # 18:47:10 INFO - Running post-action listener: _resource_record_post_action 18:47:10 INFO - ##### 18:47:10 INFO - ##### Finished run-tests step (success) 18:47:10 INFO - ##### 18:47:10 INFO - Running post-run listener: _resource_record_post_run 18:47:10 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532029440; Read time: 8; Write time: 455532 18:47:10 INFO - TinderboxPrint: CPU usage
13.1% 18:47:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:47:10 INFO - TinderboxPrint: I/O write bytes / time
532,029,440 / 455,532 18:47:10 INFO - TinderboxPrint: CPU idle
8,329.7 (86.8%) 18:47:10 INFO - TinderboxPrint: CPU user
1,216.1 (12.7%) 18:47:10 INFO - TinderboxPrint: Swap in / out
0 / 0 18:47:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245129216; Read time: 0; Write time: 281864 18:47:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286900224; Read time: 8; Write time: 173668 18:47:11 INFO - Running post-run listener: _upload_blobber_files 18:47:11 INFO - Blob upload gear active. 18:47:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:47:11 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 18:47:11 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'] 18:47:11 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 18:47:11 INFO - (blobuploader) - INFO - Open directory for files ... 18:47:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:47:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:12 INFO - (blobuploader) - INFO - Done attempting. 18:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:16 INFO - (blobuploader) - INFO - Done attempting. 18:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:16 INFO - (blobuploader) - INFO - Done attempting. 18:47:16 INFO - (blobuploader) - INFO - Iteration through files over. 18:47:16 INFO - Return code: 0 18:47:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:47:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:47:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fae8445fe3372f43147479bfcb072f96b9c9280d713a641513a5103fff501f59afddc5527934ec30f8ad65ff4c519c565b6fde8a5c54bf5efb3a0c9296a349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bc6e381cc9ad8239127fd00e8f5f919d86a5be8a0f8d71aff660998dbc0399ce8ee43bdb13c93594aaa17135ffd9a2e758f772b08e16c8179999aefb13caffa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b9a4de885ff38d203c4b0ea2afb81b0b3be54c8eecad1ae066a6d99d7a5d203f5c5e103222285f2cc48767423b61eeef8dc204a7654ef2eeb96fdca0428e2"} 18:47:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:47:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:47:16 INFO - Contents: 18:47:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fae8445fe3372f43147479bfcb072f96b9c9280d713a641513a5103fff501f59afddc5527934ec30f8ad65ff4c519c565b6fde8a5c54bf5efb3a0c9296a349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bc6e381cc9ad8239127fd00e8f5f919d86a5be8a0f8d71aff660998dbc0399ce8ee43bdb13c93594aaa17135ffd9a2e758f772b08e16c8179999aefb13caffa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b9a4de885ff38d203c4b0ea2afb81b0b3be54c8eecad1ae066a6d99d7a5d203f5c5e103222285f2cc48767423b61eeef8dc204a7654ef2eeb96fdca0428e2"} 18:47:16 INFO - Running post-run listener: copy_logs_to_upload_dir 18:47:16 INFO - Copying logs to upload dir... 18:47:16 INFO - mkdir: /builds/slave/test/build/upload/logs 18:47:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.346538 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-16 18:47:15.963159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:15.966989) ========= 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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 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/1fae8445fe3372f43147479bfcb072f96b9c9280d713a641513a5103fff501f59afddc5527934ec30f8ad65ff4c519c565b6fde8a5c54bf5efb3a0c9296a349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bc6e381cc9ad8239127fd00e8f5f919d86a5be8a0f8d71aff660998dbc0399ce8ee43bdb13c93594aaa17135ffd9a2e758f772b08e16c8179999aefb13caffa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b9a4de885ff38d203c4b0ea2afb81b0b3be54c8eecad1ae066a6d99d7a5d203f5c5e103222285f2cc48767423b61eeef8dc204a7654ef2eeb96fdca0428e2"} build_url:https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/GD0ntWAwQimRItXulKQV0w/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/1fae8445fe3372f43147479bfcb072f96b9c9280d713a641513a5103fff501f59afddc5527934ec30f8ad65ff4c519c565b6fde8a5c54bf5efb3a0c9296a349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bc6e381cc9ad8239127fd00e8f5f919d86a5be8a0f8d71aff660998dbc0399ce8ee43bdb13c93594aaa17135ffd9a2e758f772b08e16c8179999aefb13caffa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b9a4de885ff38d203c4b0ea2afb81b0b3be54c8eecad1ae066a6d99d7a5d203f5c5e103222285f2cc48767423b61eeef8dc204a7654ef2eeb96fdca0428e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:15.992453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:15.992821) ========= 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=232498196343f89f466a4a9a000001c8-1466126130.92396-1720192575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004835 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:47:16.078725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:47:16.079072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:47:16.079481) ========= ========= Total master_lag: 0.19 =========