builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1465376524.73 results: success (0) buildid: 20160607233004 builduid: 91c1474d589245f196ca42ccac1a329f revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.733127) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.733579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.733920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.777599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.777924) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 02:02:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.9M=0s 2016-06-08 02:02:05 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121978 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.925705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.926067) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015833 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.976966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.977330) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1401fcd673699f8d6e431ccb643ab46e166da2a9 --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 1401fcd673699f8d6e431ccb643ab46e166da2a9 --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=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 02:02:05,210 truncating revision to first 12 chars 2016-06-08 02:02:05,210 Setting DEBUG logging. 2016-06-08 02:02:05,210 attempt 1/10 2016-06-08 02:02:05,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1401fcd67369?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 02:02:05,564 unpacking tar archive at: fx-team-1401fcd67369/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:05.675799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:05.676411) ========= script_repo_revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:05.676892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:05.677224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:05.699266) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-08 02:02:05.699696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:06 INFO - MultiFileLogger online at 20160608 02:02:06 in /builds/slave/test 02:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:06 INFO - {'append_to_log': False, 02:02:06 INFO - 'base_work_dir': '/builds/slave/test', 02:02:06 INFO - 'blob_upload_branch': 'Fx-Team', 02:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:06 INFO - 'branch': 'Fx-Team', 02:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:06 INFO - 'config_files': ('talos/linux_config.py',), 02:02:06 INFO - 'default_actions': ('clobber', 02:02:06 INFO - 'read-buildbot-config', 02:02:06 INFO - 'download-and-extract', 02:02:06 INFO - 'populate-webroot', 02:02:06 INFO - 'create-virtualenv', 02:02:06 INFO - 'install', 02:02:06 INFO - 'run-tests'), 02:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:06 INFO - 'download_minidump_stackwalk': True, 02:02:06 INFO - 'download_symbols': 'ondemand', 02:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:06 INFO - 'installer_path': 'installer.exe', 02:02:06 INFO - 'log_level': 'info', 02:02:06 INFO - 'log_name': 'talos', 02:02:06 INFO - 'log_to_console': True, 02:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:06 INFO - 'opt_config_files': (), 02:02:06 INFO - 'pip_index': False, 02:02:06 INFO - 'sps_profile': False, 02:02:06 INFO - 'sps_profile_interval': 0, 02:02:06 INFO - 'suite': 'dromaeojs-e10s', 02:02:06 INFO - 'system_bits': '32', 02:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:06 INFO - 'title': 'talos-linux64-ix-019', 02:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:06 INFO - 'use_talos_json': True, 02:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:06 INFO - 'work_dir': 'build'} 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running clobber step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: clobber 02:02:06 INFO - rmtree: /builds/slave/test/build 02:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - ##### 02:02:06 INFO - ##### Finished clobber step (success) 02:02:06 INFO - ##### 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running read-buildbot-config step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: read_buildbot_config 02:02:06 INFO - Using buildbot properties: 02:02:06 INFO - { 02:02:06 INFO - "project": "", 02:02:06 INFO - "product": "firefox", 02:02:06 INFO - "script_repo_revision": "production", 02:02:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:02:06 INFO - "repository": "", 02:02:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:02:06 INFO - "buildid": "20160607233004", 02:02:06 INFO - "pgo_build": "True", 02:02:06 INFO - "basedir": "/builds/slave/test", 02:02:06 INFO - "buildnumber": 542, 02:02:06 INFO - "slavename": "talos-linux64-ix-019", 02:02:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:02:06 INFO - "platform": "ubuntu64_hw", 02:02:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:02:06 INFO - "branch": "fx-team", 02:02:07 INFO - "repo_path": "integration/fx-team", 02:02:07 INFO - "revision": "1401fcd673699f8d6e431ccb643ab46e166da2a9", 02:02:07 INFO - "stage_platform": "linux64-pgo", 02:02:07 INFO - "builduid": "91c1474d589245f196ca42ccac1a329f", 02:02:07 INFO - "slavebuilddir": "test" 02:02:07 INFO - } 02:02:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - ##### 02:02:07 INFO - ##### Finished read-buildbot-config step (success) 02:02:07 INFO - ##### 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running download-and-extract step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: download_and_extract 02:02:07 INFO - mkdir: /builds/slave/test/build/tests 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:07 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:12 INFO - Downloaded 1361 bytes. 02:02:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:12 INFO - Using the following test package requirements: 02:02:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'jsshell-linux-x86_64.zip'], 02:02:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:12 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:18 INFO - Downloaded 24446988 bytes. 02:02:18 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'] 02:02:18 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 02:02:20 INFO - Return code: 0 02:02:20 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 02:02:20 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')]} 02:02:20 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:22 INFO - Downloaded 24446988 bytes. 02:02:22 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'] 02:02:22 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 02:02:24 INFO - Return code: 0 02:02: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')]} 02:02:24 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:25 INFO - Downloaded 10833369 bytes. 02:02:25 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'] 02:02:25 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 02:02:26 INFO - Return code: 0 02:02:26 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')]} 02:02:26 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/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 02:02:28 INFO - Downloaded 59188184 bytes. 02:02:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:28 INFO - mkdir: /builds/slave/test/properties 02:02:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:28 INFO - Contents: 02:02:28 INFO - build_url:https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:29 INFO - Running post-action listener: _resource_record_post_action 02:02:29 INFO - Running post-action listener: set_extra_try_arguments 02:02:29 INFO - ##### 02:02:29 INFO - ##### Finished download-and-extract step (success) 02:02:29 INFO - ##### 02:02:29 INFO - ##### 02:02:29 INFO - ##### Running populate-webroot step. 02:02:29 INFO - ##### 02:02:29 INFO - Running pre-action listener: _resource_record_pre_action 02:02:29 INFO - Running main action method: populate_webroot 02:02:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:29 INFO - '--tppagecycles', 02:02:29 INFO - '7'], 02:02:29 INFO - 'tests': ['tsvgm']}}, 02:02:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['damp', 'tps']}, 02:02:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'tests': ['damp', 'tps']}, 02:02:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['dromaeo_dom']}, 02:02:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['a11yr', 02:02:29 INFO - 'ts_paint', 02:02:29 INFO - 'tpaint', 02:02:29 INFO - 'sessionrestore', 02:02:29 INFO - 'sessionrestore_no_auto_restore', 02:02:29 INFO - 'tabpaint']}, 02:02:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['tsvgx', 02:02:29 INFO - 'tsvgr_opacity', 02:02:29 INFO - 'tart', 02:02:29 INFO - 'tscrollx', 02:02:29 INFO - 'cart']}, 02:02:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:29 INFO - 'tsvgr_opacity', 02:02:29 INFO - 'tart', 02:02:29 INFO - 'tscrollx', 02:02:29 INFO - 'cart']}, 02:02:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'talos_options': ['--disable-e10s'], 02:02:29 INFO - 'tests': ['tp5o']}, 02:02:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'tests': ['tp5o']}, 02:02:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'talos_options': ['--disable-e10s', 02:02:29 INFO - '--xperf_path', 02:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:29 INFO - 'tests': ['tp5n']}, 02:02:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:29 INFO - 'talos_options': ['--xperf_path', 02:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:29 INFO - 'tests': ['tp5n']}}, 02:02:29 INFO - 'talos.zip': {'path': '', 02:02:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:29 INFO - Running post-action listener: _resource_record_post_action 02:02:29 INFO - ##### 02:02:29 INFO - ##### Finished populate-webroot step (success) 02:02:29 INFO - ##### 02:02:29 INFO - ##### 02:02:29 INFO - ##### Running create-virtualenv step. 02:02:29 INFO - ##### 02:02:29 INFO - Running pre-action listener: _resource_record_pre_action 02:02:29 INFO - Running main action method: create_virtualenv 02:02:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:29 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 02:02:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:29 INFO - Using real prefix '/usr' 02:02:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:31 INFO - Installing pip.................done. 02:02:31 INFO - Return code: 0 02:02:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:02:31 INFO - Using env: {'DISPLAY': ':0', 02:02:31 INFO - 'HOME': '/home/cltbld', 02:02:31 INFO - 'LANG': 'en_US.UTF-8', 02:02:31 INFO - 'LANGUAGE': 'en_US:en', 02:02:31 INFO - 'LOGNAME': 'cltbld', 02:02:31 INFO - 'MAIL': '/var/mail/cltbld', 02:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:31 INFO - 'MOZ_NO_REMOTE': '1', 02:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:31 INFO - 'NO_EM_RESTART': '1', 02:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:31 INFO - 'PWD': '/builds/slave/test', 02:02:31 INFO - 'SHELL': '/bin/bash', 02:02:31 INFO - 'SHLVL': '1', 02:02:31 INFO - 'TERM': 'linux', 02:02:31 INFO - 'TMOUT': '86400', 02:02:31 INFO - 'USER': 'cltbld', 02:02:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:31 INFO - '_': '/tools/buildbot/bin/python'} 02:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:32 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 02:02:32 INFO - Cleaning up... 02:02:32 INFO - Return code: 0 02:02:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:02:32 INFO - Using env: {'DISPLAY': ':0', 02:02:32 INFO - 'HOME': '/home/cltbld', 02:02:32 INFO - 'LANG': 'en_US.UTF-8', 02:02:32 INFO - 'LANGUAGE': 'en_US:en', 02:02:32 INFO - 'LOGNAME': 'cltbld', 02:02:32 INFO - 'MAIL': '/var/mail/cltbld', 02:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:32 INFO - 'MOZ_NO_REMOTE': '1', 02:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:32 INFO - 'NO_EM_RESTART': '1', 02:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:32 INFO - 'PWD': '/builds/slave/test', 02:02:32 INFO - 'SHELL': '/bin/bash', 02:02:32 INFO - 'SHLVL': '1', 02:02:32 INFO - 'TERM': 'linux', 02:02:32 INFO - 'TMOUT': '86400', 02:02:32 INFO - 'USER': 'cltbld', 02:02:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:32 INFO - '_': '/tools/buildbot/bin/python'} 02:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:32 INFO - Downloading/unpacking psutil>=3.1.1 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:34 INFO - Installing collected packages: psutil 02:02:34 INFO - Running setup.py install for psutil 02:02:34 INFO - building 'psutil._psutil_linux' extension 02:02:34 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 02:02:34 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 02:02:34 INFO - building 'psutil._psutil_posix' extension 02:02:34 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 02:02:34 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 02:02:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:34 INFO - Successfully installed psutil 02:02:34 INFO - Cleaning up... 02:02:34 INFO - Return code: 0 02:02:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:34 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 02:02:34 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 02:02:34 INFO - Using env: {'DISPLAY': ':0', 02:02:34 INFO - 'HOME': '/home/cltbld', 02:02:34 INFO - 'LANG': 'en_US.UTF-8', 02:02:34 INFO - 'LANGUAGE': 'en_US:en', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MAIL': '/var/mail/cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SHLVL': '1', 02:02:34 INFO - 'TERM': 'linux', 02:02:34 INFO - 'TMOUT': '86400', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - '_': '/tools/buildbot/bin/python'} 02:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:36 INFO - Installing collected packages: mozsystemmonitor 02:02:36 INFO - Running setup.py install for mozsystemmonitor 02:02:37 INFO - Successfully installed mozsystemmonitor 02:02:37 INFO - Cleaning up... 02:02:37 INFO - Return code: 0 02:02:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:37 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')]} 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 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')]} 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:37 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 02:02:37 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 02:02:37 INFO - Using env: {'DISPLAY': ':0', 02:02:37 INFO - 'HOME': '/home/cltbld', 02:02:37 INFO - 'LANG': 'en_US.UTF-8', 02:02:37 INFO - 'LANGUAGE': 'en_US:en', 02:02:37 INFO - 'LOGNAME': 'cltbld', 02:02:37 INFO - 'MAIL': '/var/mail/cltbld', 02:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:37 INFO - 'MOZ_NO_REMOTE': '1', 02:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:37 INFO - 'NO_EM_RESTART': '1', 02:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:37 INFO - 'PWD': '/builds/slave/test', 02:02:37 INFO - 'SHELL': '/bin/bash', 02:02:37 INFO - 'SHLVL': '1', 02:02:37 INFO - 'TERM': 'linux', 02:02:37 INFO - 'TMOUT': '86400', 02:02:37 INFO - 'USER': 'cltbld', 02:02:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:37 INFO - '_': '/tools/buildbot/bin/python'} 02:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:02:37 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 02:02:37 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 02:02:37 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 02:02:37 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 02:02:37 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 02:02:37 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 02:02:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:39 INFO - warning: no files found matching '*.txt' 02:02:39 INFO - no previously-included directories found matching 'build' 02:02:39 INFO - no previously-included directories found matching 'dist' 02:02:39 INFO - no previously-included directories found matching '.git*' 02:02:39 INFO - Installing collected packages: jsonschema, functools32 02:02:39 INFO - Running setup.py install for functools32 02:02:39 INFO - warning: no files found matching '*.txt' 02:02:39 INFO - no previously-included directories found matching 'build' 02:02:39 INFO - no previously-included directories found matching 'dist' 02:02:39 INFO - no previously-included directories found matching '.git*' 02:02:39 INFO - Successfully installed jsonschema functools32 02:02:39 INFO - Cleaning up... 02:02:39 INFO - Return code: 0 02:02:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:39 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:39 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 02:02:39 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 02:02:39 INFO - Using env: {'DISPLAY': ':0', 02:02:39 INFO - 'HOME': '/home/cltbld', 02:02:39 INFO - 'LANG': 'en_US.UTF-8', 02:02:39 INFO - 'LANGUAGE': 'en_US:en', 02:02:39 INFO - 'LOGNAME': 'cltbld', 02:02:39 INFO - 'MAIL': '/var/mail/cltbld', 02:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:39 INFO - 'MOZ_NO_REMOTE': '1', 02:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:39 INFO - 'NO_EM_RESTART': '1', 02:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:39 INFO - 'PWD': '/builds/slave/test', 02:02:39 INFO - 'SHELL': '/bin/bash', 02:02:39 INFO - 'SHLVL': '1', 02:02:39 INFO - 'TERM': 'linux', 02:02:39 INFO - 'TMOUT': '86400', 02:02:39 INFO - 'USER': 'cltbld', 02:02:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:39 INFO - '_': '/tools/buildbot/bin/python'} 02:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 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 02:02:42 INFO - Downloading docopt-0.6.1.tar.gz 02:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:42 INFO - Running setup.py install for blobuploader 02:02:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:42 INFO - Running setup.py install for requests 02:02:43 INFO - Running setup.py install for docopt 02:02:43 INFO - Successfully installed blobuploader requests docopt 02:02:43 INFO - Cleaning up... 02:02:43 INFO - Return code: 0 02:02:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:43 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 02:02:43 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 02:02:43 INFO - Using env: {'DISPLAY': ':0', 02:02:43 INFO - 'HOME': '/home/cltbld', 02:02:43 INFO - 'LANG': 'en_US.UTF-8', 02:02:43 INFO - 'LANGUAGE': 'en_US:en', 02:02:43 INFO - 'LOGNAME': 'cltbld', 02:02:43 INFO - 'MAIL': '/var/mail/cltbld', 02:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:43 INFO - 'MOZ_NO_REMOTE': '1', 02:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:43 INFO - 'NO_EM_RESTART': '1', 02:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:43 INFO - 'PWD': '/builds/slave/test', 02:02:43 INFO - 'SHELL': '/bin/bash', 02:02:43 INFO - 'SHLVL': '1', 02:02:43 INFO - 'TERM': 'linux', 02:02:43 INFO - 'TMOUT': '86400', 02:02:43 INFO - 'USER': 'cltbld', 02:02:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:43 INFO - '_': '/tools/buildbot/bin/python'} 02:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:43 INFO - Running setup.py (path:/tmp/pip-haljWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:43 INFO - Running setup.py (path:/tmp/pip-FUYzoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:43 INFO - Running setup.py (path:/tmp/pip-VN0_M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:43 INFO - Running setup.py (path:/tmp/pip-Cbef5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:43 INFO - Running setup.py (path:/tmp/pip-3mNC1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:43 INFO - Running setup.py (path:/tmp/pip-FyKpIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 INFO - Running setup.py (path:/tmp/pip-JyAaYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 INFO - Running setup.py (path:/tmp/pip-_ZIaYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:44 INFO - Running setup.py (path:/tmp/pip-q1iLdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:44 INFO - Running setup.py (path:/tmp/pip-dhTHPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:44 INFO - Running setup.py (path:/tmp/pip-m3c_Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:44 INFO - Running setup.py (path:/tmp/pip-fH24aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:44 INFO - Running setup.py (path:/tmp/pip-SIY7zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:44 INFO - Running setup.py (path:/tmp/pip-mh24eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:44 INFO - Running setup.py (path:/tmp/pip-Z_TuuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:44 INFO - Running setup.py (path:/tmp/pip-7PE34C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:44 INFO - Running setup.py (path:/tmp/pip-LTxlEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:44 INFO - Running setup.py install for manifestparser 02:02:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Running setup.py install for mozcrash 02:02:45 INFO - Running setup.py install for mozdebug 02:02:45 INFO - Running setup.py install for mozdevice 02:02:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozfile 02:02:45 INFO - Running setup.py install for mozhttpd 02:02:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozinfo 02:02:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozInstall 02:02:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozleak 02:02:45 INFO - Running setup.py install for mozlog 02:02:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for moznetwork 02:02:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:45 INFO - Running setup.py install for mozprocess 02:02:46 INFO - Running setup.py install for mozprofile 02:02:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Running setup.py install for mozrunner 02:02:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Running setup.py install for mozscreenshot 02:02:46 INFO - Running setup.py install for moztest 02:02:46 INFO - Running setup.py install for mozversion 02:02:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:46 INFO - Cleaning up... 02:02:46 INFO - Return code: 0 02:02:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:46 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:46 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 02:02:46 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 02:02:46 INFO - Using env: {'DISPLAY': ':0', 02:02:46 INFO - 'HOME': '/home/cltbld', 02:02:46 INFO - 'LANG': 'en_US.UTF-8', 02:02:46 INFO - 'LANGUAGE': 'en_US:en', 02:02:46 INFO - 'LOGNAME': 'cltbld', 02:02:46 INFO - 'MAIL': '/var/mail/cltbld', 02:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:46 INFO - 'MOZ_NO_REMOTE': '1', 02:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:46 INFO - 'NO_EM_RESTART': '1', 02:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:46 INFO - 'PWD': '/builds/slave/test', 02:02:46 INFO - 'SHELL': '/bin/bash', 02:02:46 INFO - 'SHLVL': '1', 02:02:46 INFO - 'TERM': 'linux', 02:02:46 INFO - 'TMOUT': '86400', 02:02:46 INFO - 'USER': 'cltbld', 02:02:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:46 INFO - '_': '/tools/buildbot/bin/python'} 02:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:46 INFO - Running setup.py (path:/tmp/pip-LQIgb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:46 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)) 02:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:46 INFO - Running setup.py (path:/tmp/pip-ONDTuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:46 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)) 02:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:46 INFO - Running setup.py (path:/tmp/pip-9jR472-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:47 INFO - Running setup.py (path:/tmp/pip-yWVOpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:47 INFO - Running setup.py (path:/tmp/pip-h4dK2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:47 INFO - Running setup.py (path:/tmp/pip-c4_6zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:47 INFO - Running setup.py (path:/tmp/pip-k0iTWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:47 INFO - Running setup.py (path:/tmp/pip-9YauRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:47 INFO - Running setup.py (path:/tmp/pip-gceuYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:47 INFO - Running setup.py (path:/tmp/pip-alwRLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:47 INFO - Running setup.py (path:/tmp/pip-QJwaJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:47 INFO - Running setup.py (path:/tmp/pip-Of743r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:47 INFO - Running setup.py (path:/tmp/pip-IrE5is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:47 INFO - Running setup.py (path:/tmp/pip-5bxibn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:47 INFO - Running setup.py (path:/tmp/pip-vT9dDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:47 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)) 02:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:47 INFO - Running setup.py (path:/tmp/pip-NNak4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:48 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)) 02:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:48 INFO - Running setup.py (path:/tmp/pip-oWyFrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 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)) 02:02:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:48 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 02:02:48 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 02:02:48 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 02:02:48 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 02:02:48 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 02:02:48 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 02:02:49 INFO - Downloading blessings-1.6.tar.gz 02:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:50 INFO - Installing collected packages: blessings 02:02:50 INFO - Running setup.py install for blessings 02:02:50 INFO - Successfully installed blessings 02:02:50 INFO - Cleaning up... 02:02:50 INFO - Return code: 0 02:02:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:50 INFO - Reading from file tmpfile_stdout 02:02:50 INFO - Current package versions: 02:02:50 INFO - argparse == 1.2.1 02:02:50 INFO - blessings == 1.6 02:02:50 INFO - blobuploader == 1.2.4 02:02:50 INFO - docopt == 0.6.1 02:02:50 INFO - functools32 == 3.2.3-2 02:02:50 INFO - jsonschema == 2.5.1 02:02:50 INFO - manifestparser == 1.1 02:02:50 INFO - mozInstall == 1.12 02:02:50 INFO - mozcrash == 0.17 02:02:50 INFO - mozdebug == 0.1 02:02:50 INFO - mozdevice == 0.48 02:02:50 INFO - mozfile == 1.2 02:02:50 INFO - mozhttpd == 0.7 02:02:50 INFO - mozinfo == 0.9 02:02:50 INFO - mozleak == 0.1 02:02:50 INFO - mozlog == 3.2 02:02:50 INFO - moznetwork == 0.27 02:02:50 INFO - mozprocess == 0.22 02:02:50 INFO - mozprofile == 0.28 02:02:50 INFO - mozrunner == 6.11 02:02:50 INFO - mozscreenshot == 0.1 02:02:50 INFO - mozsystemmonitor == 0.3 02:02:50 INFO - moztest == 0.7 02:02:50 INFO - mozversion == 1.4 02:02:50 INFO - psutil == 3.1.1 02:02:50 INFO - requests == 1.2.3 02:02:50 INFO - wsgiref == 0.1.2 02:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:50 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 02:02:50 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 02:02:50 INFO - Using env: {'DISPLAY': ':0', 02:02:50 INFO - 'HOME': '/home/cltbld', 02:02:50 INFO - 'LANG': 'en_US.UTF-8', 02:02:50 INFO - 'LANGUAGE': 'en_US:en', 02:02:50 INFO - 'LOGNAME': 'cltbld', 02:02:50 INFO - 'MAIL': '/var/mail/cltbld', 02:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:50 INFO - 'MOZ_NO_REMOTE': '1', 02:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:50 INFO - 'NO_EM_RESTART': '1', 02:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:50 INFO - 'PWD': '/builds/slave/test', 02:02:50 INFO - 'SHELL': '/bin/bash', 02:02:50 INFO - 'SHLVL': '1', 02:02:50 INFO - 'TERM': 'linux', 02:02:50 INFO - 'TMOUT': '86400', 02:02:50 INFO - 'USER': 'cltbld', 02:02:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:50 INFO - '_': '/tools/buildbot/bin/python'} 02:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 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)) 02:02:50 INFO - Cleaning up... 02:02:50 INFO - Return code: 0 02:02:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:50 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 02:02:50 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 02:02:50 INFO - Using env: {'DISPLAY': ':0', 02:02:50 INFO - 'HOME': '/home/cltbld', 02:02:50 INFO - 'LANG': 'en_US.UTF-8', 02:02:50 INFO - 'LANGUAGE': 'en_US:en', 02:02:50 INFO - 'LOGNAME': 'cltbld', 02:02:50 INFO - 'MAIL': '/var/mail/cltbld', 02:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:50 INFO - 'MOZ_NO_REMOTE': '1', 02:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:50 INFO - 'NO_EM_RESTART': '1', 02:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:50 INFO - 'PWD': '/builds/slave/test', 02:02:50 INFO - 'SHELL': '/bin/bash', 02:02:50 INFO - 'SHLVL': '1', 02:02:50 INFO - 'TERM': 'linux', 02:02:50 INFO - 'TMOUT': '86400', 02:02:50 INFO - 'USER': 'cltbld', 02:02:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:50 INFO - '_': '/tools/buildbot/bin/python'} 02:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:50 INFO - Cleaning up... 02:02:50 INFO - Return code: 0 02:02:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 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 0x7f130da4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', '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 02:02:50 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 02:02:50 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 02:02:50 INFO - Using env: {'DISPLAY': ':0', 02:02:50 INFO - 'HOME': '/home/cltbld', 02:02:50 INFO - 'LANG': 'en_US.UTF-8', 02:02:50 INFO - 'LANGUAGE': 'en_US:en', 02:02:50 INFO - 'LOGNAME': 'cltbld', 02:02:50 INFO - 'MAIL': '/var/mail/cltbld', 02:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:50 INFO - 'MOZ_NO_REMOTE': '1', 02:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:50 INFO - 'NO_EM_RESTART': '1', 02:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:50 INFO - 'PWD': '/builds/slave/test', 02:02:50 INFO - 'SHELL': '/bin/bash', 02:02:50 INFO - 'SHLVL': '1', 02:02:50 INFO - 'TERM': 'linux', 02:02:50 INFO - 'TMOUT': '86400', 02:02:50 INFO - 'USER': 'cltbld', 02:02:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:50 INFO - '_': '/tools/buildbot/bin/python'} 02:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:51 INFO - Downloading/unpacking flake8 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02:52 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 02:02:52 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 02:02:52 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 02:02:52 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 02:02:52 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 02:02:52 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 02:02:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:53 INFO - no previously-included directories found matching 'docs/_build' 02:02:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:53 INFO - Running setup.py install for pep8 02:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:53 INFO - no previously-included directories found matching 'docs/_build' 02:02:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:53 INFO - Cleaning up... 02:02:53 INFO - Return code: 0 02:02:53 INFO - Running post-action listener: _resource_record_post_action 02:02:53 INFO - Running post-action listener: _start_resource_monitoring 02:02:53 INFO - Starting resource monitoring. 02:02:53 INFO - ##### 02:02:53 INFO - ##### Finished create-virtualenv step (success) 02:02:53 INFO - ##### 02:02:53 INFO - ##### 02:02:53 INFO - ##### Running install step. 02:02:53 INFO - ##### 02:02:53 INFO - Running pre-action listener: _resource_record_pre_action 02:02:53 INFO - Running main action method: install 02:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:54 INFO - Reading from file tmpfile_stdout 02:02:54 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:54 INFO - Reading from file tmpfile_stdout 02:02:54 INFO - Output received: 02:02:54 INFO - Usage: mozinstall [options] installer 02:02:54 INFO - Options: 02:02:54 INFO - -h, --help show this help message and exit 02:02:54 INFO - -d DEST, --destination=DEST 02:02:54 INFO - Directory to install application into. [default: 02:02:54 INFO - "/builds/slave/test"] 02:02:54 INFO - --app=APP Application being installed. [default: firefox] 02:02:54 INFO - mkdir: /builds/slave/test/build/application 02:02:54 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'] 02:02:54 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 02:03:11 INFO - Reading from file tmpfile_stdout 02:03:11 INFO - Output received: 02:03:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:11 INFO - Running post-action listener: _resource_record_post_action 02:03:11 INFO - ##### 02:03:11 INFO - ##### Finished install step (success) 02:03:11 INFO - ##### 02:03:11 INFO - ##### 02:03:11 INFO - ##### Running run-tests step. 02:03:11 INFO - ##### 02:03:11 INFO - Running pre-action listener: _resource_record_pre_action 02:03:11 INFO - Running main action method: run_tests 02:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:11 INFO - Python 2.7.3 02:03:11 INFO - Return code: 0 02:03:11 INFO - grabbing minidump binary from tooltool 02:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:11 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 0xd9a1c0>, '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 0xd9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:11 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 02:03:11 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 02:03:11 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 02:03:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:11 INFO - Return code: 0 02:03:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:03:12 INFO - Return code: 0 02:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:03:12 INFO - Using env: {'DISPLAY': ':0', 02:03:12 INFO - 'HOME': '/home/cltbld', 02:03:12 INFO - 'LANG': 'en_US.UTF-8', 02:03:12 INFO - 'LANGUAGE': 'en_US:en', 02:03:12 INFO - 'LOGNAME': 'cltbld', 02:03:12 INFO - 'MAIL': '/var/mail/cltbld', 02:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:12 INFO - 'MOZ_NO_REMOTE': '1', 02:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:12 INFO - 'NO_EM_RESTART': '1', 02:03:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:12 INFO - 'PWD': '/builds/slave/test', 02:03:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:12 INFO - 'SHELL': '/bin/bash', 02:03:12 INFO - 'SHLVL': '1', 02:03:12 INFO - 'TERM': 'linux', 02:03:12 INFO - 'TMOUT': '86400', 02:03:12 INFO - 'USER': 'cltbld', 02:03:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980', 02:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:12 INFO - '_': '/tools/buildbot/bin/python'} 02:03:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:03:12 INFO - mozversion application_buildid: 20160607233004 02:03:12 INFO - mozversion application_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 02:03:12 INFO - mozversion application_display_name: Nightly 02:03:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:12 INFO - mozversion application_name: Firefox 02:03:12 INFO - mozversion application_remotingname: firefox 02:03:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:03:12 INFO - mozversion application_vendor: Mozilla 02:03:12 INFO - mozversion application_version: 50.0a1 02:03:12 INFO - mozversion platform_buildid: 20160607233004 02:03:12 INFO - mozversion platform_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 02:03:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:03:12 INFO - mozversion platform_version: 50.0a1 02:03:12 INFO - using testdate: 1465376592 02:03:12 INFO - actual date: 1465376592 02:03:12 INFO - starting webserver on 'localhost:43811' 02:03:12 INFO - SUITE-START | Running 2 tests 02:03:12 INFO - TEST-START | dromaeo_css 02:03:12 INFO - operating with platform_type : linux_ 02:03:12 INFO - Initialising browser for dromaeo_css test... 02:03:12 INFO - TEST-INFO | started process 20688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbKN2r/profile http://localhost:43811/getInfo.html) 02:03:17 INFO - PROCESS | 20688 | __metrics Screen width/height:1600/1200 02:03:17 INFO - PROCESS | 20688 | colorDepth:24 02:03:17 INFO - PROCESS | 20688 | Browser inner width/height: 1024/697 02:03:17 INFO - PROCESS | 20688 | __metrics 02:03:18 ERROR - PROCESS | 20688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:03:18 INFO - TEST-INFO | 20688: exit 0 02:03:18 INFO - Browser initialized. 02:03:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:18 INFO - TEST-INFO | started process 20806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbKN2r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:30 INFO - PROCESS | 20806 | RSS: Main: 167075840 02:03:30 INFO - PROCESS | 20806 | 02:04:20 INFO - PROCESS | 20806 | 1465376660340 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] 02:06:27 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43811/tests/dromaeo/cssquery-ext.html) 02:06:29 INFO - PROCESS | 20806 | RSS: Main: 170270720 02:06:29 INFO - PROCESS | 20806 | 02:09:31 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-ext.html (next: http://localhost:43811/tests/dromaeo/cssquery-jquery.html) 02:09:31 INFO - PROCESS | 20806 | RSS: Main: 169820160 02:09:31 INFO - PROCESS | 20806 | 02:12:33 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43811/tests/dromaeo/cssquery-mootools.html) 02:12:34 INFO - PROCESS | 20806 | RSS: Main: 170696704 02:12:34 INFO - PROCESS | 20806 | 02:15:35 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43811/tests/dromaeo/cssquery-prototype.html) 02:15:36 INFO - PROCESS | 20806 | RSS: Main: 168730624 02:15:36 INFO - PROCESS | 20806 | 02:18:39 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43811/tests/dromaeo/cssquery-yui.html) 02:18:39 INFO - PROCESS | 20806 | RSS: Main: 170172416 02:18:39 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:43811/tests/dromaeo/cssquery-yui.html (next: http://localhost:43811/tests/dromaeo/cssquery-dojo.html) 02:21:42 INFO - PROCESS | 20806 | RSS: Main: 171978752 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | __start_tp_report 02:21:42 INFO - PROCESS | 20806 | _x_x_mozilla_page_load 02:21:42 INFO - PROCESS | 20806 | _x_x_mozilla_page_load_details 02:21:42 INFO - PROCESS | 20806 | |i|pagename|runs| 02:21:42 INFO - PROCESS | 20806 | |0;dojo.html;3079.5380692896047;3082.0291608143434;3087.259057826121;3139.497680371141;3181.2206009527667;5368.919466208005;5368.919466208005;5380.596455265856;5405.891882162355;5490.368607610126;5279.656822306548;5331.280277162582;5348.786048558063;5384.219288203218;5429.56563474922;4833.806647734095;4859.343988561552;4955.529224723646;4991.950080499203;5020.523050310215;879.9326601752424;4891.364122664067;4911.189653707134;4924.70451772893;4970.726610036447;4921.507849215086;4931.112399768041;4945.480724523927;4953.925691114636;4997.850064498053;4783.234682450791;4965.627577931669;4982.451930287665;4993.725345106018;5020.447750747415;4802.663813533054;4810.134175848346;4815.903681926342;4816.373871396696;4842.467328593852;5185.818496352647;5236.345456817898;5277.419483856773;5288.68267903927;5337.146056630921;5575.163725441216;5731.742071606787;5731.856703582402;5783.843231353746;5794.739236734357;5709.400512946122;5715.0855863062125;5758.596898217126;5769.163471296681;5833.912491312633;5366.731663416853;5367.892642147135;5368.114261146906;5380.058489764276;5388.030154572215;5851.561132914963;5876.706164691748;5909.645421274738;5922.289325280908;5938.138969849348;5687.232223649837;5741.684207368635;5742.052561327418;5749.655020698771;5760.308762948473;5623.100303951348;5821.359650438449;5831.766729330864;5833.270841144857;5847.9415205848245;5750.511206547407;5827.475527202572;5834.416558344216;5902.439268269593;5904.0553511437965;5626.718664066781;5650.971745141248;5703.230063941398;5705.229793977843;5912.763489460373;4337.284348082594;4422.513523512411;4428.55714428561;4428.955710442919;4465.464144302705;3931.233409485123;3934.1738234970976;3978.0452691353867;4005;4042.4946881639794;5612.747426365741;5652.717364131777;5654.208410822488;5655.717214139277;5662.971685141548;5661.433856614306;5792.710364481759;5885.205497257815;5966.701664916737;5969.04495280753;5580.9441905580425;5610.158476228598;5613.410591887875;5648.463395977457;5679.6876171810945;5038.2190760432195;5043.949560504348;5047.722375269322;5058.215976523645;5092.312537807348;5806.709664516758;5923.229980102559;6023.367546407651;6045.6070355426755;6056.36408177135;5910.940890591039;5916.822495325147;5922.73347699346;5932.258467691625;5936;6067.878642427038;6070.939290607214;6072.332043475302;6076.635401875901;6088.543359247986;5631.88736225265;5680.147977803363;5718.370979192368;5787.768489260382;5807.419258074327;5896.764129434946;5907.113932910098;5914.526837852875;5918.615290006136;5921.052631578927;5713.714314284352;5739.253896993364;5747;5748.885022299447;5756.136579513107;5567.331920169606;5573.1918871762555;5643.71781410936;5657.688827114548;5684.346300175533;5425.13197888336;5538.224648549126;5553.139263414178;5601.795613943022;5658.603897727119;5764.0201165802755;5770.567207459373;5791.884162316815;5797.304323481209;5807.390224026585;5454.045542030208;5545.417731138334;5607;5627.718614069198;5663.405342438985 02:21:42 INFO - PROCESS | 20806 | |1;ext.html;578.1039388947131;613.2089604410311;616.5591602004566;624.4130517313728;640.2349192714705;43079.784601076986;44466.55533444669;44551;44611;47153.528464715346;44565;45164;45236.547634523726;45286.32070518945;45525.54474455254;8723.956380218106;8862.33532485063;8890.155435233642;8952.686655967042;8963.41737787045;8741.431806932529;8871.512066836322;8906.51014194219;8928.330375221884;8941.95529022354;8909.06454822244;8939.910600894005;8979.281657467387;9001.77495562613;9035.909640903572;8810.779730506725;8938.106189381075;8943.32925030622;9001.739756434039;9003.459792412476;8809;8869.246114080312;8897.466152030898;8899;8921.330900182513;43256;43569.34645980313;43824.12351752947;43916.12167756627;44090.55909440896;3360.932781344384;3480.4083305838067;3499.125218695326;3596.82015899204;3748.7938163401004;31218.53172202419;31419.528707069414;31860.599963326084;32498.350032999446;32756;4204.558521355275;4221.197972385237;4248.702590818644;4284.485861696585;4310.676699247569;338985;339831;341725;344137;344145.9999999975;32349.676503235136;33189;59600.40399595949;59625.70187149037;59695.40304596898;35840.64159358425;35878.820605896806;35925.28149436996;35932.64067359345;36074.09814754652;14061;14087.295635218197;14153.29233538319;14188.716225675635;14188.85811141896;12538.749225015448;12541;12548.12163148589;12548.874511254953;12559.686007849878;8337.833243335099;8429.157084291523;8435.325173986066;8487.533185674847;8494.405391622651;3227.193201699575;3242.3515296940705;3247.236899328656;3252.3332716793;3274.8690052398115;1014.0214692821463;1017.0541396501325;1073.414988831089;1170.1399471388522;1179.1000298003412;32691.836540817618;33155.336893262;33186.3362732744;33394.16514587155;33530;1151.9193656443967;1198.3169593331718;1210.0198838940487;1255.6358655989661;1270.6251655761573;17133.314667413164;17425.564360890825;17427.65144697099;17559;17625.647487050188;538752;540636;542541;542690;543809;57714.71142644344;59088.40911590915;59129.40870591239;59167.112493312634;59183.40816591865;1329.547953695748;1344.87223713749;1351.4526616720243;1370.5614203454998;1382.9151732377618;31024.22439439032;32929.67070329266;32997.50503742494;33083.17292067718;33172.488010988876;51275.743621281654;51324.20365287197;51586.74206628943;51688;51761.741191293804;353196;355322;355374;356151;357026;28190.154295371172;28521.28696782597;28549.571756424084;28581.857090714413;28745;46635.30047049365;48270.27594586154;48293;49115;49555;40415;41421.378679320434;41760;41782.79108604437;41896.581034189265;40774.79612601918;41319.38020929749;41499;41572.37641435441;41655.7917210412;40966.385504216865;40974;41558.37662435006;42071.78964105283;43965.34051989287;33752;37244.81377593203;38082.428763568016;38131;38410.231795363376;26514.86742566275;26969.595456068568;27179.864100680163;27418.17745467639;27475.450490990468 02:21:42 INFO - PROCESS | 20806 | |2;jquery.html;382.37099970548456;388.4425848906817;392.1666458775103;398.2095540352401;413.1241767453;17384.304627814887;18605.348812791555;19259.133338999745;19296.614067718656;19393.418197454062;17817.821821781778;18293.359732409368;18674;18846;18890.055497225152;5641.153826925974;5709.457601527869;5750.942490575083;5816.360200377976;5822.388649191837;5700.914486282709;5745.339285982123;5752.28096487939;5774.364819869811;5778.306603207621;5680.943190568083;5690.829275121753;5716.3426205986425;6004.669743164124;6052.667103309316;5656.575756818214;5865.413458654143;5960.105984102398;6060.636361818305;6103.420175083382;5616.606837521375;5652.604317697722;5660.122680984454;5661.886762264773;5663.405342439026;13210.33948302581;18200;18309.809862358903;21272.46818829526;21298.36104916855;1967.9508012299807;2093.8534302598823;2216.5456081503253;2300.3559003479054;2315.4790172211287;10143.340682855665;10195.133413659847;10357.533910974023;11615.419229038514;14236.35936382855;1841.7974022857475;1847.3534263007973;1858.4889155482215;1906.094605062598;1968.7932767059397;74516.25483745147;75324;76874.61562692151;77356;77512.61243693746;10508.947455262674;10723.30298530593;10801;10876.510557024953;11061.723456913642;14933.328000239799;14949.70100597982;15166.24168791556;15188;15208.771868421982;7751.573663448565;7871.173526779606;7945.920540794634;7994.160613135653;8110.391720620977;7474.663640136207;7481.438892083115;7522.097348318237;7603.163651998276;7679.424043196783;4576.146660602461;4593.609543188866;4646.23443091623;4651.37206477128;4750.786214620351;1906.418542344598;1949.8927558984108;1968.842492600617;1970.6354324449735;1978.9901050494943;955.5938726041404;983.6311383231289;1036.4921188617523;1048.4862666221836;1058.867641544807;18448;18553.25786968506;19060.71408928867;19068.523286917938;19259.61480770405;1018.4773763224027;1043.9269251152346;1055.883852776194;1080.6811990462832;1087.537796436527;6188.164597779242;10099.899001009895;10680.198985075995;10698.465076746132;10769.353838769699;354107;363013;477040;479310.0344982807;492914;68923.65538172277;82039;90088;95993.52003240079;96840;466.55677106748726;481.35017726070225;483.4971629505275;484.72612973669766;484.8763565290899;10877.945610271898;11274.943625281821;11522.596709115141;11675.941620291844;11694.181407301747;29190;39875;40475;40641.39037914375;41220.587794121675;50876.491235087175;52608.47391526036;58215;58230.7088464555;58806;7727.652255648622;8213.54825484604;8244.793880152803;8458.111898250841;8789.340799440195;8994.910050899669;11914.285142891455;12427.130100893213;12802.807957880454;12834.037447191311;10604.89395106039;10916.781664366827;11127.276727012719;11183.161262905478;11233.943830280796;9294.466413041773;10381.584736610452;10823.51294191779;11217.943910280397;11224.551017959517;10485.9475702621;10737.46312684347;10845.511951962339;10874.401907895142;10930;8497.87253191215;8606.182412670787;8630.741077767678;8653.69712060075;8661.003984541607;9492.193163580896;10315.638952636622;10464.790704186025;10488.370697758159;10696.518656660313 02:21:42 INFO - PROCESS | 20806 | |3;mootools.html;1499.655079331754;1519.7188520123777;1670.690922179397;1760.683077046133;1794.4796009157344;7830.647620857061;8424.368172387065;8509.064002959669;9085.40944838585;9098.727038188865;8490.066092729794;8767.649294028248;8768;8768.868466973001;8799.56002199889;2358.1746388763922;2380.547695937766;2395.8203134764963;2400.135951057618;2406.2300063979533;2284.017872314904;2316.779905908936;2326.2672258238686;2336.836421450499;2338.0297176671747;2376.7504412036747;2378.3935096550354;2384.4277373430427;2408.6266628672497;2409.361519197414;2323.6514522821626;2338.75443078476;2349.9647505287435;2361.728401233854;2364.2670772060715;2289.107248173214;2311.5376924614975;2319.060780383947;2327.522857814144;2337.9829774048344;8762;8852.424592401474;8860.468371897707;8870.556472176366;8879.467231966039;5141.717205553693;5264.184051472028;5278.947210527884;5281.735913204363;5288.391834938992;3264.983675081633;3315.370079684852;3394.287199688044;3402.1834759657504;3409.9659003409897;1065.6217042949797;1073.88187299397;1088;1097.2922465010104;1106.0985296982933;12328.938355308166;12380.566680166152;12424.875751242553;12463.875361246362;12473.376331183405;4710.257204834164;4723.858284251478;4839.854804355875;4855.927161092586;4965.602751779849;10291.53688084038;10358.378497290187;10358.741031474274;10368.688939331832;10390.688279351632;5506.807261745819;5519.199716041152;5562.888742225214;5568.359638641527;5580.051391263495;4380.255356589388;4717.268823332389;4905.043516514317;4909.091818013679;4933.9013219736125;4027.154297597479;4082.7346222495444;4118.496034757211;4153.1486045360625;4213.115245798355;1249.906257030708;1262.0156278103095;1278.7634287656813;1303.2766814417898;1312.8162057311984;777.0287141073658;906.9162350990634;949.6154057606681;956.1633570625703;971.7959228562081;5568.276124103841;5619.8033068843215;5708.372079071299;5775.6823374714795;5891.145783861316;928.6888892221046;989.4113002763344;1004.9497525123714;1030.350878946274;1034.567124532528;3792.981035094807;3955.149642826806;3974.463447434617;3994.1612261425425;4001.2597669431248;10541.420221887716;10776.515056822462;10860.511276992554;10899.400532970763;10906.454677266105;10611.628592999208;10950.178736594788;10979.670609881716;11003.834942475869;11015.449227538751;8277.793055173668;8279.54462504556;8334.249917507454;8397.538135402488;8475.406721529434;5566.526845218202;5626.943730562642;5653.152027195953;5702.572307076903;5867.823965281048;9595.568199430903;10379.169666426516;10389.428581428094;10477.68566942993;10481.109105726098;10071.395716257048;10270.897291027293;10321.329113607591;10391.168706503613;10414.739631509274;7412.184659687322;7602.973598564123;7984.24149705777;8030.759077227693;8166.510009399455;8611.526366049928;8622.396432249683;8639.568021599021;8645.610947507252;8646.178613031752;7572.886406703794;7712.884306735516;7754.92245077542;7795.688172473037;7978.481398709066;7452.366548843409;7468.701251949861;7570.772876813704;7587.089549254125;7643;7026.297370262932;7061.611611361424;7084.079069720903;7109.680064397218;7126.750563730245;4335.176316499855;4479.484859241099;4552.726836389827;4584.060267645058;4584.289435137559;5034.395872495324;5091.465396133352;5098.2352647103235;5104.719240441811;5161.174212126042 02:21:42 INFO - PROCESS | 20806 | |4;prototype.html;320.887689308742;329.50574138791814;332.3170883833722;340.32785249132957;340.5623773451115;5623.77504899804;5664.0459041630575;5698.116791897252;5722.79970201043;5731.369549349573;5528.5024347808685;5569.415211402805;5597.537083683187;5611.971940140294;5627.971860140704;4116.464859568252;4205.074883525619;4267.146570685875;4305.590968857953;4314.568543145691;4302.247106756321;4314.525402205755;4315.82736690532;4348.543402942693;4351.5648435156545;4310.6551475882015;4323.119443042271;4327.7186982846015;4341.50072741634;4360.6293465055505;4023.2355852387955;4217.662586993033;4223.260929337384;4257.74453532789;4337.9566204338025;3644.344018076745;3650.1604630934767;3675.713500274909;3676.613955534684;3700.85196592136;5387.218853266294;5394.244805727201;5434.701091439969;5470.5350045246205;5472.534834539069;4714.5521175488275;4939.925901111486;4955.578775804061;4961.255811628249;4995.775190116454;5875.236219291507;5882.911756323616;5892.911606325909;5920.763169473216;5955.702214889281;4166.708330416872;4171.937420938689;4180.289350810339;4183.644390226835;4195.91608167835;5989.191459153046;6143.84640383994;6191.907121393183;6202.317745048041;6240.750369985195;4265.573442655709;4279.379489973999;4288.270993931039;4295.4201182839915;4302.849400270976;4325.913481730411;4328.588784065509;4345.87052344349;4348.5211830535445;4368.672349573794;4886.902261954741;4967.503249675004;4970.801167953314;5003.449620541737;5008.248762685626;5845.620034697731;5885.2349194605285;5885.970570147122;5914.792982245601;5965.433283838029;1479.5191562741936;1498.3107770425727;1499.3402902722767;1504.653929596199;1505.7741338799267;928.8188803183315;942.2556180617236;948.4309414351334;954.5799848066829;954.6610953111684;5070.363411026246;5071.721055341992;5089.720065396365;5181.5077567631015;5203.297554830049;5383.515483606494;5436.374816896028;5443.564514838803;5450.91823622646;5468.48049435303;4919.4834542373255;5162.6386152968935;5184.248283998874;5214.296070030573;5225.869353266123;2890.2774306423394;2892.2335581071034;2918.4746745585576;2921.3134913295357;2981.3739114785703;5282.498162674539;5505.9724701376235;5511.255980442669;5550.528205102531;5561.915426491876;5450.964316779799;5489.945100549024;5497.587680923947;5498.230247765316;5518.420565840609;5486.204500347507;5523.28197334352;5553.250311208016;5555.805546805843;5643.927653745775;5177.792888284426;5403.594730395314;5404.891902162013;5425.345269692623;5458.918116228339;5395.892082158413;5447.618666693452;5448.56411487088;5450.236966824568;5456.809011684572;5447.782088716565;5522.475364840334;5602.355729091044;5610.84977579587;5652.19129878435;3849.3071247175776;3931.682886233144;4207.347861081537;4214.262504061839;4215.473065866767;5915.852103697442;5943.346231914573;6079.50740196535;6144.293406258337;6144.631322120687;5907.143464197753;5911.645301281937;5921.763129474945;5967.37342579023;5981.517670166832;5872.882542349214;5916.053431450947;5936.1986131871645;5940.376260492586;5955.374685657944;5665.291838520185;5806.390329015392;5845.649261044351;5853.795117170878;5866.266716660418;5915.674637894957;5966.850828729316;5969.91045134332;5988;5995.0407934731975;5727.570432217517;5845.941540584709;5871.442212989759;5923.851903702442;5930.199423077829 02:21:42 INFO - PROCESS | 20806 | |5;yui.html;743.735973729326;786.3237615650543;819.5574389829493;830.4062595244399;843.0429077027081;14235.78646320306;14375.784363234547;15477.071375717465;15710.92144539277;15944.362225510995;14924.403023879031;15068.849311506881;15166.545003649908;15213;15213.619659508518;797.0913158998746;806.2381049907825;821.8438496685641;827.2058823529389;829.4484168028254;821.5481485183155;824.9257566818985;826.89663792026;827.8178800663844;828.1097819843662;863.1109956744563;863.9611217495228;864.511550973701;865.2429124516049;868.4398562926908;847.9957600212022;851.9829603407898;854.9786255343635;856.1652388920784;856.7130011446174;616.3682225718629;623.1680706257152;626.6396821827421;627.6892937995722;627.7551754815626;15817.762733559006;15853.841461585353;15921.363145474166;15923.761143582855;15984;14096.436142554285;14526.70946581073;14608;14863;14933.925330373388;12189.65913749487;12253.877461225451;12281.201721888048;12312.507499700001;12875.420606072656;3770.5852356240794;3773.9998900291444;3942.921141577181;4000.139969906455;4001.099752555681;80440.59779701065;81877.59061204715;81991;82296.58851705764;83313.99999999939;10893.509792059376;11155.970253404317;11185.496652650487;11486.94256528712;11905.047596192284;20163.092660830298;20186.39440816778;20202.595948080954;20209.898950505154;20223.696644550047;8607.61265743043;8734.170253826003;8765.167309105625;8930.86603700945;9131.452112873249;4703.717776933327;4771.73755443447;4858.392700912386;4873.31773551703;5016.172331565251;3652.8356223969986;3659.6523330284112;3748.737588368788;3749.2688925659236;3769.5288088988877;588.485075558886;596.2040675697991;601.2844714789474;609.1684850179473;613.9877202455926;629.6788637794758;715.9069320988239;725.7278520554792;730.3390431659357;744.5793126883293;9532.809343813085;10062.899371006342;10259.230557708053;10340.37957722539;10357.274990750575;688.896665500179;718.3714250031222;718.9964050179716;730.3828265115968;739.7078154129089;4686.3204835299375;4763.45220299663;4781.258904869681;4820.783064762094;4899.363082799213;70470.29529704637;80869;94339.05660943303;114476;117629;58674;59185;62087.37912620906;84120;92919.5354023239;77305.61347193229;77775;78212.21787782163;88821;91169.08830911606;9961.50192490387;10459.738506537398;10469.790604188025;10537.104346130665;10591.735206619587;40446;46113.07773844572;49076.263856042904;49266;50899.2365114531;44899.53052582139;45018;45467.54532454633;79116.60441697754;80890.19109808827;13116.606501804961;13177.212159898068;13237.40431680596;13332.666683332995;13929.58211253664;13792.517261895786;13794.241316727675;13958.441662333393;14443.566692999228;14723.190224537753;13782.379792909143;13846.376913038735;13961.511347102803;14345.856541434452;14821.110733356034;13842;13993.93003035019;14275.928620356832;14340.856591433952;14733.55799326022;13220.272884991418;13637.863621364057;13749.656258593615;13830.515931942333;14073.788893166406;10716.571337146426;11210.215284929976;11283.633042358622;11818.468168932246;11857.822132667845;11525.654230373102;11548.48031838586;11640.35978021217;11710.531578736754;11740.519654224223 02:21:42 INFO - PROCESS | 20806 | __end_tp_report 02:21:42 INFO - PROCESS | 20806 | __start_cc_report 02:21:42 INFO - PROCESS | 20806 | _x_x_mozilla_cycle_collect,356 02:21:42 INFO - PROCESS | 20806 | __end_cc_report 02:21:42 INFO - PROCESS | 20806 | __startTimestamp1465377702541__endTimestamp 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | ------- Summary: start ------- 02:21:42 INFO - PROCESS | 20806 | Number of tests: 6 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#0] dojo.html Cycles:165 Average:5370.33 Median:5643.72 stddev:716.10 (12.7%) stddev-sans-first:695.38 02:21:42 INFO - PROCESS | 20806 | Values: 3079.5 3082.0 3087.3 3139.5 3181.2 5368.9 5368.9 5380.6 5405.9 5490.4 5279.7 5331.3 5348.8 5384.2 5429.6 4833.8 4859.3 4955.5 4992.0 5020.5 879.9 4891.4 4911.2 4924.7 4970.7 4921.5 4931.1 4945.5 4953.9 4997.9 4783.2 4965.6 4982.5 4993.7 5020.4 4802.7 4810.1 4815.9 4816.4 4842.5 5185.8 5236.3 5277.4 5288.7 5337.1 5575.2 5731.7 5731.9 5783.8 5794.7 5709.4 5715.1 5758.6 5769.2 5833.9 5366.7 5367.9 5368.1 5380.1 5388.0 5851.6 5876.7 5909.6 5922.3 5938.1 5687.2 5741.7 5742.1 5749.7 5760.3 5623.1 5821.4 5831.8 5833.3 5847.9 5750.5 5827.5 5834.4 5902.4 5904.1 5626.7 5651.0 5703.2 5705.2 5912.8 4337.3 4422.5 4428.6 4429.0 4465.5 3931.2 3934.2 3978.0 4005.0 4042.5 5612.7 5652.7 5654.2 5655.7 5663.0 5661.4 5792.7 5885.2 5966.7 5969.0 5580.9 5610.2 5613.4 5648.5 5679.7 5038.2 5043.9 5047.7 5058.2 5092.3 5806.7 5923.2 6023.4 6045.6 6056.4 5910.9 5916.8 5922.7 5932.3 5936.0 6067.9 6070.9 6072.3 6076.6 6088.5 5631.9 5680.1 5718.4 5787.8 5807.4 5896.8 5907.1 5914.5 5918.6 5921.1 5713.7 5739.3 5747.0 5748.9 5756.1 5567.3 5573.2 5643.7 5657.7 5684.3 5425.1 5538.2 5553.1 5601.8 5658.6 5764.0 5770.6 5791.9 5797.3 5807.4 5454.0 5545.4 5607.0 5627.7 5663.4 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#1] ext.html Cycles:180 Average:56771.88 Median:41146.69 stddev:112274.59 (272.9%) stddev-sans-first:112510.28 02:21:42 INFO - PROCESS | 20806 | Values: 578.1 613.2 616.6 624.4 640.2 43079.8 44466.6 44551.0 44611.0 47153.5 44565.0 45164.0 45236.5 45286.3 45525.5 8724.0 8862.3 8890.2 8952.7 8963.4 8741.4 8871.5 8906.5 8928.3 8942.0 8909.1 8939.9 8979.3 9001.8 9035.9 8810.8 8938.1 8943.3 9001.7 9003.5 8809.0 8869.2 8897.5 8899.0 8921.3 43256.0 43569.3 43824.1 43916.1 44090.6 3360.9 3480.4 3499.1 3596.8 3748.8 31218.5 31419.5 31860.6 32498.4 32756.0 4204.6 4221.2 4248.7 4284.5 4310.7 338985.0 339831.0 341725.0 344137.0 344146.0 32349.7 33189.0 59600.4 59625.7 59695.4 35840.6 35878.8 35925.3 35932.6 36074.1 14061.0 14087.3 14153.3 14188.7 14188.9 12538.7 12541.0 12548.1 12548.9 12559.7 8337.8 8429.2 8435.3 8487.5 8494.4 3227.2 3242.4 3247.2 3252.3 3274.9 1014.0 1017.1 1073.4 1170.1 1179.1 32691.8 33155.3 33186.3 33394.2 33530.0 1151.9 1198.3 1210.0 1255.6 1270.6 17133.3 17425.6 17427.7 17559.0 17625.6 538752.0 540636.0 542541.0 542690.0 543809.0 57714.7 59088.4 59129.4 59167.1 59183.4 1329.5 1344.9 1351.5 1370.6 1382.9 31024.2 32929.7 32997.5 33083.2 33172.5 51275.7 51324.2 51586.7 51688.0 51761.7 353196.0 355322.0 355374.0 356151.0 357026.0 28190.2 28521.3 28549.6 28581.9 28745.0 46635.3 48270.3 48293.0 49115.0 49555.0 40415.0 41421.4 41760.0 41782.8 41896.6 40774.8 41319.4 41499.0 41572.4 41655.8 40966.4 40974.0 41558.4 42071.8 43965.3 33752.0 37244.8 38082.4 38131.0 38410.2 26514.9 26969.6 27179.9 27418.2 27475.5 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#2] jquery.html Cycles:180 Average:26463.33 Median:358560.00 stddev:72372.61 (20.2%) stddev-sans-first:72549.14 02:21:42 INFO - PROCESS | 20806 | Values: 382.4 388.4 392.2 398.2 413.1 17384.3 18605.3 19259.1 19296.6 19393.4 17817.8 18293.4 18674.0 18846.0 18890.1 5641.2 5709.5 5750.9 5816.4 5822.4 5700.9 5745.3 5752.3 5774.4 5778.3 5680.9 5690.8 5716.3 6004.7 6052.7 5656.6 5865.4 5960.1 6060.6 6103.4 5616.6 5652.6 5660.1 5661.9 5663.4 13210.3 18200.0 18309.8 21272.5 21298.4 1968.0 2093.9 2216.5 2300.4 2315.5 10143.3 10195.1 10357.5 11615.4 14236.4 1841.8 1847.4 1858.5 1906.1 1968.8 74516.3 75324.0 76874.6 77356.0 77512.6 10508.9 10723.3 10801.0 10876.5 11061.7 14933.3 14949.7 15166.2 15188.0 15208.8 7751.6 7871.2 7945.9 7994.2 8110.4 7474.7 7481.4 7522.1 7603.2 7679.4 4576.1 4593.6 4646.2 4651.4 4750.8 1906.4 1949.9 1968.8 1970.6 1979.0 955.6 983.6 1036.5 1048.5 1058.9 18448.0 18553.3 19060.7 19068.5 19259.6 1018.5 1043.9 1055.9 1080.7 1087.5 6188.2 10099.9 10680.2 10698.5 10769.4 354107.0 363013.0 477040.0 479310.0 492914.0 68923.7 82039.0 90088.0 95993.5 96840.0 466.6 481.4 483.5 484.7 484.9 10877.9 11274.9 11522.6 11675.9 11694.2 29190.0 39875.0 40475.0 40641.4 41220.6 50876.5 52608.5 58215.0 58230.7 58806.0 7727.7 8213.5 8244.8 8458.1 8789.3 8994.9 11914.3 12427.1 12802.8 12834.0 10604.9 10916.8 11127.3 11183.2 11233.9 9294.5 10381.6 10823.5 11217.9 11224.6 10485.9 10737.5 10845.5 10874.4 10930.0 8497.9 8606.2 8630.7 8653.7 8661.0 9492.2 10315.6 10464.8 10488.4 10696.5 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#3] mootools.html Cycles:180 Average:5802.84 Median:4568.39 stddev:3310.01 (72.5%) stddev-sans-first:3303.50 02:21:42 INFO - PROCESS | 20806 | Values: 1499.7 1519.7 1670.7 1760.7 1794.5 7830.6 8424.4 8509.1 9085.4 9098.7 8490.1 8767.6 8768.0 8768.9 8799.6 2358.2 2380.5 2395.8 2400.1 2406.2 2284.0 2316.8 2326.3 2336.8 2338.0 2376.8 2378.4 2384.4 2408.6 2409.4 2323.7 2338.8 2350.0 2361.7 2364.3 2289.1 2311.5 2319.1 2327.5 2338.0 8762.0 8852.4 8860.5 8870.6 8879.5 5141.7 5264.2 5278.9 5281.7 5288.4 3265.0 3315.4 3394.3 3402.2 3410.0 1065.6 1073.9 1088.0 1097.3 1106.1 12328.9 12380.6 12424.9 12463.9 12473.4 4710.3 4723.9 4839.9 4855.9 4965.6 10291.5 10358.4 10358.7 10368.7 10390.7 5506.8 5519.2 5562.9 5568.4 5580.1 4380.3 4717.3 4905.0 4909.1 4933.9 4027.2 4082.7 4118.5 4153.1 4213.1 1249.9 1262.0 1278.8 1303.3 1312.8 777.0 906.9 949.6 956.2 971.8 5568.3 5619.8 5708.4 5775.7 5891.1 928.7 989.4 1004.9 1030.4 1034.6 3793.0 3955.1 3974.5 3994.2 4001.3 10541.4 10776.5 10860.5 10899.4 10906.5 10611.6 10950.2 10979.7 11003.8 11015.4 8277.8 8279.5 8334.2 8397.5 8475.4 5566.5 5626.9 5653.2 5702.6 5867.8 9595.6 10379.2 10389.4 10477.7 10481.1 10071.4 10270.9 10321.3 10391.2 10414.7 7412.2 7603.0 7984.2 8030.8 8166.5 8611.5 8622.4 8639.6 8645.6 8646.2 7572.9 7712.9 7754.9 7795.7 7978.5 7452.4 7468.7 7570.8 7587.1 7643.0 7026.3 7061.6 7084.1 7109.7 7126.8 4335.2 4479.5 4552.7 4584.1 4584.3 5034.4 5091.5 5098.2 5104.7 5161.2 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#4] prototype.html Cycles:180 Average:4779.69 Median:5439.97 stddev:1401.40 (25.8%) stddev-sans-first:1364.78 02:21:42 INFO - PROCESS | 20806 | Values: 320.9 329.5 332.3 340.3 340.6 5623.8 5664.0 5698.1 5722.8 5731.4 5528.5 5569.4 5597.5 5612.0 5628.0 4116.5 4205.1 4267.1 4305.6 4314.6 4302.2 4314.5 4315.8 4348.5 4351.6 4310.7 4323.1 4327.7 4341.5 4360.6 4023.2 4217.7 4223.3 4257.7 4338.0 3644.3 3650.2 3675.7 3676.6 3700.9 5387.2 5394.2 5434.7 5470.5 5472.5 4714.6 4939.9 4955.6 4961.3 4995.8 5875.2 5882.9 5892.9 5920.8 5955.7 4166.7 4171.9 4180.3 4183.6 4195.9 5989.2 6143.8 6191.9 6202.3 6240.8 4265.6 4279.4 4288.3 4295.4 4302.8 4325.9 4328.6 4345.9 4348.5 4368.7 4886.9 4967.5 4970.8 5003.4 5008.2 5845.6 5885.2 5886.0 5914.8 5965.4 1479.5 1498.3 1499.3 1504.7 1505.8 928.8 942.3 948.4 954.6 954.7 5070.4 5071.7 5089.7 5181.5 5203.3 5383.5 5436.4 5443.6 5450.9 5468.5 4919.5 5162.6 5184.2 5214.3 5225.9 2890.3 2892.2 2918.5 2921.3 2981.4 5282.5 5506.0 5511.3 5550.5 5561.9 5451.0 5489.9 5497.6 5498.2 5518.4 5486.2 5523.3 5553.3 5555.8 5643.9 5177.8 5403.6 5404.9 5425.3 5458.9 5395.9 5447.6 5448.6 5450.2 5456.8 5447.8 5522.5 5602.4 5610.8 5652.2 3849.3 3931.7 4207.3 4214.3 4215.5 5915.9 5943.3 6079.5 6144.3 6144.6 5907.1 5911.6 5921.8 5967.4 5981.5 5872.9 5916.1 5936.2 5940.4 5955.4 5665.3 5806.4 5845.6 5853.8 5866.3 5915.7 5966.9 5969.9 5988.0 5995.0 5727.6 5845.9 5871.4 5923.9 5930.2 02:21:42 INFO - PROCESS | 20806 | 02:21:42 INFO - PROCESS | 20806 | [#5] yui.html Cycles:180 Average:19125.82 Median:42672.77 stddev:26124.14 (61.2%) stddev-sans-first:26160.97 02:21:42 INFO - PROCESS | 20806 | Values: 743.7 786.3 819.6 830.4 843.0 14235.8 14375.8 15477.1 15710.9 15944.4 14924.4 15068.8 15166.5 15213.0 15213.6 797.1 806.2 821.8 827.2 829.4 821.5 824.9 826.9 827.8 828.1 863.1 864.0 864.5 865.2 868.4 848.0 852.0 855.0 856.2 856.7 616.4 623.2 626.6 627.7 627.8 15817.8 15853.8 15921.4 15923.8 15984.0 14096.4 14526.7 14608.0 14863.0 14933.9 12189.7 12253.9 12281.2 12312.5 12875.4 3770.6 3774.0 3942.9 4000.1 4001.1 80440.6 81877.6 81991.0 82296.6 83314.0 10893.5 11156.0 11185.5 11486.9 11905.0 20163.1 20186.4 20202.6 20209.9 20223.7 8607.6 8734.2 8765.2 8930.9 9131.5 4703.7 4771.7 4858.4 4873.3 5016.2 3652.8 3659.7 3748.7 3749.3 3769.5 588.5 596.2 601.3 609.2 614.0 629.7 715.9 725.7 730.3 744.6 9532.8 10062.9 10259.2 10340.4 10357.3 688.9 718.4 719.0 730.4 739.7 4686.3 4763.5 4781.3 4820.8 4899.4 70470.3 80869.0 94339.1 114476.0 117629.0 58674.0 59185.0 62087.4 84120.0 92919.5 77305.6 77775.0 78212.2 88821.0 91169.1 9961.5 10459.7 10469.8 10537.1 10591.7 40446.0 46113.1 49076.3 49266.0 50899.2 44899.5 45018.0 45467.5 79116.6 80890.2 13116.6 13177.2 13237.4 13332.7 13929.6 13792.5 13794.2 13958.4 14443.6 14723.2 13782.4 13846.4 13961.5 14345.9 14821.1 13842.0 13993.9 14275.9 14340.9 14733.6 13220.3 13637.9 13749.7 13830.5 14073.8 10716.6 11210.2 11283.6 11818.5 11857.8 11525.7 11548.5 11640.4 11710.5 11740.5 02:21:42 INFO - PROCESS | 20806 | -------- Summary: end -------- 02:21:42 INFO - PROCESS | 20806 | 02:21:43 INFO - TEST-INFO | 20806: exit 0 02:21:43 INFO - TEST-OK | dromaeo_css | took 1110868ms 02:21:43 INFO - TEST-START | kraken 02:21:43 INFO - operating with platform_type : linux_ 02:21:43 INFO - Initialising browser for kraken test... 02:21:43 INFO - TEST-INFO | started process 21049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr224vf/profile http://localhost:43811/getInfo.html) 02:21:47 INFO - PROCESS | 21049 | __metrics Screen width/height:1600/1200 02:21:47 INFO - PROCESS | 21049 | colorDepth:24 02:21:47 INFO - PROCESS | 21049 | Browser inner width/height: 1024/697 02:21:47 INFO - PROCESS | 21049 | __metrics 02:21:48 ERROR - PROCESS | 21049 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:21:49 INFO - TEST-INFO | 21049: exit 0 02:21:49 INFO - Browser initialized. 02:21:49 INFO - Running cycle 1/1 for kraken test... 02:21:49 INFO - TEST-INFO | started process 21169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr224vf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:01 INFO - PROCESS | 21169 | RSS: Main: 167337984 02:22:01 INFO - PROCESS | 21169 | 02:22:03 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:04 INFO - PROCESS | 21169 | RSS: Main: 172662784 02:22:04 INFO - PROCESS | 21169 | 02:22:07 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-dft) 02:22:08 INFO - PROCESS | 21169 | RSS: Main: 171720704 02:22:08 INFO - PROCESS | 21169 | 02:22:10 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-fft) 02:22:11 INFO - PROCESS | 21169 | RSS: Main: 166596608 02:22:11 INFO - PROCESS | 21169 | 02:22:13 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43811/tests/kraken/driver.html?testName=audio-oscillator) 02:22:14 INFO - PROCESS | 21169 | RSS: Main: 167915520 02:22:14 INFO - PROCESS | 21169 | 02:22:16 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:17 INFO - PROCESS | 21169 | RSS: Main: 168005632 02:22:17 INFO - PROCESS | 21169 | 02:22:20 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:20 INFO - PROCESS | 21169 | RSS: Main: 168140800 02:22:20 INFO - PROCESS | 21169 | 02:22:24 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43811/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:24 INFO - PROCESS | 21169 | RSS: Main: 166092800 02:22:24 INFO - PROCESS | 21169 | 02:22:27 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43811/tests/kraken/driver.html?testName=json-parse-financial) 02:22:28 INFO - PROCESS | 21169 | RSS: Main: 167227392 02:22:28 INFO - PROCESS | 21169 | 02:22:29 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:30 INFO - PROCESS | 21169 | RSS: Main: 167849984 02:22:30 INFO - PROCESS | 21169 | 02:22:32 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:33 INFO - PROCESS | 21169 | RSS: Main: 168095744 02:22:33 INFO - PROCESS | 21169 | 02:22:35 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:35 INFO - PROCESS | 21169 | RSS: Main: 168177664 02:22:35 INFO - PROCESS | 21169 | 02:22:38 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:39 INFO - PROCESS | 21169 | RSS: Main: 168394752 02:22:39 INFO - PROCESS | 21169 | 02:22:41 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:42 INFO - PROCESS | 21169 | RSS: Main: 168181760 02:22:42 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | Cycle 1(1): loaded http://localhost:43811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43811/tests/kraken/driver.html?testName=ai-astar) 02:22:44 INFO - PROCESS | 21169 | RSS: Main: 168919040 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | __start_tp_report 02:22:44 INFO - PROCESS | 21169 | _x_x_mozilla_page_load 02:22:44 INFO - PROCESS | 21169 | _x_x_mozilla_page_load_details 02:22:44 INFO - PROCESS | 21169 | |i|pagename|runs| 02:22:44 INFO - PROCESS | 21169 | |0;ai-astar;111;106;112;111;113;111;112;110;111;111 02:22:44 INFO - PROCESS | 21169 | |1;audio-beat-detection;155;134;155;196;125;164;161;139;180;125 02:22:44 INFO - PROCESS | 21169 | |2;audio-dft;162;162;160;161;162;165;169;160;163;161 02:22:44 INFO - PROCESS | 21169 | |3;audio-fft;74;76;75;159;76;75;75;75;163;75 02:22:44 INFO - PROCESS | 21169 | |4;audio-oscillator;85;85;141;85;85;88;134;85;85;143 02:22:44 INFO - PROCESS | 21169 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;118;119;118 02:22:44 INFO - PROCESS | 21169 | |6;imaging-darkroom;146;147;147;146;147;147;147;146;150;147 02:22:44 INFO - PROCESS | 21169 | |7;imaging-desaturate;95;98;95;95;95;96;95;96;96;98 02:22:44 INFO - PROCESS | 21169 | |8;json-parse-financial;58;59;58;58;61;59;60;59;59;57 02:22:44 INFO - PROCESS | 21169 | |9;json-stringify-tinderbox;61;61;62;60;61;61;62;62;61;61 02:22:44 INFO - PROCESS | 21169 | |10;stanford-crypto-aes;89;81;79;80;81;82;90;89;120;83 02:22:44 INFO - PROCESS | 21169 | |11;stanford-crypto-ccm;128;130;125;131;125;130;132;127;127;124 02:22:44 INFO - PROCESS | 21169 | |12;stanford-crypto-pbkdf2;161;162;164;163;162;159;164;177;161;162 02:22:44 INFO - PROCESS | 21169 | |13;stanford-crypto-sha256-iterative;67;64;64;63;65;62;69;68;63;65 02:22:44 INFO - PROCESS | 21169 | __end_tp_report 02:22:44 INFO - PROCESS | 21169 | __start_cc_report 02:22:44 INFO - PROCESS | 21169 | _x_x_mozilla_cycle_collect,876 02:22:44 INFO - PROCESS | 21169 | __end_cc_report 02:22:44 INFO - PROCESS | 21169 | __startTimestamp1465377764399__endTimestamp 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | ------- Summary: start ------- 02:22:44 INFO - PROCESS | 21169 | Number of tests: 14 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.99 02:22:44 INFO - PROCESS | 21169 | Values: 111.0 106.0 112.0 111.0 113.0 111.0 112.0 110.0 111.0 111.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:158.00 stddev:23.32 (14.8%) stddev-sans-first:24.73 02:22:44 INFO - PROCESS | 21169 | Values: 155.0 134.0 155.0 196.0 125.0 164.0 161.0 139.0 180.0 125.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.72 (1.7%) stddev-sans-first:2.88 02:22:44 INFO - PROCESS | 21169 | Values: 162.0 162.0 160.0 161.0 162.0 165.0 169.0 160.0 163.0 161.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:36.22 (48.3%) stddev-sans-first:37.81 02:22:44 INFO - PROCESS | 21169 | Values: 74.0 76.0 75.0 159.0 76.0 75.0 75.0 75.0 163.0 75.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:85.00 stddev:26.15 (30.8%) stddev-sans-first:27.04 02:22:44 INFO - PROCESS | 21169 | Values: 85.0 85.0 141.0 85.0 85.0 88.0 134.0 85.0 85.0 143.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 02:22:44 INFO - PROCESS | 21169 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 119.0 118.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 02:22:44 INFO - PROCESS | 21169 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 150.0 147.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.22 02:22:44 INFO - PROCESS | 21169 | Values: 95.0 98.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 98.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.14 (1.9%) stddev-sans-first:1.17 02:22:44 INFO - PROCESS | 21169 | Values: 58.0 59.0 58.0 58.0 61.0 59.0 60.0 59.0 59.0 57.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:22:44 INFO - PROCESS | 21169 | Values: 61.0 61.0 62.0 60.0 61.0 61.0 62.0 62.0 61.0 61.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:82.50 stddev:12.16 (14.7%) stddev-sans-first:12.88 02:22:44 INFO - PROCESS | 21169 | Values: 89.0 81.0 79.0 80.0 81.0 82.0 90.0 89.0 120.0 83.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:2.77 (2.1%) stddev-sans-first:2.93 02:22:44 INFO - PROCESS | 21169 | Values: 128.0 130.0 125.0 131.0 125.0 130.0 132.0 127.0 127.0 124.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:162.50 stddev:4.97 (3.1%) stddev-sans-first:5.19 02:22:44 INFO - PROCESS | 21169 | Values: 161.0 162.0 164.0 163.0 162.0 159.0 164.0 177.0 161.0 162.0 02:22:44 INFO - PROCESS | 21169 | 02:22:44 INFO - PROCESS | 21169 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.31 (3.6%) stddev-sans-first:2.33 02:22:44 INFO - PROCESS | 21169 | Values: 67.0 64.0 64.0 63.0 65.0 62.0 69.0 68.0 63.0 65.0 02:22:44 INFO - PROCESS | 21169 | -------- Summary: end -------- 02:22:44 INFO - PROCESS | 21169 | 02:22:45 INFO - TEST-INFO | 21169: exit 0 02:22:45 INFO - TEST-OK | kraken | took 62111ms 02:22:45 INFO - SUITE-END | took 1172s 02:22:45 INFO - Completed test suite (00:19:33) 02:22:45 INFO - javascript benchmark 02:22:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7124.39463005534, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.5380692896047, 3082.0291608143434, 3087.259057826121, 3139.497680371141, 3181.2206009527667, 5368.919466208005, 5368.919466208005, 5380.596455265856, 5405.891882162355, 5490.368607610126, 5279.656822306548, 5331.280277162582, 5348.786048558063, 5384.219288203218, 5429.56563474922, 4833.806647734095, 4859.343988561552, 4955.529224723646, 4991.950080499203, 5020.523050310215, 879.9326601752424, 4891.364122664067, 4911.189653707134, 4924.70451772893, 4970.726610036447, 4921.507849215086, 4931.112399768041, 4945.480724523927, 4953.925691114636, 4997.850064498053, 4783.234682450791, 4965.627577931669, 4982.451930287665, 4993.725345106018, 5020.447750747415, 4802.663813533054, 4810.134175848346, 4815.903681926342, 4816.373871396696, 4842.467328593852, 5185.818496352647, 5236.345456817898, 5277.419483856773, 5288.68267903927, 5337.146056630921, 5575.163725441216, 5731.742071606787, 5731.856703582402, 5783.843231353746, 5794.739236734357, 5709.400512946122, 5715.0855863062125, 5758.596898217126, 5769.163471296681, 5833.912491312633, 5366.731663416853, 5367.892642147135, 5368.114261146906, 5380.058489764276, 5388.030154572215, 5851.561132914963, 5876.706164691748, 5909.645421274738, 5922.289325280908, 5938.138969849348, 5687.232223649837, 5741.684207368635, 5742.052561327418, 5749.655020698771, 5760.308762948473, 5623.100303951348, 5821.359650438449, 5831.766729330864, 5833.270841144857, 5847.9415205848245, 5750.511206547407, 5827.475527202572, 5834.416558344216, 5902.439268269593, 5904.0553511437965, 5626.718664066781, 5650.971745141248, 5703.230063941398, 5705.229793977843, 5912.763489460373, 4337.284348082594, 4422.513523512411, 4428.55714428561, 4428.955710442919, 4465.464144302705, 3931.233409485123, 3934.1738234970976, 3978.0452691353867, 4005.0, 4042.4946881639794, 5612.747426365741, 5652.717364131777, 5654.208410822488, 5655.717214139277, 5662.971685141548, 5661.433856614306, 5792.710364481759, 5885.205497257815, 5966.701664916737, 5969.04495280753, 5580.9441905580425, 5610.158476228598, 5613.410591887875, 5648.463395977457, 5679.6876171810945, 5038.2190760432195, 5043.949560504348, 5047.722375269322, 5058.215976523645, 5092.312537807348, 5806.709664516758, 5923.229980102559, 6023.367546407651, 6045.6070355426755, 6056.36408177135, 5910.940890591039, 5916.822495325147, 5922.73347699346, 5932.258467691625, 5936.0, 6067.878642427038, 6070.939290607214, 6072.332043475302, 6076.635401875901, 6088.543359247986, 5631.88736225265, 5680.147977803363, 5718.370979192368, 5787.768489260382, 5807.419258074327, 5896.764129434946, 5907.113932910098, 5914.526837852875, 5918.615290006136, 5921.052631578927, 5713.714314284352, 5739.253896993364, 5747.0, 5748.885022299447, 5756.136579513107, 5567.331920169606, 5573.1918871762555, 5643.71781410936, 5657.688827114548, 5684.346300175533, 5425.13197888336, 5538.224648549126, 5553.139263414178, 5601.795613943022, 5658.603897727119, 5764.0201165802755, 5770.567207459373, 5791.884162316815, 5797.304323481209, 5807.390224026585, 5454.045542030208, 5545.417731138334, 5607.0, 5627.718614069198, 5663.405342438985], "value": 5322.862163338719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1039388947131, 613.2089604410311, 616.5591602004566, 624.4130517313728, 640.2349192714705, 43079.784601076986, 44466.55533444669, 44551.0, 44611.0, 47153.528464715346, 44565.0, 45164.0, 45236.547634523726, 45286.32070518945, 45525.54474455254, 8723.956380218106, 8862.33532485063, 8890.155435233642, 8952.686655967042, 8963.41737787045, 8741.431806932529, 8871.512066836322, 8906.51014194219, 8928.330375221884, 8941.95529022354, 8909.06454822244, 8939.910600894005, 8979.281657467387, 9001.77495562613, 9035.909640903572, 8810.779730506725, 8938.106189381075, 8943.32925030622, 9001.739756434039, 9003.459792412476, 8809.0, 8869.246114080312, 8897.466152030898, 8899.0, 8921.330900182513, 43256.0, 43569.34645980313, 43824.12351752947, 43916.12167756627, 44090.55909440896, 3360.932781344384, 3480.4083305838067, 3499.125218695326, 3596.82015899204, 3748.7938163401004, 31218.53172202419, 31419.528707069414, 31860.599963326084, 32498.350032999446, 32756.0, 4204.558521355275, 4221.197972385237, 4248.702590818644, 4284.485861696585, 4310.676699247569, 338985.0, 339831.0, 341725.0, 344137.0, 344145.9999999975, 32349.676503235136, 33189.0, 59600.40399595949, 59625.70187149037, 59695.40304596898, 35840.64159358425, 35878.820605896806, 35925.28149436996, 35932.64067359345, 36074.09814754652, 14061.0, 14087.295635218197, 14153.29233538319, 14188.716225675635, 14188.85811141896, 12538.749225015448, 12541.0, 12548.12163148589, 12548.874511254953, 12559.686007849878, 8337.833243335099, 8429.157084291523, 8435.325173986066, 8487.533185674847, 8494.405391622651, 3227.193201699575, 3242.3515296940705, 3247.236899328656, 3252.3332716793, 3274.8690052398115, 1014.0214692821463, 1017.0541396501325, 1073.414988831089, 1170.1399471388522, 1179.1000298003412, 32691.836540817618, 33155.336893262, 33186.3362732744, 33394.16514587155, 33530.0, 1151.9193656443967, 1198.3169593331718, 1210.0198838940487, 1255.6358655989661, 1270.6251655761573, 17133.314667413164, 17425.564360890825, 17427.65144697099, 17559.0, 17625.647487050188, 538752.0, 540636.0, 542541.0, 542690.0, 543809.0, 57714.71142644344, 59088.40911590915, 59129.40870591239, 59167.112493312634, 59183.40816591865, 1329.547953695748, 1344.87223713749, 1351.4526616720243, 1370.5614203454998, 1382.9151732377618, 31024.22439439032, 32929.67070329266, 32997.50503742494, 33083.17292067718, 33172.488010988876, 51275.743621281654, 51324.20365287197, 51586.74206628943, 51688.0, 51761.741191293804, 353196.0, 355322.0, 355374.0, 356151.0, 357026.0, 28190.154295371172, 28521.28696782597, 28549.571756424084, 28581.857090714413, 28745.0, 46635.30047049365, 48270.27594586154, 48293.0, 49115.0, 49555.0, 40415.0, 41421.378679320434, 41760.0, 41782.79108604437, 41896.581034189265, 40774.79612601918, 41319.38020929749, 41499.0, 41572.37641435441, 41655.7917210412, 40966.385504216865, 40974.0, 41558.37662435006, 42071.78964105283, 43965.34051989287, 33752.0, 37244.81377593203, 38082.428763568016, 38131.0, 38410.231795363376, 26514.86742566275, 26969.595456068568, 27179.864100680163, 27418.17745467639, 27475.450490990468], "value": 18872.937388701288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.37099970548456, 388.4425848906817, 392.1666458775103, 398.2095540352401, 413.1241767453, 17384.304627814887, 18605.348812791555, 19259.133338999745, 19296.614067718656, 19393.418197454062, 17817.821821781778, 18293.359732409368, 18674.0, 18846.0, 18890.055497225152, 5641.153826925974, 5709.457601527869, 5750.942490575083, 5816.360200377976, 5822.388649191837, 5700.914486282709, 5745.339285982123, 5752.28096487939, 5774.364819869811, 5778.306603207621, 5680.943190568083, 5690.829275121753, 5716.3426205986425, 6004.669743164124, 6052.667103309316, 5656.575756818214, 5865.413458654143, 5960.105984102398, 6060.636361818305, 6103.420175083382, 5616.606837521375, 5652.604317697722, 5660.122680984454, 5661.886762264773, 5663.405342439026, 13210.33948302581, 18200.0, 18309.809862358903, 21272.46818829526, 21298.36104916855, 1967.9508012299807, 2093.8534302598823, 2216.5456081503253, 2300.3559003479054, 2315.4790172211287, 10143.340682855665, 10195.133413659847, 10357.533910974023, 11615.419229038514, 14236.35936382855, 1841.7974022857475, 1847.3534263007973, 1858.4889155482215, 1906.094605062598, 1968.7932767059397, 74516.25483745147, 75324.0, 76874.61562692151, 77356.0, 77512.61243693746, 10508.947455262674, 10723.30298530593, 10801.0, 10876.510557024953, 11061.723456913642, 14933.328000239799, 14949.70100597982, 15166.24168791556, 15188.0, 15208.771868421982, 7751.573663448565, 7871.173526779606, 7945.920540794634, 7994.160613135653, 8110.391720620977, 7474.663640136207, 7481.438892083115, 7522.097348318237, 7603.163651998276, 7679.424043196783, 4576.146660602461, 4593.609543188866, 4646.23443091623, 4651.37206477128, 4750.786214620351, 1906.418542344598, 1949.8927558984108, 1968.842492600617, 1970.6354324449735, 1978.9901050494943, 955.5938726041404, 983.6311383231289, 1036.4921188617523, 1048.4862666221836, 1058.867641544807, 18448.0, 18553.25786968506, 19060.71408928867, 19068.523286917938, 19259.61480770405, 1018.4773763224027, 1043.9269251152346, 1055.883852776194, 1080.6811990462832, 1087.537796436527, 6188.164597779242, 10099.899001009895, 10680.198985075995, 10698.465076746132, 10769.353838769699, 354107.0, 363013.0, 477040.0, 479310.0344982807, 492914.0, 68923.65538172277, 82039.0, 90088.0, 95993.52003240079, 96840.0, 466.55677106748726, 481.35017726070225, 483.4971629505275, 484.72612973669766, 484.8763565290899, 10877.945610271898, 11274.943625281821, 11522.596709115141, 11675.941620291844, 11694.181407301747, 29190.0, 39875.0, 40475.0, 40641.39037914375, 41220.587794121675, 50876.491235087175, 52608.47391526036, 58215.0, 58230.7088464555, 58806.0, 7727.652255648622, 8213.54825484604, 8244.793880152803, 8458.111898250841, 8789.340799440195, 8994.910050899669, 11914.285142891455, 12427.130100893213, 12802.807957880454, 12834.037447191311, 10604.89395106039, 10916.781664366827, 11127.276727012719, 11183.161262905478, 11233.943830280796, 9294.466413041773, 10381.584736610452, 10823.51294191779, 11217.943910280397, 11224.551017959517, 10485.9475702621, 10737.46312684347, 10845.511951962339, 10874.401907895142, 10930.0, 8497.87253191215, 8606.182412670787, 8630.741077767678, 8653.69712060075, 8661.003984541607, 9492.193163580896, 10315.638952636622, 10464.790704186025, 10488.370697758159, 10696.518656660313], "value": 8624.693899637217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.655079331754, 1519.7188520123777, 1670.690922179397, 1760.683077046133, 1794.4796009157344, 7830.647620857061, 8424.368172387065, 8509.064002959669, 9085.40944838585, 9098.727038188865, 8490.066092729794, 8767.649294028248, 8768.0, 8768.868466973001, 8799.56002199889, 2358.1746388763922, 2380.547695937766, 2395.8203134764963, 2400.135951057618, 2406.2300063979533, 2284.017872314904, 2316.779905908936, 2326.2672258238686, 2336.836421450499, 2338.0297176671747, 2376.7504412036747, 2378.3935096550354, 2384.4277373430427, 2408.6266628672497, 2409.361519197414, 2323.6514522821626, 2338.75443078476, 2349.9647505287435, 2361.728401233854, 2364.2670772060715, 2289.107248173214, 2311.5376924614975, 2319.060780383947, 2327.522857814144, 2337.9829774048344, 8762.0, 8852.424592401474, 8860.468371897707, 8870.556472176366, 8879.467231966039, 5141.717205553693, 5264.184051472028, 5278.947210527884, 5281.735913204363, 5288.391834938992, 3264.983675081633, 3315.370079684852, 3394.287199688044, 3402.1834759657504, 3409.9659003409897, 1065.6217042949797, 1073.88187299397, 1088.0, 1097.2922465010104, 1106.0985296982933, 12328.938355308166, 12380.566680166152, 12424.875751242553, 12463.875361246362, 12473.376331183405, 4710.257204834164, 4723.858284251478, 4839.854804355875, 4855.927161092586, 4965.602751779849, 10291.53688084038, 10358.378497290187, 10358.741031474274, 10368.688939331832, 10390.688279351632, 5506.807261745819, 5519.199716041152, 5562.888742225214, 5568.359638641527, 5580.051391263495, 4380.255356589388, 4717.268823332389, 4905.043516514317, 4909.091818013679, 4933.9013219736125, 4027.154297597479, 4082.7346222495444, 4118.496034757211, 4153.1486045360625, 4213.115245798355, 1249.906257030708, 1262.0156278103095, 1278.7634287656813, 1303.2766814417898, 1312.8162057311984, 777.0287141073658, 906.9162350990634, 949.6154057606681, 956.1633570625703, 971.7959228562081, 5568.276124103841, 5619.8033068843215, 5708.372079071299, 5775.6823374714795, 5891.145783861316, 928.6888892221046, 989.4113002763344, 1004.9497525123714, 1030.350878946274, 1034.567124532528, 3792.981035094807, 3955.149642826806, 3974.463447434617, 3994.1612261425425, 4001.2597669431248, 10541.420221887716, 10776.515056822462, 10860.511276992554, 10899.400532970763, 10906.454677266105, 10611.628592999208, 10950.178736594788, 10979.670609881716, 11003.834942475869, 11015.449227538751, 8277.793055173668, 8279.54462504556, 8334.249917507454, 8397.538135402488, 8475.406721529434, 5566.526845218202, 5626.943730562642, 5653.152027195953, 5702.572307076903, 5867.823965281048, 9595.568199430903, 10379.169666426516, 10389.428581428094, 10477.68566942993, 10481.109105726098, 10071.395716257048, 10270.897291027293, 10321.329113607591, 10391.168706503613, 10414.739631509274, 7412.184659687322, 7602.973598564123, 7984.24149705777, 8030.759077227693, 8166.510009399455, 8611.526366049928, 8622.396432249683, 8639.568021599021, 8645.610947507252, 8646.178613031752, 7572.886406703794, 7712.884306735516, 7754.92245077542, 7795.688172473037, 7978.481398709066, 7452.366548843409, 7468.701251949861, 7570.772876813704, 7587.089549254125, 7643.0, 7026.297370262932, 7061.611611361424, 7084.079069720903, 7109.680064397218, 7126.750563730245, 4335.176316499855, 4479.484859241099, 4552.726836389827, 4584.060267645058, 4584.289435137559, 5034.395872495324, 5091.465396133352, 5098.2352647103235, 5104.719240441811, 5161.174212126042], "value": 4644.407069441157, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.887689308742, 329.50574138791814, 332.3170883833722, 340.32785249132957, 340.5623773451115, 5623.77504899804, 5664.0459041630575, 5698.116791897252, 5722.79970201043, 5731.369549349573, 5528.5024347808685, 5569.415211402805, 5597.537083683187, 5611.971940140294, 5627.971860140704, 4116.464859568252, 4205.074883525619, 4267.146570685875, 4305.590968857953, 4314.568543145691, 4302.247106756321, 4314.525402205755, 4315.82736690532, 4348.543402942693, 4351.5648435156545, 4310.6551475882015, 4323.119443042271, 4327.7186982846015, 4341.50072741634, 4360.6293465055505, 4023.2355852387955, 4217.662586993033, 4223.260929337384, 4257.74453532789, 4337.9566204338025, 3644.344018076745, 3650.1604630934767, 3675.713500274909, 3676.613955534684, 3700.85196592136, 5387.218853266294, 5394.244805727201, 5434.701091439969, 5470.5350045246205, 5472.534834539069, 4714.5521175488275, 4939.925901111486, 4955.578775804061, 4961.255811628249, 4995.775190116454, 5875.236219291507, 5882.911756323616, 5892.911606325909, 5920.763169473216, 5955.702214889281, 4166.708330416872, 4171.937420938689, 4180.289350810339, 4183.644390226835, 4195.91608167835, 5989.191459153046, 6143.84640383994, 6191.907121393183, 6202.317745048041, 6240.750369985195, 4265.573442655709, 4279.379489973999, 4288.270993931039, 4295.4201182839915, 4302.849400270976, 4325.913481730411, 4328.588784065509, 4345.87052344349, 4348.5211830535445, 4368.672349573794, 4886.902261954741, 4967.503249675004, 4970.801167953314, 5003.449620541737, 5008.248762685626, 5845.620034697731, 5885.2349194605285, 5885.970570147122, 5914.792982245601, 5965.433283838029, 1479.5191562741936, 1498.3107770425727, 1499.3402902722767, 1504.653929596199, 1505.7741338799267, 928.8188803183315, 942.2556180617236, 948.4309414351334, 954.5799848066829, 954.6610953111684, 5070.363411026246, 5071.721055341992, 5089.720065396365, 5181.5077567631015, 5203.297554830049, 5383.515483606494, 5436.374816896028, 5443.564514838803, 5450.91823622646, 5468.48049435303, 4919.4834542373255, 5162.6386152968935, 5184.248283998874, 5214.296070030573, 5225.869353266123, 2890.2774306423394, 2892.2335581071034, 2918.4746745585576, 2921.3134913295357, 2981.3739114785703, 5282.498162674539, 5505.9724701376235, 5511.255980442669, 5550.528205102531, 5561.915426491876, 5450.964316779799, 5489.945100549024, 5497.587680923947, 5498.230247765316, 5518.420565840609, 5486.204500347507, 5523.28197334352, 5553.250311208016, 5555.805546805843, 5643.927653745775, 5177.792888284426, 5403.594730395314, 5404.891902162013, 5425.345269692623, 5458.918116228339, 5395.892082158413, 5447.618666693452, 5448.56411487088, 5450.236966824568, 5456.809011684572, 5447.782088716565, 5522.475364840334, 5602.355729091044, 5610.84977579587, 5652.19129878435, 3849.3071247175776, 3931.682886233144, 4207.347861081537, 4214.262504061839, 4215.473065866767, 5915.852103697442, 5943.346231914573, 6079.50740196535, 6144.293406258337, 6144.631322120687, 5907.143464197753, 5911.645301281937, 5921.763129474945, 5967.37342579023, 5981.517670166832, 5872.882542349214, 5916.053431450947, 5936.1986131871645, 5940.376260492586, 5955.374685657944, 5665.291838520185, 5806.390329015392, 5845.649261044351, 5853.795117170878, 5866.266716660418, 5915.674637894957, 5966.850828729316, 5969.91045134332, 5988.0, 5995.0407934731975, 5727.570432217517, 5845.941540584709, 5871.442212989759, 5923.851903702442, 5930.199423077829], "value": 4329.958031971071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.735973729326, 786.3237615650543, 819.5574389829493, 830.4062595244399, 843.0429077027081, 14235.78646320306, 14375.784363234547, 15477.071375717465, 15710.92144539277, 15944.362225510995, 14924.403023879031, 15068.849311506881, 15166.545003649908, 15213.0, 15213.619659508518, 797.0913158998746, 806.2381049907825, 821.8438496685641, 827.2058823529389, 829.4484168028254, 821.5481485183155, 824.9257566818985, 826.89663792026, 827.8178800663844, 828.1097819843662, 863.1109956744563, 863.9611217495228, 864.511550973701, 865.2429124516049, 868.4398562926908, 847.9957600212022, 851.9829603407898, 854.9786255343635, 856.1652388920784, 856.7130011446174, 616.3682225718629, 623.1680706257152, 626.6396821827421, 627.6892937995722, 627.7551754815626, 15817.762733559006, 15853.841461585353, 15921.363145474166, 15923.761143582855, 15984.0, 14096.436142554285, 14526.70946581073, 14608.0, 14863.0, 14933.925330373388, 12189.65913749487, 12253.877461225451, 12281.201721888048, 12312.507499700001, 12875.420606072656, 3770.5852356240794, 3773.9998900291444, 3942.921141577181, 4000.139969906455, 4001.099752555681, 80440.59779701065, 81877.59061204715, 81991.0, 82296.58851705764, 83313.99999999939, 10893.509792059376, 11155.970253404317, 11185.496652650487, 11486.94256528712, 11905.047596192284, 20163.092660830298, 20186.39440816778, 20202.595948080954, 20209.898950505154, 20223.696644550047, 8607.61265743043, 8734.170253826003, 8765.167309105625, 8930.86603700945, 9131.452112873249, 4703.717776933327, 4771.73755443447, 4858.392700912386, 4873.31773551703, 5016.172331565251, 3652.8356223969986, 3659.6523330284112, 3748.737588368788, 3749.2688925659236, 3769.5288088988877, 588.485075558886, 596.2040675697991, 601.2844714789474, 609.1684850179473, 613.9877202455926, 629.6788637794758, 715.9069320988239, 725.7278520554792, 730.3390431659357, 744.5793126883293, 9532.809343813085, 10062.899371006342, 10259.230557708053, 10340.37957722539, 10357.274990750575, 688.896665500179, 718.3714250031222, 718.9964050179716, 730.3828265115968, 739.7078154129089, 4686.3204835299375, 4763.45220299663, 4781.258904869681, 4820.783064762094, 4899.363082799213, 70470.29529704637, 80869.0, 94339.05660943303, 114476.0, 117629.0, 58674.0, 59185.0, 62087.37912620906, 84120.0, 92919.5354023239, 77305.61347193229, 77775.0, 78212.21787782163, 88821.0, 91169.08830911606, 9961.50192490387, 10459.738506537398, 10469.790604188025, 10537.104346130665, 10591.735206619587, 40446.0, 46113.07773844572, 49076.263856042904, 49266.0, 50899.2365114531, 44899.53052582139, 45018.0, 45467.54532454633, 79116.60441697754, 80890.19109808827, 13116.606501804961, 13177.212159898068, 13237.40431680596, 13332.666683332995, 13929.58211253664, 13792.517261895786, 13794.241316727675, 13958.441662333393, 14443.566692999228, 14723.190224537753, 13782.379792909143, 13846.376913038735, 13961.511347102803, 14345.856541434452, 14821.110733356034, 13842.0, 13993.93003035019, 14275.928620356832, 14340.856591433952, 14733.55799326022, 13220.272884991418, 13637.863621364057, 13749.656258593615, 13830.515931942333, 14073.788893166406, 10716.571337146426, 11210.215284929976, 11283.633042358622, 11818.468168932246, 11857.822132667845, 11525.654230373102, 11548.48031838586, 11640.35978021217, 11710.531578736754, 11740.519654224223], "value": 7504.202694641444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 111.0, 113.0, 111.0, 112.0, 110.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 155.0, 196.0, 125.0, 164.0, 161.0, 139.0, 180.0, 125.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 162.0, 165.0, 169.0, 160.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 159.0, 76.0, 75.0, 75.0, 75.0, 163.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 141.0, 85.0, 85.0, 88.0, 134.0, 85.0, 85.0, 143.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 150.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 98.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 61.0, 59.0, 60.0, 59.0, 59.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 79.0, 80.0, 81.0, 82.0, 90.0, 89.0, 120.0, 83.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 125.0, 131.0, 125.0, 130.0, 132.0, 127.0, 127.0, 124.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 163.0, 162.0, 159.0, 164.0, 177.0, 161.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 63.0, 65.0, 62.0, 69.0, 68.0, 63.0, 65.0], "value": 65.0, "unit": "score"}]}]} 02:22:45 INFO - Return code: 0 02:22:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:45 ERROR - # TBPL SUCCESS # 02:22:45 INFO - Running post-action listener: _resource_record_post_action 02:22:45 INFO - ##### 02:22:45 INFO - ##### Finished run-tests step (success) 02:22:45 INFO - ##### 02:22:45 INFO - Running post-run listener: _resource_record_post_run 02:22:45 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 4096; Write bytes: 540917760; Read time: 28; Write time: 543904 02:22:45 INFO - TinderboxPrint: CPU usage
13.5% 02:22:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 02:22:45 INFO - TinderboxPrint: I/O write bytes / time
540,917,760 / 543,904 02:22:45 INFO - TinderboxPrint: CPU idle
8,215.0 (86.4%) 02:22:45 INFO - TinderboxPrint: CPU user
1,229.9 (12.9%) 02:22:45 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248164352; Read time: 0; Write time: 244128 02:22:45 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292753408; Read time: 28; Write time: 299776 02:22:46 INFO - Running post-run listener: _upload_blobber_files 02:22:46 INFO - Blob upload gear active. 02:22:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:46 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 02:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:46 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:47 INFO - (blobuploader) - INFO - Done attempting. 02:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:48 INFO - (blobuploader) - INFO - Done attempting. 02:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:52 INFO - (blobuploader) - INFO - Done attempting. 02:22:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:52 INFO - Return code: 0 02:22:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ce7a321761eb56abb0ee2caf6a49880659f13b6341271bd926eb2a37fa65b76df8d7f111432986d50e8681bac4f1021b90e97c625deac4ff66e8dce585d3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39f725394f8ccbe8f56f7707b2ad916e3e48a7fea041db0f9853071dd07bf3b2a9feb312c0738d21c7aa27cb7d2af8283b1f25a6ca6593990078401cfc039956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956accb8b22b4b4fffc33e485a1128ce0f895395a1288c4b8614c30748878c0f30ae647de79890f60299b14e62f55f1b43694cd743af43239a035fa1ae4ae8dd"} 02:22:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:52 INFO - Contents: 02:22:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ce7a321761eb56abb0ee2caf6a49880659f13b6341271bd926eb2a37fa65b76df8d7f111432986d50e8681bac4f1021b90e97c625deac4ff66e8dce585d3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39f725394f8ccbe8f56f7707b2ad916e3e48a7fea041db0f9853071dd07bf3b2a9feb312c0738d21c7aa27cb7d2af8283b1f25a6ca6593990078401cfc039956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956accb8b22b4b4fffc33e485a1128ce0f895395a1288c4b8614c30748878c0f30ae647de79890f60299b14e62f55f1b43694cd743af43239a035fa1ae4ae8dd"} 02:22:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:52 INFO - Copying logs to upload dir... 02:22:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.363187 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-08 02:22:52.099011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:52.103671) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ce7a321761eb56abb0ee2caf6a49880659f13b6341271bd926eb2a37fa65b76df8d7f111432986d50e8681bac4f1021b90e97c625deac4ff66e8dce585d3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39f725394f8ccbe8f56f7707b2ad916e3e48a7fea041db0f9853071dd07bf3b2a9feb312c0738d21c7aa27cb7d2af8283b1f25a6ca6593990078401cfc039956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956accb8b22b4b4fffc33e485a1128ce0f895395a1288c4b8614c30748878c0f30ae647de79890f60299b14e62f55f1b43694cd743af43239a035fa1ae4ae8dd"} build_url:https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ce7a321761eb56abb0ee2caf6a49880659f13b6341271bd926eb2a37fa65b76df8d7f111432986d50e8681bac4f1021b90e97c625deac4ff66e8dce585d3810", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39f725394f8ccbe8f56f7707b2ad916e3e48a7fea041db0f9853071dd07bf3b2a9feb312c0738d21c7aa27cb7d2af8283b1f25a6ca6593990078401cfc039956", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/956accb8b22b4b4fffc33e485a1128ce0f895395a1288c4b8614c30748878c0f30ae647de79890f60299b14e62f55f1b43694cd743af43239a035fa1ae4ae8dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:52.131469) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:52.131801) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465375109.955971-151294980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:52.181071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 02:22:52.181411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 02:22:52.181701) ========= ========= Total master_lag: 0.17 =========