builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1465636645.37 results: success (0) buildid: 20160611012225 builduid: 28111c48a0af4699be722304839a2279 revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.367374) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.368058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.368361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.384017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.384301) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 02:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-06-11 02:17:26 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.537476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.537798) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017368 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.588042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:25.588377) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9694e371363590c8dace6629dc4d57f1af7206f2 --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 9694e371363590c8dace6629dc4d57f1af7206f2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 02:17:26,154 truncating revision to first 12 chars 2016-06-11 02:17:26,154 Setting DEBUG logging. 2016-06-11 02:17:26,154 attempt 1/10 2016-06-11 02:17:26,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9694e3713635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 02:17:26,451 unpacking tar archive at: fx-team-9694e3713635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:26.219801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:26.220181) ========= script_repo_revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:26.220686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:26.221003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:17:26.230437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-11 02:17:26.230862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:26 INFO - MultiFileLogger online at 20160611 02:17:26 in /builds/slave/test 02:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:26 INFO - {'append_to_log': False, 02:17:26 INFO - 'base_work_dir': '/builds/slave/test', 02:17:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:26 INFO - 'config_files': ('talos/linux_config.py',), 02:17:26 INFO - 'default_actions': ('clobber', 02:17:26 INFO - 'read-buildbot-config', 02:17:26 INFO - 'download-and-extract', 02:17:26 INFO - 'populate-webroot', 02:17:26 INFO - 'create-virtualenv', 02:17:26 INFO - 'install', 02:17:26 INFO - 'run-tests'), 02:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:26 INFO - 'download_minidump_stackwalk': True, 02:17:26 INFO - 'download_symbols': 'ondemand', 02:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:26 INFO - 'installer_path': 'installer.exe', 02:17:26 INFO - 'log_level': 'info', 02:17:26 INFO - 'log_name': 'talos', 02:17:26 INFO - 'log_to_console': True, 02:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:26 INFO - 'opt_config_files': (), 02:17:26 INFO - 'pip_index': False, 02:17:26 INFO - 'sps_profile': False, 02:17:26 INFO - 'sps_profile_interval': 0, 02:17:26 INFO - 'suite': 'dromaeojs', 02:17:26 INFO - 'system_bits': '32', 02:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:26 INFO - 'title': 'talos-linux64-ix-025', 02:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:26 INFO - 'use_talos_json': True, 02:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:26 INFO - 'work_dir': 'build'} 02:17:26 INFO - ##### 02:17:26 INFO - ##### Running clobber step. 02:17:26 INFO - ##### 02:17:26 INFO - Running pre-action listener: _resource_record_pre_action 02:17:26 INFO - Running main action method: clobber 02:17:26 INFO - rmtree: /builds/slave/test/build 02:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:27 INFO - Running post-action listener: _resource_record_post_action 02:17:27 INFO - ##### 02:17:27 INFO - ##### Finished clobber step (success) 02:17:27 INFO - ##### 02:17:27 INFO - ##### 02:17:27 INFO - ##### Running read-buildbot-config step. 02:17:27 INFO - ##### 02:17:27 INFO - Running pre-action listener: _resource_record_pre_action 02:17:27 INFO - Running main action method: read_buildbot_config 02:17:27 INFO - Using buildbot properties: 02:17:27 INFO - { 02:17:27 INFO - "project": "", 02:17:27 INFO - "product": "firefox", 02:17:27 INFO - "script_repo_revision": "production", 02:17:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:17:27 INFO - "repository": "", 02:17:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:17:27 INFO - "buildid": "20160611012225", 02:17:27 INFO - "pgo_build": "False", 02:17:27 INFO - "basedir": "/builds/slave/test", 02:17:27 INFO - "buildnumber": 1849, 02:17:27 INFO - "slavename": "talos-linux64-ix-025", 02:17:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:17:27 INFO - "platform": "ubuntu64_hw", 02:17:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:17:27 INFO - "branch": "fx-team", 02:17:27 INFO - "repo_path": "integration/fx-team", 02:17:27 INFO - "revision": "9694e371363590c8dace6629dc4d57f1af7206f2", 02:17:27 INFO - "stage_platform": "linux64", 02:17:27 INFO - "builduid": "28111c48a0af4699be722304839a2279", 02:17:27 INFO - "slavebuilddir": "test" 02:17:27 INFO - } 02:17:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:17:27 INFO - Running post-action listener: _resource_record_post_action 02:17:27 INFO - ##### 02:17:27 INFO - ##### Finished read-buildbot-config step (success) 02:17:27 INFO - ##### 02:17:27 INFO - ##### 02:17:27 INFO - ##### Running download-and-extract step. 02:17:27 INFO - ##### 02:17:27 INFO - Running pre-action listener: _resource_record_pre_action 02:17:27 INFO - Running main action method: download_and_extract 02:17:27 INFO - mkdir: /builds/slave/test/build/tests 02:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:27 INFO - https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:30 INFO - Downloaded 1361 bytes. 02:17:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:30 INFO - Using the following test package requirements: 02:17:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'jsshell-linux-x86_64.zip'], 02:17:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17:30 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:17:30 INFO - https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:38 INFO - Downloaded 22891347 bytes. 02:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:17:39 INFO - Return code: 0 02:17:39 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:17: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:17:39 INFO - https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:42 INFO - Downloaded 22891347 bytes. 02:17:42 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:17:42 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:17:43 INFO - Return code: 0 02:17: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:17:43 INFO - https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:44 INFO - Downloaded 10833377 bytes. 02:17:44 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:17:44 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:17:44 INFO - Return code: 0 02:17:44 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:17:44 INFO - https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XnXXnmyNSPuCzKivBYmGTw/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:17:46 INFO - Downloaded 55399095 bytes. 02:17:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:17:46 INFO - mkdir: /builds/slave/test/properties 02:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:46 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:46 INFO - Contents: 02:17:46 INFO - build_url:https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:17:47 INFO - Running post-action listener: _resource_record_post_action 02:17:47 INFO - Running post-action listener: set_extra_try_arguments 02:17:47 INFO - ##### 02:17:47 INFO - ##### Finished download-and-extract step (success) 02:17:47 INFO - ##### 02:17:47 INFO - ##### 02:17:47 INFO - ##### Running populate-webroot step. 02:17:47 INFO - ##### 02:17:47 INFO - Running pre-action listener: _resource_record_pre_action 02:17:47 INFO - Running main action method: populate_webroot 02:17:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:17:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:17:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:17:47 INFO - '--tppagecycles', 02:17:47 INFO - '7'], 02:17:47 INFO - 'tests': ['tsvgm']}}, 02:17:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:17:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:17:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:17:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:17:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['damp', 'tps']}, 02:17:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'tests': ['damp', 'tps']}, 02:17:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['dromaeo_dom']}, 02:17:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'other-e10s': {'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['a11yr', 02:17:47 INFO - 'ts_paint', 02:17:47 INFO - 'tpaint', 02:17:47 INFO - 'sessionrestore', 02:17:47 INFO - 'sessionrestore_no_auto_restore', 02:17:47 INFO - 'tabpaint']}, 02:17:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['tsvgx', 02:17:47 INFO - 'tsvgr_opacity', 02:17:47 INFO - 'tart', 02:17:47 INFO - 'tscrollx', 02:17:47 INFO - 'cart']}, 02:17:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:17:47 INFO - 'tsvgr_opacity', 02:17:47 INFO - 'tart', 02:17:47 INFO - 'tscrollx', 02:17:47 INFO - 'cart']}, 02:17:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'talos_options': ['--disable-e10s'], 02:17:47 INFO - 'tests': ['tp5o']}, 02:17:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'tests': ['tp5o']}, 02:17:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'talos_options': ['--disable-e10s', 02:17:47 INFO - '--xperf_path', 02:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:47 INFO - 'tests': ['tp5n']}, 02:17:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:47 INFO - 'talos_options': ['--xperf_path', 02:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:47 INFO - 'tests': ['tp5n']}}, 02:17:47 INFO - 'talos.zip': {'path': '', 02:17:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:17:47 INFO - Running post-action listener: _resource_record_post_action 02:17:47 INFO - ##### 02:17:47 INFO - ##### Finished populate-webroot step (success) 02:17:47 INFO - ##### 02:17:47 INFO - ##### 02:17:47 INFO - ##### Running create-virtualenv step. 02:17:47 INFO - ##### 02:17:47 INFO - Running pre-action listener: _resource_record_pre_action 02:17:47 INFO - Running main action method: create_virtualenv 02:17:47 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:47 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:17:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:17:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:47 INFO - Using real prefix '/usr' 02:17:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:49 INFO - Installing pip.................done. 02:17:49 INFO - Return code: 0 02:17:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:17:49 INFO - Using env: {'DISPLAY': ':0', 02:17:49 INFO - 'HOME': '/home/cltbld', 02:17:49 INFO - 'LANG': 'en_US.UTF-8', 02:17:49 INFO - 'LANGUAGE': 'en_US:en', 02:17:49 INFO - 'LOGNAME': 'cltbld', 02:17:49 INFO - 'MAIL': '/var/mail/cltbld', 02:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:49 INFO - 'MOZ_NO_REMOTE': '1', 02:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:49 INFO - 'NO_EM_RESTART': '1', 02:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:49 INFO - 'PWD': '/builds/slave/test', 02:17:49 INFO - 'SHELL': '/bin/bash', 02:17:49 INFO - 'SHLVL': '1', 02:17:49 INFO - 'TERM': 'linux', 02:17:49 INFO - 'TMOUT': '86400', 02:17:49 INFO - 'USER': 'cltbld', 02:17:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:49 INFO - '_': '/tools/buildbot/bin/python'} 02:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:49 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:17:49 INFO - Cleaning up... 02:17:49 INFO - Return code: 0 02:17:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:17:49 INFO - Using env: {'DISPLAY': ':0', 02:17:49 INFO - 'HOME': '/home/cltbld', 02:17:49 INFO - 'LANG': 'en_US.UTF-8', 02:17:49 INFO - 'LANGUAGE': 'en_US:en', 02:17:49 INFO - 'LOGNAME': 'cltbld', 02:17:49 INFO - 'MAIL': '/var/mail/cltbld', 02:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:49 INFO - 'MOZ_NO_REMOTE': '1', 02:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:49 INFO - 'NO_EM_RESTART': '1', 02:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:49 INFO - 'PWD': '/builds/slave/test', 02:17:49 INFO - 'SHELL': '/bin/bash', 02:17:49 INFO - 'SHLVL': '1', 02:17:49 INFO - 'TERM': 'linux', 02:17:49 INFO - 'TMOUT': '86400', 02:17:49 INFO - 'USER': 'cltbld', 02:17:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:49 INFO - '_': '/tools/buildbot/bin/python'} 02:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:50 INFO - Downloading/unpacking psutil>=3.1.1 02:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:52 INFO - Installing collected packages: psutil 02:17:52 INFO - Running setup.py install for psutil 02:17:52 INFO - building 'psutil._psutil_linux' extension 02:17:52 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:17:52 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:17:52 INFO - building 'psutil._psutil_posix' extension 02:17:52 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:17:52 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:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:52 INFO - Successfully installed psutil 02:17:52 INFO - Cleaning up... 02:17:52 INFO - Return code: 0 02:17:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:17:52 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:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 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:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:17:52 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:17:52 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:17:52 INFO - Using env: {'DISPLAY': ':0', 02:17:52 INFO - 'HOME': '/home/cltbld', 02:17:52 INFO - 'LANG': 'en_US.UTF-8', 02:17:52 INFO - 'LANGUAGE': 'en_US:en', 02:17:52 INFO - 'LOGNAME': 'cltbld', 02:17:52 INFO - 'MAIL': '/var/mail/cltbld', 02:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:52 INFO - 'MOZ_NO_REMOTE': '1', 02:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:52 INFO - 'NO_EM_RESTART': '1', 02:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:52 INFO - 'PWD': '/builds/slave/test', 02:17:52 INFO - 'SHELL': '/bin/bash', 02:17:52 INFO - 'SHLVL': '1', 02:17:52 INFO - 'TERM': 'linux', 02:17:52 INFO - 'TMOUT': '86400', 02:17:52 INFO - 'USER': 'cltbld', 02:17:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:52 INFO - '_': '/tools/buildbot/bin/python'} 02:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:17: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:17: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:17: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:17: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:17: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:17: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:17:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:17:54 INFO - Installing collected packages: mozsystemmonitor 02:17:54 INFO - Running setup.py install for mozsystemmonitor 02:17:54 INFO - Successfully installed mozsystemmonitor 02:17:54 INFO - Cleaning up... 02:17:54 INFO - Return code: 0 02:17:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:17:54 INFO - Using env: {'DISPLAY': ':0', 02:17:54 INFO - 'HOME': '/home/cltbld', 02:17:54 INFO - 'LANG': 'en_US.UTF-8', 02:17:54 INFO - 'LANGUAGE': 'en_US:en', 02:17:54 INFO - 'LOGNAME': 'cltbld', 02:17:54 INFO - 'MAIL': '/var/mail/cltbld', 02:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:54 INFO - 'MOZ_NO_REMOTE': '1', 02:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:54 INFO - 'NO_EM_RESTART': '1', 02:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:54 INFO - 'PWD': '/builds/slave/test', 02:17:54 INFO - 'SHELL': '/bin/bash', 02:17:54 INFO - 'SHLVL': '1', 02:17:54 INFO - 'TERM': 'linux', 02:17:54 INFO - 'TMOUT': '86400', 02:17:54 INFO - 'USER': 'cltbld', 02:17:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:54 INFO - '_': '/tools/buildbot/bin/python'} 02:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:17:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:17:57 INFO - warning: no files found matching '*.txt' 02:17:57 INFO - no previously-included directories found matching 'build' 02:17:57 INFO - no previously-included directories found matching 'dist' 02:17:57 INFO - no previously-included directories found matching '.git*' 02:17:57 INFO - Installing collected packages: jsonschema, functools32 02:17:57 INFO - Running setup.py install for functools32 02:17:57 INFO - warning: no files found matching '*.txt' 02:17:57 INFO - no previously-included directories found matching 'build' 02:17:57 INFO - no previously-included directories found matching 'dist' 02:17:57 INFO - no previously-included directories found matching '.git*' 02:17:57 INFO - Successfully installed jsonschema functools32 02:17:57 INFO - Cleaning up... 02:17:57 INFO - Return code: 0 02:17:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:57 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 02:17:57 INFO - 'HOME': '/home/cltbld', 02:17:57 INFO - 'LANG': 'en_US.UTF-8', 02:17:57 INFO - 'LANGUAGE': 'en_US:en', 02:17:57 INFO - 'LOGNAME': 'cltbld', 02:17:57 INFO - 'MAIL': '/var/mail/cltbld', 02:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:57 INFO - 'MOZ_NO_REMOTE': '1', 02:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:57 INFO - 'NO_EM_RESTART': '1', 02:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:57 INFO - 'PWD': '/builds/slave/test', 02:17:57 INFO - 'SHELL': '/bin/bash', 02:17:57 INFO - 'SHLVL': '1', 02:17:57 INFO - 'TERM': 'linux', 02:17:57 INFO - 'TMOUT': '86400', 02:17:57 INFO - 'USER': 'cltbld', 02:17:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:57 INFO - '_': '/tools/buildbot/bin/python'} 02:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:17:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:00 INFO - Downloading docopt-0.6.1.tar.gz 02:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:00 INFO - Running setup.py install for blobuploader 02:18:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:00 INFO - Running setup.py install for requests 02:18:00 INFO - Running setup.py install for docopt 02:18:00 INFO - Successfully installed blobuploader requests docopt 02:18:00 INFO - Cleaning up... 02:18:00 INFO - Return code: 0 02:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:00 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:18:00 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:18:00 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:18:00 INFO - Using env: {'DISPLAY': ':0', 02:18:00 INFO - 'HOME': '/home/cltbld', 02:18:00 INFO - 'LANG': 'en_US.UTF-8', 02:18:00 INFO - 'LANGUAGE': 'en_US:en', 02:18:00 INFO - 'LOGNAME': 'cltbld', 02:18:00 INFO - 'MAIL': '/var/mail/cltbld', 02:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:00 INFO - 'MOZ_NO_REMOTE': '1', 02:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:00 INFO - 'NO_EM_RESTART': '1', 02:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:00 INFO - 'PWD': '/builds/slave/test', 02:18:00 INFO - 'SHELL': '/bin/bash', 02:18:00 INFO - 'SHLVL': '1', 02:18:00 INFO - 'TERM': 'linux', 02:18:00 INFO - 'TMOUT': '86400', 02:18:00 INFO - 'USER': 'cltbld', 02:18:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:00 INFO - '_': '/tools/buildbot/bin/python'} 02:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:01 INFO - Running setup.py (path:/tmp/pip-0voxKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:01 INFO - Running setup.py (path:/tmp/pip-KjEU6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:01 INFO - Running setup.py (path:/tmp/pip-Rl2yqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:01 INFO - Running setup.py (path:/tmp/pip-Bt4B_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:01 INFO - Running setup.py (path:/tmp/pip-vqbp3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 INFO - Running setup.py (path:/tmp/pip-yzySy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:01 INFO - Running setup.py (path:/tmp/pip-ttzgaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:01 INFO - Running setup.py (path:/tmp/pip-AUxEf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:01 INFO - Running setup.py (path:/tmp/pip-KO8ORp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:01 INFO - Running setup.py (path:/tmp/pip-wBtebs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:01 INFO - Running setup.py (path:/tmp/pip-1GzGTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:01 INFO - Running setup.py (path:/tmp/pip-FlAYUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:01 INFO - Running setup.py (path:/tmp/pip-t4Duov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:02 INFO - Running setup.py (path:/tmp/pip-fXn7wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 INFO - Running setup.py (path:/tmp/pip-SF69Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:02 INFO - Running setup.py (path:/tmp/pip-1qmmHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:02 INFO - Running setup.py (path:/tmp/pip-VLhkmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:02 INFO - Running setup.py install for manifestparser 02:18:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:02 INFO - Running setup.py install for mozcrash 02:18:02 INFO - Running setup.py install for mozdebug 02:18:02 INFO - Running setup.py install for mozdevice 02:18:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:02 INFO - Running setup.py install for mozfile 02:18:02 INFO - Running setup.py install for mozhttpd 02:18:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:02 INFO - Running setup.py install for mozinfo 02:18:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozInstall 02:18:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozleak 02:18:03 INFO - Running setup.py install for mozlog 02:18:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for moznetwork 02:18:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozprocess 02:18:03 INFO - Running setup.py install for mozprofile 02:18:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozrunner 02:18:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozscreenshot 02:18:03 INFO - Running setup.py install for moztest 02:18:03 INFO - Running setup.py install for mozversion 02:18:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:04 INFO - Cleaning up... 02:18:04 INFO - Return code: 0 02:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:04 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:18:04 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:18:04 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:18:04 INFO - Using env: {'DISPLAY': ':0', 02:18:04 INFO - 'HOME': '/home/cltbld', 02:18:04 INFO - 'LANG': 'en_US.UTF-8', 02:18:04 INFO - 'LANGUAGE': 'en_US:en', 02:18:04 INFO - 'LOGNAME': 'cltbld', 02:18:04 INFO - 'MAIL': '/var/mail/cltbld', 02:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:04 INFO - 'MOZ_NO_REMOTE': '1', 02:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:04 INFO - 'NO_EM_RESTART': '1', 02:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:04 INFO - 'PWD': '/builds/slave/test', 02:18:04 INFO - 'SHELL': '/bin/bash', 02:18:04 INFO - 'SHLVL': '1', 02:18:04 INFO - 'TERM': 'linux', 02:18:04 INFO - 'TMOUT': '86400', 02:18:04 INFO - 'USER': 'cltbld', 02:18:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:04 INFO - '_': '/tools/buildbot/bin/python'} 02:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:04 INFO - Running setup.py (path:/tmp/pip-U1mq5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:04 INFO - Running setup.py (path:/tmp/pip-ueXYVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:04 INFO - Running setup.py (path:/tmp/pip-4iuGpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:04 INFO - Running setup.py (path:/tmp/pip-ZiQVGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:04 INFO - Running setup.py (path:/tmp/pip-8HSkmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:04 INFO - Running setup.py (path:/tmp/pip-gcMN2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:04 INFO - Running setup.py (path:/tmp/pip-F5QkPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:04 INFO - Running setup.py (path:/tmp/pip-F8hB2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:04 INFO - Running setup.py (path:/tmp/pip-NnCxPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:04 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:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:04 INFO - Running setup.py (path:/tmp/pip-VEMimH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:05 INFO - Running setup.py (path:/tmp/pip-BbGr9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:05 INFO - Running setup.py (path:/tmp/pip-LMZpt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:05 INFO - Running setup.py (path:/tmp/pip-IS8C8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:05 INFO - Running setup.py (path:/tmp/pip-iS1d9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:05 INFO - Running setup.py (path:/tmp/pip-JMxs5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:05 INFO - Running setup.py (path:/tmp/pip-SyNmuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:05 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:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:05 INFO - Running setup.py (path:/tmp/pip-5C0qiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:05 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:18:05 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:18:05 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:18:05 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:18:05 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:18:05 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:18:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:07 INFO - Downloading blessings-1.6.tar.gz 02:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:07 INFO - Installing collected packages: blessings 02:18:07 INFO - Running setup.py install for blessings 02:18:07 INFO - Successfully installed blessings 02:18:07 INFO - Cleaning up... 02:18:07 INFO - Return code: 0 02:18:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:07 INFO - Reading from file tmpfile_stdout 02:18:07 INFO - Current package versions: 02:18:07 INFO - argparse == 1.2.1 02:18:07 INFO - blessings == 1.6 02:18:07 INFO - blobuploader == 1.2.4 02:18:07 INFO - docopt == 0.6.1 02:18:07 INFO - functools32 == 3.2.3-2 02:18:07 INFO - jsonschema == 2.5.1 02:18:07 INFO - manifestparser == 1.1 02:18:07 INFO - mozInstall == 1.12 02:18:07 INFO - mozcrash == 0.17 02:18:07 INFO - mozdebug == 0.1 02:18:07 INFO - mozdevice == 0.48 02:18:07 INFO - mozfile == 1.2 02:18:07 INFO - mozhttpd == 0.7 02:18:07 INFO - mozinfo == 0.9 02:18:07 INFO - mozleak == 0.1 02:18:07 INFO - mozlog == 3.2 02:18:07 INFO - moznetwork == 0.27 02:18:07 INFO - mozprocess == 0.22 02:18:07 INFO - mozprofile == 0.28 02:18:07 INFO - mozrunner == 6.11 02:18:07 INFO - mozscreenshot == 0.1 02:18:07 INFO - mozsystemmonitor == 0.3 02:18:07 INFO - moztest == 0.7 02:18:07 INFO - mozversion == 1.4 02:18:07 INFO - psutil == 3.1.1 02:18:07 INFO - requests == 1.2.3 02:18:07 INFO - wsgiref == 0.1.2 02:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:07 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:18:07 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:18:07 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:18:07 INFO - Using env: {'DISPLAY': ':0', 02:18:07 INFO - 'HOME': '/home/cltbld', 02:18:07 INFO - 'LANG': 'en_US.UTF-8', 02:18:07 INFO - 'LANGUAGE': 'en_US:en', 02:18:07 INFO - 'LOGNAME': 'cltbld', 02:18:07 INFO - 'MAIL': '/var/mail/cltbld', 02:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:07 INFO - 'MOZ_NO_REMOTE': '1', 02:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:07 INFO - 'NO_EM_RESTART': '1', 02:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:07 INFO - 'PWD': '/builds/slave/test', 02:18:07 INFO - 'SHELL': '/bin/bash', 02:18:07 INFO - 'SHLVL': '1', 02:18:07 INFO - 'TERM': 'linux', 02:18:07 INFO - 'TMOUT': '86400', 02:18:07 INFO - 'USER': 'cltbld', 02:18:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:07 INFO - '_': '/tools/buildbot/bin/python'} 02:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 INFO - Cleaning up... 02:18:08 INFO - Return code: 0 02:18:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18:08 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:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 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:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:18:08 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:18:08 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:18:08 INFO - Using env: {'DISPLAY': ':0', 02:18:08 INFO - 'HOME': '/home/cltbld', 02:18:08 INFO - 'LANG': 'en_US.UTF-8', 02:18:08 INFO - 'LANGUAGE': 'en_US:en', 02:18:08 INFO - 'LOGNAME': 'cltbld', 02:18:08 INFO - 'MAIL': '/var/mail/cltbld', 02:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:08 INFO - 'MOZ_NO_REMOTE': '1', 02:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:08 INFO - 'NO_EM_RESTART': '1', 02:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:08 INFO - 'PWD': '/builds/slave/test', 02:18:08 INFO - 'SHELL': '/bin/bash', 02:18:08 INFO - 'SHLVL': '1', 02:18:08 INFO - 'TERM': 'linux', 02:18:08 INFO - 'TMOUT': '86400', 02:18:08 INFO - 'USER': 'cltbld', 02:18:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:08 INFO - '_': '/tools/buildbot/bin/python'} 02:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:18:08 INFO - Cleaning up... 02:18:08 INFO - Return code: 0 02:18:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:18:08 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:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 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:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 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 0x7f7408233f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', '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:18:08 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:18:08 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:18:08 INFO - Using env: {'DISPLAY': ':0', 02:18:08 INFO - 'HOME': '/home/cltbld', 02:18:08 INFO - 'LANG': 'en_US.UTF-8', 02:18:08 INFO - 'LANGUAGE': 'en_US:en', 02:18:08 INFO - 'LOGNAME': 'cltbld', 02:18:08 INFO - 'MAIL': '/var/mail/cltbld', 02:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:08 INFO - 'MOZ_NO_REMOTE': '1', 02:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:08 INFO - 'NO_EM_RESTART': '1', 02:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:08 INFO - 'PWD': '/builds/slave/test', 02:18:08 INFO - 'SHELL': '/bin/bash', 02:18:08 INFO - 'SHLVL': '1', 02:18:08 INFO - 'TERM': 'linux', 02:18:08 INFO - 'TMOUT': '86400', 02:18:08 INFO - 'USER': 'cltbld', 02:18:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:08 INFO - '_': '/tools/buildbot/bin/python'} 02:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:08 INFO - Downloading/unpacking flake8 02:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:18:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:18:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:11 INFO - no previously-included directories found matching 'docs/_build' 02:18:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:18:11 INFO - Running setup.py install for pep8 02:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:11 INFO - no previously-included directories found matching 'docs/_build' 02:18:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:18:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:18:11 INFO - Cleaning up... 02:18:11 INFO - Return code: 0 02:18:11 INFO - Running post-action listener: _resource_record_post_action 02:18:11 INFO - Running post-action listener: _start_resource_monitoring 02:18:11 INFO - Starting resource monitoring. 02:18:11 INFO - ##### 02:18:11 INFO - ##### Finished create-virtualenv step (success) 02:18:11 INFO - ##### 02:18:11 INFO - ##### 02:18:11 INFO - ##### Running install step. 02:18:11 INFO - ##### 02:18:11 INFO - Running pre-action listener: _resource_record_pre_action 02:18:11 INFO - Running main action method: install 02:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:11 INFO - Reading from file tmpfile_stdout 02:18:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:11 INFO - Reading from file tmpfile_stdout 02:18:11 INFO - Output received: 02:18:11 INFO - Usage: mozinstall [options] installer 02:18:11 INFO - Options: 02:18:11 INFO - -h, --help show this help message and exit 02:18:11 INFO - -d DEST, --destination=DEST 02:18:11 INFO - Directory to install application into. [default: 02:18:11 INFO - "/builds/slave/test"] 02:18:11 INFO - --app=APP Application being installed. [default: firefox] 02:18:11 INFO - mkdir: /builds/slave/test/build/application 02:18:11 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:18:11 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:18:27 INFO - Reading from file tmpfile_stdout 02:18:27 INFO - Output received: 02:18:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:18:27 INFO - Running post-action listener: _resource_record_post_action 02:18:27 INFO - ##### 02:18:27 INFO - ##### Finished install step (success) 02:18:27 INFO - ##### 02:18:27 INFO - ##### 02:18:27 INFO - ##### Running run-tests step. 02:18:27 INFO - ##### 02:18:27 INFO - Running pre-action listener: _resource_record_pre_action 02:18:27 INFO - Running main action method: run_tests 02:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:27 INFO - Python 2.7.3 02:18:27 INFO - Return code: 0 02:18:27 INFO - grabbing minidump binary from tooltool 02:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:27 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 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:27 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:18:27 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:18:27 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:18:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:27 INFO - Return code: 0 02:18:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:18:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:18:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:18:28 INFO - Return code: 0 02:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:18:28 INFO - Using env: {'DISPLAY': ':0', 02:18:28 INFO - 'HOME': '/home/cltbld', 02:18:28 INFO - 'LANG': 'en_US.UTF-8', 02:18:28 INFO - 'LANGUAGE': 'en_US:en', 02:18:28 INFO - 'LOGNAME': 'cltbld', 02:18:28 INFO - 'MAIL': '/var/mail/cltbld', 02:18:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:28 INFO - 'MOZ_NO_REMOTE': '1', 02:18:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:28 INFO - 'NO_EM_RESTART': '1', 02:18:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:28 INFO - 'PWD': '/builds/slave/test', 02:18:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:28 INFO - 'SHELL': '/bin/bash', 02:18:28 INFO - 'SHLVL': '1', 02:18:28 INFO - 'TERM': 'linux', 02:18:28 INFO - 'TMOUT': '86400', 02:18:28 INFO - 'USER': 'cltbld', 02:18:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145', 02:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:28 INFO - '_': '/tools/buildbot/bin/python'} 02:18:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:18:28 INFO - mozversion application_buildid: 20160611012225 02:18:28 INFO - mozversion application_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 02:18:28 INFO - mozversion application_display_name: Nightly 02:18:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:28 INFO - mozversion application_name: Firefox 02:18:28 INFO - mozversion application_remotingname: firefox 02:18:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:18:28 INFO - mozversion application_vendor: Mozilla 02:18:28 INFO - mozversion application_version: 50.0a1 02:18:28 INFO - mozversion platform_buildid: 20160611012225 02:18:28 INFO - mozversion platform_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 02:18:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:18:28 INFO - mozversion platform_version: 50.0a1 02:18:28 INFO - using testdate: 1465636708 02:18:28 INFO - actual date: 1465636708 02:18:28 INFO - starting webserver on 'localhost:47946' 02:18:28 INFO - SUITE-START | Running 2 tests 02:18:28 INFO - TEST-START | dromaeo_css 02:18:28 INFO - operating with platform_type : linux_ 02:18:28 INFO - Initialising browser for dromaeo_css test... 02:18:28 INFO - TEST-INFO | started process 1435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLyGkKO/profile http://localhost:47946/getInfo.html) 02:18:33 INFO - PROCESS | 1435 | __metrics Screen width/height:1600/1200 02:18:33 INFO - PROCESS | 1435 | colorDepth:24 02:18:33 INFO - PROCESS | 1435 | Browser inner width/height: 1024/697 02:18:33 INFO - PROCESS | 1435 | __metrics 02:18:34 INFO - PROCESS | 1435 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:34 INFO - PROCESS | 1435 | console.error: PushService: 02:18:34 INFO - PROCESS | 1435 | stateChangeProcessEnqueue: Error transitioning state 02:18:34 INFO - PROCESS | 1435 | UnknownError 02:18:35 INFO - TEST-INFO | 1435: exit 0 02:18:35 INFO - Browser initialized. 02:18:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:35 INFO - TEST-INFO | started process 1518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLyGkKO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:47 INFO - PROCESS | 1518 | RSS: Main: 179359744 02:18:47 INFO - PROCESS | 1518 | 02:19:39 INFO - PROCESS | 1518 | 1465636779646 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:21:51 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47946/tests/dromaeo/cssquery-ext.html) 02:21:52 INFO - PROCESS | 1518 | RSS: Main: 283873280 02:21:52 INFO - PROCESS | 1518 | 02:24:55 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-ext.html (next: http://localhost:47946/tests/dromaeo/cssquery-jquery.html) 02:24:55 INFO - PROCESS | 1518 | RSS: Main: 262664192 02:24:55 INFO - PROCESS | 1518 | 02:27:58 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47946/tests/dromaeo/cssquery-mootools.html) 02:27:58 INFO - PROCESS | 1518 | RSS: Main: 263925760 02:27:58 INFO - PROCESS | 1518 | 02:31:00 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47946/tests/dromaeo/cssquery-prototype.html) 02:31:01 INFO - PROCESS | 1518 | RSS: Main: 257261568 02:31:01 INFO - PROCESS | 1518 | 02:34:04 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47946/tests/dromaeo/cssquery-yui.html) 02:34:05 INFO - PROCESS | 1518 | RSS: Main: 232914944 02:34:05 INFO - PROCESS | 1518 | 02:37:07 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:47946/tests/dromaeo/cssquery-yui.html (next: http://localhost:47946/tests/dromaeo/cssquery-dojo.html) 02:37:08 INFO - PROCESS | 1518 | RSS: Main: 297926656 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | __start_tp_report 02:37:08 INFO - PROCESS | 1518 | _x_x_mozilla_page_load 02:37:08 INFO - PROCESS | 1518 | _x_x_mozilla_page_load_details 02:37:08 INFO - PROCESS | 1518 | |i|pagename|runs| 02:37:08 INFO - PROCESS | 1518 | |0;dojo.html;2597.311712396215;2614.019742596526;2639.709631940487;2657.973420265798;2660.241831078142;4604.171249175156;4659.930101048487;4682.461516925555;4748.477667456581;4783.712977221365;4699.882502937428;4725.7164570125815;4739.90520189596;4771.069641419916;4820.542048505386;4249.553796851333;4266.424032755584;4277.272863613193;4342.435483387163;4421.049474363027;4337.349397590371;4363.0619416825375;4455.242608756503;4478.596926276635;4488.326750987361;4252.553481884389;4397.934030989538;4406.317020861771;4423.292273236299;4436.6672499562665;4211.7051806373565;4222.2822120239325;4258.510271318807;4278;4292.29177185764;4188.120494696117;4236.237477254093;4254.234237837188;4281.7002809803325;4299.828006879721;4616.238320677085;4683.274092515666;4684.601808846252;4707.952920470786;4713.811447542094;4968.701877887338;5028.84913452597;5037.546620804145;5114.616403769695;5114.769835357418;5100.489951004907;5110.872228194287;5117.385913690344;5125.2312153176945;5146.047981123466;4605.631549476034;4706.882327941828;4739.218029025173;4741.620670346364;4746.667733258673;5217.452167522431;5232.529072383504;5300.602454815904;5304.496072873071;5304.92042619361;5012.724300163453;5062.670926389773;5063;5063.417706963746;5074;4938.38270216223;4995.100881841304;5040.647154699136;5132.743362831843;5180.0157969985585;5015.14742493777;5016.698998060128;5043.747812609428;5047.747612619354;5054.797808087709;4986.650934434628;4988.052270068675;4998.700077995332;4999.775010124553;5054.974725126351;4068.6541643960004;4116.197341518375;4167.270727622654;4186.811593478301;4236.91526169481;3642.8907132786057;3692.8522859085874;3705.8517659293866;3726.4224045273027;3743.344914639927;4386.429764130707;4389.714668546534;4392.978035109804;4393.890152746207;4438.201123797683;4873.853784386474;4924.926126108111;5061.848144555669;5066.695998240118;5108.56577190943;4356.607905288539;4433.334999750064;4433.977830110829;4439.844605438859;4443;4542.545745425497;4545.431821022372;4547.7498737569085;4568.543145685471;4596.517365676623;4688.578027977498;4744.644151688568;4802.951970480251;4820.517948205152;4821.4696383397095;5101.897962040813;5115.64190506661;5139.074966506065;5141.562967147835;5186.792528298976;4799.304100905419;4815.061063092663;4818.638602104786;4829.323894654822;4879.634027447884;4860.513948605111;4919.827806026772;4952.826651067196;5021.824236151717;5083.339165908408;5049.116404629101;5077.822276220462;5079.6698214615935;5080.49195080489;5110.386753589593;4938.629602779734;4941.876453088702;4949.752512374439;4950.034743225036;4984.975075124601;4716.339712440193;4832.49258827818;4908.730019848943;4926.605871530197;4986.501349864984;4852.369192005017;4875.512448755097;4924.679895806761;4926.458089610069;4928.433230178575;4953.2570114483115;4972.801087956441;4979.975100124476;4982.10322142018;5017.448080711192;4698.389209402756;4725.196716558262;4751.049790041936;4768.117898188846;4826.517348265286 02:37:08 INFO - PROCESS | 1518 | |1;ext.html;535.5616750546008;581.9621724587902;587.7590188022912;590.3240789296259;599.4425184578341;26646;29259.56110658342;29352.85323573382;29368.706312936865;29369.85315073427;29414.117576472687;38903.22193556127;39886;39952.80023599885;44051.11897762043;7761.689532418696;7883.448158628898;7885.881711774328;7887.526748395086;7888.802779930519;7792;7882.566458844762;7883;7886.132525422199;7886.487378320419;7894.565798881059;7920.405969552277;7921.683132674686;7928.722494712686;7929.405294602928;7845.960770196141;7894.80262993424;7902.051753789525;7902.328302094329;7911.525308481452;7740.148583655793;7807.570583617899;7807.6876924922935;7809.336206422461;7809.843803123906;37624;37972.81013594942;37990.81004594987;38000.42999355012;38003.809980950195;3122.656507784142;3164;3227.0318904328606;3404.5403870477417;3714;28389.858050709616;28737.56893646597;29165.125046248435;29251.853740731374;29323.41353172946;3235.5097948249727;3296.884609038696;3303.975767512079;3309.3546758382126;3325.3681800457834;246393;247146;248010;248709.7564512184;250544;50950.23574646383;50979.23531147036;51142.23286650703;51156.23265651018;51315;32652.346953060805;33718;33724.156896077795;35486.82256588752;35487.645123548435;14844.554663360117;15127.697446051017;15201.31594078247;15212.1633310169;15213.239338033276;11354.716132096764;11640.243384180001;11651.76696466066;11660;11678.240914340711;18085.36701215451;18110.28345748122;18295.176717047765;18374.724379134324;18459.630807383775;6648.900266496006;6885.931140688629;6892.657061325253;6916.930830691628;6954.130733658293;807.6244546286006;829.6059371798468;868.9652413903373;881.1976322169944;909.1544863277084;25074.87462562712;27314.453710926067;27729.306767330574;27978.720212797612;28152.155435336972;948.5541795356172;964.233434419624;1047.5704960965968;1054.2198772908146;1074.5701719312337;14151.787723184161;14595.197264150574;14708.55874323772;14887.553373398816;14910;388229;388439;388554;390218;392033;49078;50310.24534631983;50433.24350134751;50530.74734626304;50577.747111264944;1072.6406653770919;1087.3693257910393;1125.2235957189514;1153.1870031627682;1203.668991027457;26140.477190456466;28100.71899280981;29219.707802921697;29905.401891962472;30800.845995769876;46490.767546163406;46763.29855052245;47213;47223.52776472329;47304.29043564418;358862;365225;366242;366433;367354;33004.1748956278;33860.49209261814;38362.657306995236;38999.80500097481;39157;42153.57846421497;42485.15029699451;42709.57290427056;43258.35112473378;43710.344344834215;35824.28351433009;36878.078048049014;36957.63042369542;37056.25887482289;37282.440763388026;35806.283874322886;36216.81891590525;36284.27431451409;36451;36534;35605.465918010734;35781.46327805137;36420.27159456849;36514.08714782152;36648.45027324539;31725;32712.34575308433;32743.672563274064;33107.84122555699;33295.50056749102;25256.621150682386;25258.49483010293;25355.61966570466;25414.20443751149;25487.36281592975 02:37:08 INFO - PROCESS | 1518 | |2;jquery.html;369.86315063426537;370.0655843993915;370.4739270236264;383.9884803455894;389.9532056153262;15875.523734287975;16114.35542578297;16924.2384092716;16929.91535042323;16951.49145525633;15696.686066278697;16855.325786968508;17162.914185429054;17421.390251341207;17461.12694365283;4921.630877684179;5127.256547800566;5172.172452407615;5173.042987047408;5176.844694659167;3732.8133593320363;3923.489946306976;4915.82794602189;5607.719614019283;5949.345571987078;6035.064564992411;6051.062085376773;6067.180930574382;6071.210742603455;6071.301800292957;5760.510356619692;5845.824625261249;5913.349531551526;5914.319853216871;5929.466348028676;3362.96637033629;4881.585065269456;5207.4792520748;5217.217417387385;5225.634205605571;20853.79146208549;20921.476963075893;20957;21443.49895507315;21470.141194352207;1965.0862349007637;2000.349886286948;2148.709924160234;2292.3008482412856;2307.976920230793;12428.689282767913;12695;13014.284214368206;13336.933315333361;13444.395002224923;1741.939032133882;1745.8777885548018;1765.0645158066245;1809.1316168239318;1838.117703502313;67669.32330676728;71850;72495;73122;73735;10203.38779673222;10267.383956962607;10344.637937672145;10424.739381515372;10471.895281047093;14369.712605747827;14491.492797752027;14510.347034383478;14518;14534.636634084021;7398;7578.54528728267;7653;7665.61671916402;7768.689252429839;7116.252793456716;7295.489315747846;7298.343149116605;7407.481476296715;7429;4325.675574331937;4343.109662519176;4456.6211871991245;4476.171908196929;4485.0581377911;1679.5968967447968;1765.496833402474;2870.7990440668955;3031.9545206821917;3281.506914353963;754.7924320811711;839.6858915796759;871.9084496127942;923.330585325647;938.6198589571235;16040.919795401182;17101.657966840594;17282.395116171127;17300.65398692019;17575.472735817944;830.779843341515;840.8906842110608;881.7795551112222;883.3330835219368;924.9548010747812;9287.349885508085;9613.471259080818;9624.422534647943;9718;9928.553215105338;379892;394230;430380;432275;438673;79298;83967;84791.15208847832;84804.57597712096;85316;934.1592566690033;943.3538026451903;969.8448248280241;979.7599588100961;985.0789511806483;15883.761743573625;16087.597810054374;16104.758428623814;16124.79064070176;16533.751993720343;36037.81981090183;36380;37033.44449833308;37435;37588;50568.49431505785;51217;51291.71770705762;51347.031735408586;52258.21612675889;7359.227281135403;7716.459847810824;7840;7941.205879412244;8061.435699500978;10034.749131271485;11415.315081095161;11491.540338386705;11926.940365298466;12065.939670301592;8080.676772929017;10022.849657255001;10205;10280.537375817956;10294.176465882862;9964.302498825013;9989.500524973868;10074.54664540112;10230.335028223142;10337.483125843828;9943.751406214902;9954.751131221488;10141.492925353556;10488.423136727248;10584.523696433525;7824.5524577953265;7843.058832940083;7962.0871915114285;8051.718189863327;8229.917700822914;10520.526576303932;10567.154627629925;10609.681709548726;10715.464226788785;10904.61833835812 02:37:08 INFO - PROCESS | 1518 | |3;mootools.html;1148.8047032004558;1373.5535950815984;1427.3933578229253;1495.192595998161;1697.9745303820437;6404.199475065617;7391.0761154855645;7590.734324298651;7606.429517786168;7804;7468.178500364956;7611.657475413605;7632.961835190817;7644;7652.846943061136;1836.706127019677;2106.3365040012345;2182.9563408731897;2185.792349726781;2219.201087608468;2197.9010944507454;2216.601011817872;2221.522372689871;2222.022310183514;2222.3221917315213;2167.696522486853;2168.5229249565073;2176.858504197222;2178.194068194762;2192.331338941622;1793.6681713882908;2056.8868712220824;2135.092585651092;2136.6260904341834;2153.041896356114;2087.6033553624916;2104.316097268394;2106.3891471473253;2108.5677436125557;2109.24067335759;7697.653605587706;7741.064733816545;7742.419318551075;7746.147923728386;7772.3393511551585;4544.909101817945;4682.367880336145;4684.531546845323;4690.624750020024;4706.670533062653;2737.7399147080996;2913.4318807832483;2931.589577459157;2938.147937098239;2946.175070980129;840.6805413942724;858.3776761847673;871.0853603716073;881.8060026794095;885.2563846369017;10363.274570780048;10385.948070259676;10415.479226038744;10428.843567346496;10429;4126.504819421629;4297.076128632359;4315.654747620183;4368.301071828492;4374.78126093694;8768.07935166811;8803.823923521493;8817.118288171132;8820.029796722356;8833.514156721314;4688.507706690816;4725.031368569435;4736.550027747358;4738.715677059387;4744.478107408182;3669.8532058717888;4139.97930010348;4282.143571285756;4293.785310734451;4381.5618438155925;3658.378075727133;3686.7234957378305;3728.440733889884;3776.188119554309;3799.0882188274613;1107.213878146525;1129.8418221449003;1135.4039129456935;1140.7091191746051;1213.8846809553079;719.8776208044645;752.2928447259668;854.9700760473354;861.629499315288;871.1419252036738;4974.825881094217;5136.537711605899;5241.554467870197;5252.921206181911;5325.227841962894;804.9678012879536;842.2125312832521;854.2013217641525;860.6428332242175;903.9728808135767;3427.485877118452;3547.840347184383;3563.501109844624;3564.376234159012;3586.3903136466865;9028.413153145024;9239.168474837297;9312.394694344846;9316.627334906529;9525.857112143323;9245.861312080324;9364.578593963288;9485.14633682958;9487.857682134774;9551.140397364132;6912.723491060402;6975.965120174366;7100.538464999759;7112.110986126734;7303.123625164908;5104.69371837691;5260.763265652979;5263.973680131575;5287.471252874836;5293.5765138789575;8323.500589964622;8561.529115898686;8588.527630980356;8680.739577812676;8752.737417877473;8546.957265213634;8813.779655508664;8825.249853762245;9026.774330641787;9096.590653420479;5616.66300022;5820.563457740602;5821.330546987151;6311.810645680637;6413.198350206224;6700.430463410665;7200.567965921852;7456.701731930879;7464;7607.923920760722;6394.840128996812;6630.900536492053;6695.09616201826;6853.383195512428;7002.369786719016;6695.296993815774;6752;6775.4240889524945;6825;6851.109355783717;6285.842853928689;6300.653464059521;6338.271098823694;6369.363063693593;6373.330800265905;4282.272013757606;4349.565043495625;4478.731276123443;4533.977330113328;4549.067441174485;4453.19842428366;4514.706544074625;4653.53464653532;4703.764811759467;4717 02:37:08 INFO - PROCESS | 1518 | |4;prototype.html;287.34628719662766;292.1294542264053;292.23288866724846;302.7744330473797;303.3674788066879;4736.242201247796;4750.596199323053;4762.714237145774;4776.877433803063;4780.330753694481;4718.4809670936165;4721.238075725704;4730.526947305268;4733.976330118353;4735.621150307976;3546.379383607871;3601.7118630509626;3622.1850083731083;3734.759144513284;3769.962300377002;3664.890053298392;3734.365157923146;3736.458213559032;3750.924981500368;3765.3034188675047;3520.9295814083703;3692.947509959662;3712.3874560697454;3713.5915049344685;3721.6092310307436;3587.3542762302777;3693.649103335179;3698.519192504957;3723.8696645617542;3730.3658378075656;3272.9018129456153;3287.9342413151844;3289.3092450585405;3295.307985323085;3302.9504557431655;4618.884527886796;4620.267399725103;4626.606738427237;4630.18971679958;4643;4164.583541645841;4238.745675259494;4251.171021650779;4260.531341552427;4277.358396240557;4885.218365061573;4902.534259245366;4928.33467481889;4931.580815630676;4958.380202474691;3588;3595.532580764484;3612.3858943979585;3620.4931309616672;3625.4199328107375;4958.9008219835405;5202.167653175474;5203.869903252411;5209;5213.42652308242;3567.696745776638;3577.9284414312087;3604.4052731299043;3605.4591811228524;3633.345997720383;3622.4747411625167;3628.8911332660064;3630.2376500935097;3631.819658610962;3634.254977729612;4038.3134867072667;4086.1419101988913;4153.317906247914;4170.603792639695;4195.202911446815;4856.63575231852;4881;4881.731504767272;4894.339264199359;4902.509749025069;1249.4564864284066;1265.9303738294482;1272.344742457635;1272.4464857786893;1273.3696820074122;792.7502836606451;799.5402643480022;837.0708513550077;858.52780970466;862.4566523090413;4353.6299414549485;4362.302031674917;4367.366731823868;4371.453568303962;4377.474703035592;5027.567143364124;5033;5084.161113416319;5084.6440749147205;5089.6691715038405;4265.168292182994;4364;4404.207242696345;4419.668524860648;4431.379606855043;2671.919842404692;2695.191442567222;2711.240852561286;2715.5247831629385;2737.3840885800537;4726.338312636233;4761.880952976203;4768.713877167381;4770.833020844323;4784.784684689197;4974.452810190876;5132.820351287687;5162.148245539519;5170.250313704567;5298.178782288752;4851.539103785135;4873.1471992400475;4877.878053048702;4879.243717223836;4881.804727810848;5155.922661160161;5160.870978225575;5161.7677204526635;5169.844904652867;5172;4858.7164032904475;5023.419320689908;5049.747512624427;5067.719526213293;5074.188129899198;4799.520047995173;4851.902961940671;4859.198232291632;4862.708237505761;4881.926771098365;3640.1263696712067;3646.3254297954963;3646.6353364663323;3656.104254457675;3656.6160553141535;4984.352034235526;5153.3815942087185;5158.793648254028;5170.8965820684125;5185.870353241199;4974.358461707556;4998.750062496933;5003.523255988309;5017.397912250407;5037.19404895215;4995.975824955948;4997.625178111729;5000.549950504472;5005.224190250371;5006.1739812930455;4684.976575117103;4898.24077268024;4913.77887995034;4933.235348520985;4981.825636102864;4844.612431005582;4960.925586116284;5034.697918124924;5051.545360917388;5054.873628159326;4905.362302900743;4925.827596034122;4936.950630493793;4938.506149385033;4959.330490383752 02:37:08 INFO - PROCESS | 1518 | |5;yui.html;652.8498445357568;663.7743167323109;667.1960287853137;685.8388278754495;707.9044329015583;13008.024398170139;13683.110597811148;13865.098768580036;14003.36984835681;14005.159690418583;13139.868601313983;13232;13251.80122298164;13271.137376070548;13274.535391261285;594.2245369792419;728.5628622826289;773.4547144263295;775.1628241499168;786.4573444323427;774.7404619452462;779.8128449172186;783.1150799596448;786.4298383671821;788.3377962511489;831.995840020799;839.0225387423644;839.1776059461731;840.4411066640677;840.8066144786703;626.076537107767;767.1178145133085;829.8008477965245;830.0247209528779;834.4117397234966;606.1362558354327;610.081826850587;610.7587502936316;610.7648555306195;611.4496952742568;13618.18290902549;13697.452101916011;13715.588532344045;13728.382222799997;13744.587662370144;12781.16922400041;12940.57653658097;13189.076764626385;13208.933955330258;13335.73328533424;11729.120315976335;11784.882151178464;11852.762944741144;11892.405379730979;12264.448099835528;4191.077962848199;4219.556946520602;4228.281192197333;4231.851885184004;4241;55100.448995510334;55255;55307.170392444146;55456;55873.72063139699;9704.466254355937;9724.17344525709;10168.644097456554;10278;10538.736531586772;17551.561210969572;17891.46325610234;17894;18730.53173670642;18780.624387512173;6950.478714096463;6955.513114081966;7035.859282814315;7217.170025447141;7429.628518574158;3934.8229329680235;4054.716169868081;4069.1251380953236;4073.551909289976;4117.3206420940205;2943.632045994251;3037.179961410407;3049.161480592855;3049.60355153833;3056.6332040155326;524.4807640435941;525.1413938211052;529.1454301303368;530.2258702294693;535.7998084291238;497.9477154898756;621.623917529897;627.0656721484954;630.2846269484169;656.7931101702949;7745.22547745221;8012.839743205103;8147.592620368958;8185.4684607329655;8186.795330116675;513.1627734519836;516.3983958688161;540.6620861961275;609.1563184988822;630.3538872655473;3879.903002424962;3952.9011774705864;3974.3442332014893;3974.3839704845795;4019.196160767858;54924.72537637366;54994.72502637541;95681.56477652841;97104;104592;84165.15834841695;85426;86829.5658521716;86907.56546217228;89063;62214;63294.36705632885;77653;79970.20029799743;81566;8188.426810123234;8435.8734618982;8645.567721613768;8683.088275730957;8720.12798720123;32090.679093208768;33907.83046084754;39911;43825.12349752923;45798.54201457943;63134;63321;63372.68313658402;63941.68029159824;64104;10766.407847568458;10976.725581860517;11425.31448113116;11617.825732614187;12301.75396492083;12071.939640301742;12140.028797695986;12901.516325622673;13415.597532074053;13899.235542045284;8253.79365515867;9936.254780891317;9968.40189588598;10275.948620256851;10686.679399618024;11810.114241432098;12417.254964702146;12469;12560.309182995023;12754.936225318814;10527.4736263185;10607.469626518798;10645.574177032831;11049.889501104886;11103.056240219672;9443.716688499357;9472.715818525456;9523;9820.705378838646;9839.409635421898;8922.821543568962;9131.360804743605;9216.447013179231;9344.29997701388;9574.808503830023 02:37:08 INFO - PROCESS | 1518 | __end_tp_report 02:37:08 INFO - PROCESS | 1518 | __start_cc_report 02:37:08 INFO - PROCESS | 1518 | _x_x_mozilla_cycle_collect,1018 02:37:08 INFO - PROCESS | 1518 | __end_cc_report 02:37:08 INFO - PROCESS | 1518 | __startTimestamp1465637828217__endTimestamp 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | ------- Summary: start ------- 02:37:08 INFO - PROCESS | 1518 | Number of tests: 6 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#0] dojo.html Cycles:165 Average:4672.45 Median:4802.95 stddev:504.84 (10.5%) stddev-sans-first:479.42 02:37:08 INFO - PROCESS | 1518 | Values: 2597.3 2614.0 2639.7 2658.0 2660.2 4604.2 4659.9 4682.5 4748.5 4783.7 4699.9 4725.7 4739.9 4771.1 4820.5 4249.6 4266.4 4277.3 4342.4 4421.0 4337.3 4363.1 4455.2 4478.6 4488.3 4252.6 4397.9 4406.3 4423.3 4436.7 4211.7 4222.3 4258.5 4278.0 4292.3 4188.1 4236.2 4254.2 4281.7 4299.8 4616.2 4683.3 4684.6 4708.0 4713.8 4968.7 5028.8 5037.5 5114.6 5114.8 5100.5 5110.9 5117.4 5125.2 5146.0 4605.6 4706.9 4739.2 4741.6 4746.7 5217.5 5232.5 5300.6 5304.5 5304.9 5012.7 5062.7 5063.0 5063.4 5074.0 4938.4 4995.1 5040.6 5132.7 5180.0 5015.1 5016.7 5043.7 5047.7 5054.8 4986.7 4988.1 4998.7 4999.8 5055.0 4068.7 4116.2 4167.3 4186.8 4236.9 3642.9 3692.9 3705.9 3726.4 3743.3 4386.4 4389.7 4393.0 4393.9 4438.2 4873.9 4924.9 5061.8 5066.7 5108.6 4356.6 4433.3 4434.0 4439.8 4443.0 4542.5 4545.4 4547.7 4568.5 4596.5 4688.6 4744.6 4803.0 4820.5 4821.5 5101.9 5115.6 5139.1 5141.6 5186.8 4799.3 4815.1 4818.6 4829.3 4879.6 4860.5 4919.8 4952.8 5021.8 5083.3 5049.1 5077.8 5079.7 5080.5 5110.4 4938.6 4941.9 4949.8 4950.0 4985.0 4716.3 4832.5 4908.7 4926.6 4986.5 4852.4 4875.5 4924.7 4926.5 4928.4 4953.3 4972.8 4980.0 4982.1 5017.4 4698.4 4725.2 4751.0 4768.1 4826.5 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#1] ext.html Cycles:180 Average:48280.43 Median:200879.50 stddev:89592.22 (44.6%) stddev-sans-first:89771.84 02:37:08 INFO - PROCESS | 1518 | Values: 535.6 582.0 587.8 590.3 599.4 26646.0 29259.6 29352.9 29368.7 29369.9 29414.1 38903.2 39886.0 39952.8 44051.1 7761.7 7883.4 7885.9 7887.5 7888.8 7792.0 7882.6 7883.0 7886.1 7886.5 7894.6 7920.4 7921.7 7928.7 7929.4 7846.0 7894.8 7902.1 7902.3 7911.5 7740.1 7807.6 7807.7 7809.3 7809.8 37624.0 37972.8 37990.8 38000.4 38003.8 3122.7 3164.0 3227.0 3404.5 3714.0 28389.9 28737.6 29165.1 29251.9 29323.4 3235.5 3296.9 3304.0 3309.4 3325.4 246393.0 247146.0 248010.0 248709.8 250544.0 50950.2 50979.2 51142.2 51156.2 51315.0 32652.3 33718.0 33724.2 35486.8 35487.6 14844.6 15127.7 15201.3 15212.2 15213.2 11354.7 11640.2 11651.8 11660.0 11678.2 18085.4 18110.3 18295.2 18374.7 18459.6 6648.9 6885.9 6892.7 6916.9 6954.1 807.6 829.6 869.0 881.2 909.2 25074.9 27314.5 27729.3 27978.7 28152.2 948.6 964.2 1047.6 1054.2 1074.6 14151.8 14595.2 14708.6 14887.6 14910.0 388229.0 388439.0 388554.0 390218.0 392033.0 49078.0 50310.2 50433.2 50530.7 50577.7 1072.6 1087.4 1125.2 1153.2 1203.7 26140.5 28100.7 29219.7 29905.4 30800.8 46490.8 46763.3 47213.0 47223.5 47304.3 358862.0 365225.0 366242.0 366433.0 367354.0 33004.2 33860.5 38362.7 38999.8 39157.0 42153.6 42485.2 42709.6 43258.4 43710.3 35824.3 36878.1 36957.6 37056.3 37282.4 35806.3 36216.8 36284.3 36451.0 36534.0 35605.5 35781.5 36420.3 36514.1 36648.5 31725.0 32712.3 32743.7 33107.8 33295.5 25256.6 25258.5 25355.6 25414.2 25487.4 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#2] jquery.html Cycles:180 Average:25484.51 Median:431327.50 stddev:68651.59 (15.9%) stddev-sans-first:68818.27 02:37:08 INFO - PROCESS | 1518 | Values: 369.9 370.1 370.5 384.0 390.0 15875.5 16114.4 16924.2 16929.9 16951.5 15696.7 16855.3 17162.9 17421.4 17461.1 4921.6 5127.3 5172.2 5173.0 5176.8 3732.8 3923.5 4915.8 5607.7 5949.3 6035.1 6051.1 6067.2 6071.2 6071.3 5760.5 5845.8 5913.3 5914.3 5929.5 3363.0 4881.6 5207.5 5217.2 5225.6 20853.8 20921.5 20957.0 21443.5 21470.1 1965.1 2000.3 2148.7 2292.3 2308.0 12428.7 12695.0 13014.3 13336.9 13444.4 1741.9 1745.9 1765.1 1809.1 1838.1 67669.3 71850.0 72495.0 73122.0 73735.0 10203.4 10267.4 10344.6 10424.7 10471.9 14369.7 14491.5 14510.3 14518.0 14534.6 7398.0 7578.5 7653.0 7665.6 7768.7 7116.3 7295.5 7298.3 7407.5 7429.0 4325.7 4343.1 4456.6 4476.2 4485.1 1679.6 1765.5 2870.8 3032.0 3281.5 754.8 839.7 871.9 923.3 938.6 16040.9 17101.7 17282.4 17300.7 17575.5 830.8 840.9 881.8 883.3 925.0 9287.3 9613.5 9624.4 9718.0 9928.6 379892.0 394230.0 430380.0 432275.0 438673.0 79298.0 83967.0 84791.2 84804.6 85316.0 934.2 943.4 969.8 979.8 985.1 15883.8 16087.6 16104.8 16124.8 16533.8 36037.8 36380.0 37033.4 37435.0 37588.0 50568.5 51217.0 51291.7 51347.0 52258.2 7359.2 7716.5 7840.0 7941.2 8061.4 10034.7 11415.3 11491.5 11926.9 12065.9 8080.7 10022.8 10205.0 10280.5 10294.2 9964.3 9989.5 10074.5 10230.3 10337.5 9943.8 9954.8 10141.5 10488.4 10584.5 7824.6 7843.1 7962.1 8051.7 8229.9 10520.5 10567.2 10609.7 10715.5 10904.6 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#3] mootools.html Cycles:180 Average:5041.66 Median:5262.37 stddev:2792.55 (53.1%) stddev-sans-first:2785.06 02:37:08 INFO - PROCESS | 1518 | Values: 1148.8 1373.6 1427.4 1495.2 1698.0 6404.2 7391.1 7590.7 7606.4 7804.0 7468.2 7611.7 7633.0 7644.0 7652.8 1836.7 2106.3 2183.0 2185.8 2219.2 2197.9 2216.6 2221.5 2222.0 2222.3 2167.7 2168.5 2176.9 2178.2 2192.3 1793.7 2056.9 2135.1 2136.6 2153.0 2087.6 2104.3 2106.4 2108.6 2109.2 7697.7 7741.1 7742.4 7746.1 7772.3 4544.9 4682.4 4684.5 4690.6 4706.7 2737.7 2913.4 2931.6 2938.1 2946.2 840.7 858.4 871.1 881.8 885.3 10363.3 10385.9 10415.5 10428.8 10429.0 4126.5 4297.1 4315.7 4368.3 4374.8 8768.1 8803.8 8817.1 8820.0 8833.5 4688.5 4725.0 4736.6 4738.7 4744.5 3669.9 4140.0 4282.1 4293.8 4381.6 3658.4 3686.7 3728.4 3776.2 3799.1 1107.2 1129.8 1135.4 1140.7 1213.9 719.9 752.3 855.0 861.6 871.1 4974.8 5136.5 5241.6 5252.9 5325.2 805.0 842.2 854.2 860.6 904.0 3427.5 3547.8 3563.5 3564.4 3586.4 9028.4 9239.2 9312.4 9316.6 9525.9 9245.9 9364.6 9485.1 9487.9 9551.1 6912.7 6976.0 7100.5 7112.1 7303.1 5104.7 5260.8 5264.0 5287.5 5293.6 8323.5 8561.5 8588.5 8680.7 8752.7 8547.0 8813.8 8825.2 9026.8 9096.6 5616.7 5820.6 5821.3 6311.8 6413.2 6700.4 7200.6 7456.7 7464.0 7607.9 6394.8 6630.9 6695.1 6853.4 7002.4 6695.3 6752.0 6775.4 6825.0 6851.1 6285.8 6300.7 6338.3 6369.4 6373.3 4282.3 4349.6 4478.7 4534.0 4549.1 4453.2 4514.7 4653.5 4703.8 4717.0 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#4] prototype.html Cycles:180 Average:4128.52 Median:4734.80 stddev:1199.67 (25.3%) stddev-sans-first:1167.88 02:37:08 INFO - PROCESS | 1518 | Values: 287.3 292.1 292.2 302.8 303.4 4736.2 4750.6 4762.7 4776.9 4780.3 4718.5 4721.2 4730.5 4734.0 4735.6 3546.4 3601.7 3622.2 3734.8 3770.0 3664.9 3734.4 3736.5 3750.9 3765.3 3520.9 3692.9 3712.4 3713.6 3721.6 3587.4 3693.6 3698.5 3723.9 3730.4 3272.9 3287.9 3289.3 3295.3 3303.0 4618.9 4620.3 4626.6 4630.2 4643.0 4164.6 4238.7 4251.2 4260.5 4277.4 4885.2 4902.5 4928.3 4931.6 4958.4 3588.0 3595.5 3612.4 3620.5 3625.4 4958.9 5202.2 5203.9 5209.0 5213.4 3567.7 3577.9 3604.4 3605.5 3633.3 3622.5 3628.9 3630.2 3631.8 3634.3 4038.3 4086.1 4153.3 4170.6 4195.2 4856.6 4881.0 4881.7 4894.3 4902.5 1249.5 1265.9 1272.3 1272.4 1273.4 792.8 799.5 837.1 858.5 862.5 4353.6 4362.3 4367.4 4371.5 4377.5 5027.6 5033.0 5084.2 5084.6 5089.7 4265.2 4364.0 4404.2 4419.7 4431.4 2671.9 2695.2 2711.2 2715.5 2737.4 4726.3 4761.9 4768.7 4770.8 4784.8 4974.5 5132.8 5162.1 5170.3 5298.2 4851.5 4873.1 4877.9 4879.2 4881.8 5155.9 5160.9 5161.8 5169.8 5172.0 4858.7 5023.4 5049.7 5067.7 5074.2 4799.5 4851.9 4859.2 4862.7 4881.9 3640.1 3646.3 3646.6 3656.1 3656.6 4984.4 5153.4 5158.8 5170.9 5185.9 4974.4 4998.8 5003.5 5017.4 5037.2 4996.0 4997.6 5000.5 5005.2 5006.2 4685.0 4898.2 4913.8 4933.2 4981.8 4844.6 4960.9 5034.7 5051.5 5054.9 4905.4 4925.8 4937.0 4938.5 4959.3 02:37:08 INFO - PROCESS | 1518 | 02:37:08 INFO - PROCESS | 1518 | [#5] yui.html Cycles:180 Average:17058.55 Median:54959.73 stddev:23970.01 (43.6%) stddev-sans-first:24005.60 02:37:08 INFO - PROCESS | 1518 | Values: 652.8 663.8 667.2 685.8 707.9 13008.0 13683.1 13865.1 14003.4 14005.2 13139.9 13232.0 13251.8 13271.1 13274.5 594.2 728.6 773.5 775.2 786.5 774.7 779.8 783.1 786.4 788.3 832.0 839.0 839.2 840.4 840.8 626.1 767.1 829.8 830.0 834.4 606.1 610.1 610.8 610.8 611.4 13618.2 13697.5 13715.6 13728.4 13744.6 12781.2 12940.6 13189.1 13208.9 13335.7 11729.1 11784.9 11852.8 11892.4 12264.4 4191.1 4219.6 4228.3 4231.9 4241.0 55100.4 55255.0 55307.2 55456.0 55873.7 9704.5 9724.2 10168.6 10278.0 10538.7 17551.6 17891.5 17894.0 18730.5 18780.6 6950.5 6955.5 7035.9 7217.2 7429.6 3934.8 4054.7 4069.1 4073.6 4117.3 2943.6 3037.2 3049.2 3049.6 3056.6 524.5 525.1 529.1 530.2 535.8 497.9 621.6 627.1 630.3 656.8 7745.2 8012.8 8147.6 8185.5 8186.8 513.2 516.4 540.7 609.2 630.4 3879.9 3952.9 3974.3 3974.4 4019.2 54924.7 54994.7 95681.6 97104.0 104592.0 84165.2 85426.0 86829.6 86907.6 89063.0 62214.0 63294.4 77653.0 79970.2 81566.0 8188.4 8435.9 8645.6 8683.1 8720.1 32090.7 33907.8 39911.0 43825.1 45798.5 63134.0 63321.0 63372.7 63941.7 64104.0 10766.4 10976.7 11425.3 11617.8 12301.8 12071.9 12140.0 12901.5 13415.6 13899.2 8253.8 9936.3 9968.4 10275.9 10686.7 11810.1 12417.3 12469.0 12560.3 12754.9 10527.5 10607.5 10645.6 11049.9 11103.1 9443.7 9472.7 9523.0 9820.7 9839.4 8922.8 9131.4 9216.4 9344.3 9574.8 02:37:08 INFO - PROCESS | 1518 | -------- Summary: end -------- 02:37:08 INFO - PROCESS | 1518 | 02:37:09 INFO - TEST-INFO | 1518: exit 0 02:37:09 INFO - TEST-OK | dromaeo_css | took 1120161ms 02:37:09 INFO - TEST-START | kraken 02:37:09 INFO - operating with platform_type : linux_ 02:37:09 INFO - Initialising browser for kraken test... 02:37:09 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6y7Y4n/profile http://localhost:47946/getInfo.html) 02:37:13 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 02:37:13 INFO - PROCESS | 1691 | colorDepth:24 02:37:13 INFO - PROCESS | 1691 | Browser inner width/height: 1024/697 02:37:13 INFO - PROCESS | 1691 | __metrics 02:37:14 INFO - PROCESS | 1691 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:37:14 INFO - PROCESS | 1691 | console.error: PushService: 02:37:14 INFO - PROCESS | 1691 | stateChangeProcessEnqueue: Error transitioning state 02:37:14 INFO - PROCESS | 1691 | UnknownError 02:37:15 INFO - TEST-INFO | 1691: exit 0 02:37:15 INFO - Browser initialized. 02:37:15 INFO - Running cycle 1/1 for kraken test... 02:37:15 INFO - TEST-INFO | started process 1774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6y7Y4n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:27 INFO - PROCESS | 1774 | RSS: Main: 175620096 02:37:27 INFO - PROCESS | 1774 | 02:37:30 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47946/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:31 INFO - PROCESS | 1774 | RSS: Main: 234422272 02:37:31 INFO - PROCESS | 1774 | 02:37:34 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47946/tests/kraken/driver.html?testName=audio-dft) 02:37:34 INFO - PROCESS | 1774 | RSS: Main: 221601792 02:37:34 INFO - PROCESS | 1774 | 02:37:37 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47946/tests/kraken/driver.html?testName=audio-fft) 02:37:38 INFO - PROCESS | 1774 | RSS: Main: 288997376 02:37:38 INFO - PROCESS | 1774 | 02:37:40 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47946/tests/kraken/driver.html?testName=audio-oscillator) 02:37:41 INFO - PROCESS | 1774 | RSS: Main: 199135232 02:37:41 INFO - PROCESS | 1774 | 02:37:43 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:44 INFO - PROCESS | 1774 | RSS: Main: 202584064 02:37:44 INFO - PROCESS | 1774 | 02:37:47 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47946/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:47 INFO - PROCESS | 1774 | RSS: Main: 238485504 02:37:47 INFO - PROCESS | 1774 | 02:37:51 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47946/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:52 INFO - PROCESS | 1774 | RSS: Main: 235094016 02:37:52 INFO - PROCESS | 1774 | 02:37:54 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47946/tests/kraken/driver.html?testName=json-parse-financial) 02:37:55 INFO - PROCESS | 1774 | RSS: Main: 237752320 02:37:55 INFO - PROCESS | 1774 | 02:37:57 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:57 INFO - PROCESS | 1774 | RSS: Main: 225710080 02:37:57 INFO - PROCESS | 1774 | 02:37:59 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:00 INFO - PROCESS | 1774 | RSS: Main: 229982208 02:38:00 INFO - PROCESS | 1774 | 02:38:02 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:03 INFO - PROCESS | 1774 | RSS: Main: 239378432 02:38:03 INFO - PROCESS | 1774 | 02:38:06 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:06 INFO - PROCESS | 1774 | RSS: Main: 243019776 02:38:06 INFO - PROCESS | 1774 | 02:38:09 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:10 INFO - PROCESS | 1774 | RSS: Main: 242388992 02:38:10 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | Cycle 1(1): loaded http://localhost:47946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47946/tests/kraken/driver.html?testName=ai-astar) 02:38:12 INFO - PROCESS | 1774 | RSS: Main: 286138368 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | __start_tp_report 02:38:12 INFO - PROCESS | 1774 | _x_x_mozilla_page_load 02:38:12 INFO - PROCESS | 1774 | _x_x_mozilla_page_load_details 02:38:12 INFO - PROCESS | 1774 | |i|pagename|runs| 02:38:12 INFO - PROCESS | 1774 | |0;ai-astar;114;109;114;113;113;112;112;112;113;113 02:38:12 INFO - PROCESS | 1774 | |1;audio-beat-detection;162;134;133;190;137;158;156;132;199;138 02:38:12 INFO - PROCESS | 1774 | |2;audio-dft;161;161;161;163;162;161;163;163;161;160 02:38:12 INFO - PROCESS | 1774 | |3;audio-fft;75;75;75;109;82;76;74;74;102;75 02:38:12 INFO - PROCESS | 1774 | |4;audio-oscillator;87;86;119;86;86;87;118;86;86;127 02:38:12 INFO - PROCESS | 1774 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 02:38:12 INFO - PROCESS | 1774 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;146;146 02:38:12 INFO - PROCESS | 1774 | |7;imaging-desaturate;95;95;96;94;95;95;95;95;94;94 02:38:12 INFO - PROCESS | 1774 | |8;json-parse-financial;62;62;63;62;62;62;61;62;61;63 02:38:12 INFO - PROCESS | 1774 | |9;json-stringify-tinderbox;64;64;65;64;64;66;67;66;66;65 02:38:12 INFO - PROCESS | 1774 | |10;stanford-crypto-aes;90;84;84;83;89;85;90;86;133;84 02:38:12 INFO - PROCESS | 1774 | |11;stanford-crypto-ccm;138;132;129;135;135;132;146;126;153;136 02:38:12 INFO - PROCESS | 1774 | |12;stanford-crypto-pbkdf2;170;169;171;174;169;169;173;172;173;171 02:38:12 INFO - PROCESS | 1774 | |13;stanford-crypto-sha256-iterative;68;68;68;66;67;72;68;66;66;66 02:38:12 INFO - PROCESS | 1774 | __end_tp_report 02:38:12 INFO - PROCESS | 1774 | __start_cc_report 02:38:12 INFO - PROCESS | 1774 | _x_x_mozilla_cycle_collect,1914 02:38:12 INFO - PROCESS | 1774 | __end_cc_report 02:38:12 INFO - PROCESS | 1774 | __startTimestamp1465637892300__endTimestamp 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | ------- Summary: start ------- 02:38:12 INFO - PROCESS | 1774 | Number of tests: 14 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.43 (1.3%) stddev-sans-first:1.41 02:38:12 INFO - PROCESS | 1774 | Values: 114.0 109.0 114.0 113.0 113.0 112.0 112.0 112.0 113.0 113.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:157.00 stddev:24.21 (15.4%) stddev-sans-first:25.50 02:38:12 INFO - PROCESS | 1774 | Values: 162.0 134.0 133.0 190.0 137.0 158.0 156.0 132.0 199.0 138.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 02:38:12 INFO - PROCESS | 1774 | Values: 161.0 161.0 161.0 163.0 162.0 161.0 163.0 163.0 161.0 160.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:12.86 (17.1%) stddev-sans-first:13.41 02:38:12 INFO - PROCESS | 1774 | Values: 75.0 75.0 75.0 109.0 82.0 76.0 74.0 74.0 102.0 75.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:86.00 stddev:17.09 (19.9%) stddev-sans-first:17.76 02:38:12 INFO - PROCESS | 1774 | Values: 87.0 86.0 119.0 86.0 86.0 87.0 118.0 86.0 86.0 127.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:38:12 INFO - PROCESS | 1774 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 02:38:12 INFO - PROCESS | 1774 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:38:12 INFO - PROCESS | 1774 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:38:12 INFO - PROCESS | 1774 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 61.0 62.0 61.0 63.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.50 stddev:1.10 (1.7%) stddev-sans-first:1.09 02:38:12 INFO - PROCESS | 1774 | Values: 64.0 64.0 65.0 64.0 64.0 66.0 67.0 66.0 66.0 65.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:85.50 stddev:15.06 (17.6%) stddev-sans-first:15.97 02:38:12 INFO - PROCESS | 1774 | Values: 90.0 84.0 84.0 83.0 89.0 85.0 90.0 86.0 133.0 84.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:135.50 stddev:8.00 (5.9%) stddev-sans-first:8.46 02:38:12 INFO - PROCESS | 1774 | Values: 138.0 132.0 129.0 135.0 135.0 132.0 146.0 126.0 153.0 136.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:1.85 (1.1%) stddev-sans-first:1.92 02:38:12 INFO - PROCESS | 1774 | Values: 170.0 169.0 171.0 174.0 169.0 169.0 173.0 172.0 173.0 171.0 02:38:12 INFO - PROCESS | 1774 | 02:38:12 INFO - PROCESS | 1774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 02:38:12 INFO - PROCESS | 1774 | Values: 68.0 68.0 68.0 66.0 67.0 72.0 68.0 66.0 66.0 66.0 02:38:12 INFO - PROCESS | 1774 | -------- Summary: end -------- 02:38:12 INFO - PROCESS | 1774 | 02:38:13 INFO - TEST-INFO | 1774: exit 0 02:38:13 INFO - TEST-OK | kraken | took 64219ms 02:38:13 INFO - SUITE-END | took 1184s 02:38:13 INFO - Completed test suite (00:19:44) 02:38:13 INFO - javascript benchmark 02:38:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.311712396215, 2614.019742596526, 2639.709631940487, 2657.973420265798, 2660.241831078142, 4604.171249175156, 4659.930101048487, 4682.461516925555, 4748.477667456581, 4783.712977221365, 4699.882502937428, 4725.7164570125815, 4739.90520189596, 4771.069641419916, 4820.542048505386, 4249.553796851333, 4266.424032755584, 4277.272863613193, 4342.435483387163, 4421.049474363027, 4337.349397590371, 4363.0619416825375, 4455.242608756503, 4478.596926276635, 4488.326750987361, 4252.553481884389, 4397.934030989538, 4406.317020861771, 4423.292273236299, 4436.6672499562665, 4211.7051806373565, 4222.2822120239325, 4258.510271318807, 4278.0, 4292.29177185764, 4188.120494696117, 4236.237477254093, 4254.234237837188, 4281.7002809803325, 4299.828006879721, 4616.238320677085, 4683.274092515666, 4684.601808846252, 4707.952920470786, 4713.811447542094, 4968.701877887338, 5028.84913452597, 5037.546620804145, 5114.616403769695, 5114.769835357418, 5100.489951004907, 5110.872228194287, 5117.385913690344, 5125.2312153176945, 5146.047981123466, 4605.631549476034, 4706.882327941828, 4739.218029025173, 4741.620670346364, 4746.667733258673, 5217.452167522431, 5232.529072383504, 5300.602454815904, 5304.496072873071, 5304.92042619361, 5012.724300163453, 5062.670926389773, 5063.0, 5063.417706963746, 5074.0, 4938.38270216223, 4995.100881841304, 5040.647154699136, 5132.743362831843, 5180.0157969985585, 5015.14742493777, 5016.698998060128, 5043.747812609428, 5047.747612619354, 5054.797808087709, 4986.650934434628, 4988.052270068675, 4998.700077995332, 4999.775010124553, 5054.974725126351, 4068.6541643960004, 4116.197341518375, 4167.270727622654, 4186.811593478301, 4236.91526169481, 3642.8907132786057, 3692.8522859085874, 3705.8517659293866, 3726.4224045273027, 3743.344914639927, 4386.429764130707, 4389.714668546534, 4392.978035109804, 4393.890152746207, 4438.201123797683, 4873.853784386474, 4924.926126108111, 5061.848144555669, 5066.695998240118, 5108.56577190943, 4356.607905288539, 4433.334999750064, 4433.977830110829, 4439.844605438859, 4443.0, 4542.545745425497, 4545.431821022372, 4547.7498737569085, 4568.543145685471, 4596.517365676623, 4688.578027977498, 4744.644151688568, 4802.951970480251, 4820.517948205152, 4821.4696383397095, 5101.897962040813, 5115.64190506661, 5139.074966506065, 5141.562967147835, 5186.792528298976, 4799.304100905419, 4815.061063092663, 4818.638602104786, 4829.323894654822, 4879.634027447884, 4860.513948605111, 4919.827806026772, 4952.826651067196, 5021.824236151717, 5083.339165908408, 5049.116404629101, 5077.822276220462, 5079.6698214615935, 5080.49195080489, 5110.386753589593, 4938.629602779734, 4941.876453088702, 4949.752512374439, 4950.034743225036, 4984.975075124601, 4716.339712440193, 4832.49258827818, 4908.730019848943, 4926.605871530197, 4986.501349864984, 4852.369192005017, 4875.512448755097, 4924.679895806761, 4926.458089610069, 4928.433230178575, 4953.2570114483115, 4972.801087956441, 4979.975100124476, 4982.10322142018, 5017.448080711192, 4698.389209402756, 4725.196716558262, 4751.049790041936, 4768.117898188846, 4826.517348265286], "value": 4639.47728730812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.5616750546008, 581.9621724587902, 587.7590188022912, 590.3240789296259, 599.4425184578341, 26646.0, 29259.56110658342, 29352.85323573382, 29368.706312936865, 29369.85315073427, 29414.117576472687, 38903.22193556127, 39886.0, 39952.80023599885, 44051.11897762043, 7761.689532418696, 7883.448158628898, 7885.881711774328, 7887.526748395086, 7888.802779930519, 7792.0, 7882.566458844762, 7883.0, 7886.132525422199, 7886.487378320419, 7894.565798881059, 7920.405969552277, 7921.683132674686, 7928.722494712686, 7929.405294602928, 7845.960770196141, 7894.80262993424, 7902.051753789525, 7902.328302094329, 7911.525308481452, 7740.148583655793, 7807.570583617899, 7807.6876924922935, 7809.336206422461, 7809.843803123906, 37624.0, 37972.81013594942, 37990.81004594987, 38000.42999355012, 38003.809980950195, 3122.656507784142, 3164.0, 3227.0318904328606, 3404.5403870477417, 3714.0, 28389.858050709616, 28737.56893646597, 29165.125046248435, 29251.853740731374, 29323.41353172946, 3235.5097948249727, 3296.884609038696, 3303.975767512079, 3309.3546758382126, 3325.3681800457834, 246393.0, 247146.0, 248010.0, 248709.7564512184, 250544.0, 50950.23574646383, 50979.23531147036, 51142.23286650703, 51156.23265651018, 51315.0, 32652.346953060805, 33718.0, 33724.156896077795, 35486.82256588752, 35487.645123548435, 14844.554663360117, 15127.697446051017, 15201.31594078247, 15212.1633310169, 15213.239338033276, 11354.716132096764, 11640.243384180001, 11651.76696466066, 11660.0, 11678.240914340711, 18085.36701215451, 18110.28345748122, 18295.176717047765, 18374.724379134324, 18459.630807383775, 6648.900266496006, 6885.931140688629, 6892.657061325253, 6916.930830691628, 6954.130733658293, 807.6244546286006, 829.6059371798468, 868.9652413903373, 881.1976322169944, 909.1544863277084, 25074.87462562712, 27314.453710926067, 27729.306767330574, 27978.720212797612, 28152.155435336972, 948.5541795356172, 964.233434419624, 1047.5704960965968, 1054.2198772908146, 1074.5701719312337, 14151.787723184161, 14595.197264150574, 14708.55874323772, 14887.553373398816, 14910.0, 388229.0, 388439.0, 388554.0, 390218.0, 392033.0, 49078.0, 50310.24534631983, 50433.24350134751, 50530.74734626304, 50577.747111264944, 1072.6406653770919, 1087.3693257910393, 1125.2235957189514, 1153.1870031627682, 1203.668991027457, 26140.477190456466, 28100.71899280981, 29219.707802921697, 29905.401891962472, 30800.845995769876, 46490.767546163406, 46763.29855052245, 47213.0, 47223.52776472329, 47304.29043564418, 358862.0, 365225.0, 366242.0, 366433.0, 367354.0, 33004.1748956278, 33860.49209261814, 38362.657306995236, 38999.80500097481, 39157.0, 42153.57846421497, 42485.15029699451, 42709.57290427056, 43258.35112473378, 43710.344344834215, 35824.28351433009, 36878.078048049014, 36957.63042369542, 37056.25887482289, 37282.440763388026, 35806.283874322886, 36216.81891590525, 36284.27431451409, 36451.0, 36534.0, 35605.465918010734, 35781.46327805137, 36420.27159456849, 36514.08714782152, 36648.45027324539, 31725.0, 32712.34575308433, 32743.672563274064, 33107.84122555699, 33295.50056749102, 25256.621150682386, 25258.49483010293, 25355.61966570466, 25414.20443751149, 25487.36281592975], "value": 17475.602488794648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.86315063426537, 370.0655843993915, 370.4739270236264, 383.9884803455894, 389.9532056153262, 15875.523734287975, 16114.35542578297, 16924.2384092716, 16929.91535042323, 16951.49145525633, 15696.686066278697, 16855.325786968508, 17162.914185429054, 17421.390251341207, 17461.12694365283, 4921.630877684179, 5127.256547800566, 5172.172452407615, 5173.042987047408, 5176.844694659167, 3732.8133593320363, 3923.489946306976, 4915.82794602189, 5607.719614019283, 5949.345571987078, 6035.064564992411, 6051.062085376773, 6067.180930574382, 6071.210742603455, 6071.301800292957, 5760.510356619692, 5845.824625261249, 5913.349531551526, 5914.319853216871, 5929.466348028676, 3362.96637033629, 4881.585065269456, 5207.4792520748, 5217.217417387385, 5225.634205605571, 20853.79146208549, 20921.476963075893, 20957.0, 21443.49895507315, 21470.141194352207, 1965.0862349007637, 2000.349886286948, 2148.709924160234, 2292.3008482412856, 2307.976920230793, 12428.689282767913, 12695.0, 13014.284214368206, 13336.933315333361, 13444.395002224923, 1741.939032133882, 1745.8777885548018, 1765.0645158066245, 1809.1316168239318, 1838.117703502313, 67669.32330676728, 71850.0, 72495.0, 73122.0, 73735.0, 10203.38779673222, 10267.383956962607, 10344.637937672145, 10424.739381515372, 10471.895281047093, 14369.712605747827, 14491.492797752027, 14510.347034383478, 14518.0, 14534.636634084021, 7398.0, 7578.54528728267, 7653.0, 7665.61671916402, 7768.689252429839, 7116.252793456716, 7295.489315747846, 7298.343149116605, 7407.481476296715, 7429.0, 4325.675574331937, 4343.109662519176, 4456.6211871991245, 4476.171908196929, 4485.0581377911, 1679.5968967447968, 1765.496833402474, 2870.7990440668955, 3031.9545206821917, 3281.506914353963, 754.7924320811711, 839.6858915796759, 871.9084496127942, 923.330585325647, 938.6198589571235, 16040.919795401182, 17101.657966840594, 17282.395116171127, 17300.65398692019, 17575.472735817944, 830.779843341515, 840.8906842110608, 881.7795551112222, 883.3330835219368, 924.9548010747812, 9287.349885508085, 9613.471259080818, 9624.422534647943, 9718.0, 9928.553215105338, 379892.0, 394230.0, 430380.0, 432275.0, 438673.0, 79298.0, 83967.0, 84791.15208847832, 84804.57597712096, 85316.0, 934.1592566690033, 943.3538026451903, 969.8448248280241, 979.7599588100961, 985.0789511806483, 15883.761743573625, 16087.597810054374, 16104.758428623814, 16124.79064070176, 16533.751993720343, 36037.81981090183, 36380.0, 37033.44449833308, 37435.0, 37588.0, 50568.49431505785, 51217.0, 51291.71770705762, 51347.031735408586, 52258.21612675889, 7359.227281135403, 7716.459847810824, 7840.0, 7941.205879412244, 8061.435699500978, 10034.749131271485, 11415.315081095161, 11491.540338386705, 11926.940365298466, 12065.939670301592, 8080.676772929017, 10022.849657255001, 10205.0, 10280.537375817956, 10294.176465882862, 9964.302498825013, 9989.500524973868, 10074.54664540112, 10230.335028223142, 10337.483125843828, 9943.751406214902, 9954.751131221488, 10141.492925353556, 10488.423136727248, 10584.523696433525, 7824.5524577953265, 7843.058832940083, 7962.0871915114285, 8051.718189863327, 8229.917700822914, 10520.526576303932, 10567.154627629925, 10609.681709548726, 10715.464226788785, 10904.61833835812], "value": 8510.911807352577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1148.8047032004558, 1373.5535950815984, 1427.3933578229253, 1495.192595998161, 1697.9745303820437, 6404.199475065617, 7391.0761154855645, 7590.734324298651, 7606.429517786168, 7804.0, 7468.178500364956, 7611.657475413605, 7632.961835190817, 7644.0, 7652.846943061136, 1836.706127019677, 2106.3365040012345, 2182.9563408731897, 2185.792349726781, 2219.201087608468, 2197.9010944507454, 2216.601011817872, 2221.522372689871, 2222.022310183514, 2222.3221917315213, 2167.696522486853, 2168.5229249565073, 2176.858504197222, 2178.194068194762, 2192.331338941622, 1793.6681713882908, 2056.8868712220824, 2135.092585651092, 2136.6260904341834, 2153.041896356114, 2087.6033553624916, 2104.316097268394, 2106.3891471473253, 2108.5677436125557, 2109.24067335759, 7697.653605587706, 7741.064733816545, 7742.419318551075, 7746.147923728386, 7772.3393511551585, 4544.909101817945, 4682.367880336145, 4684.531546845323, 4690.624750020024, 4706.670533062653, 2737.7399147080996, 2913.4318807832483, 2931.589577459157, 2938.147937098239, 2946.175070980129, 840.6805413942724, 858.3776761847673, 871.0853603716073, 881.8060026794095, 885.2563846369017, 10363.274570780048, 10385.948070259676, 10415.479226038744, 10428.843567346496, 10429.0, 4126.504819421629, 4297.076128632359, 4315.654747620183, 4368.301071828492, 4374.78126093694, 8768.07935166811, 8803.823923521493, 8817.118288171132, 8820.029796722356, 8833.514156721314, 4688.507706690816, 4725.031368569435, 4736.550027747358, 4738.715677059387, 4744.478107408182, 3669.8532058717888, 4139.97930010348, 4282.143571285756, 4293.785310734451, 4381.5618438155925, 3658.378075727133, 3686.7234957378305, 3728.440733889884, 3776.188119554309, 3799.0882188274613, 1107.213878146525, 1129.8418221449003, 1135.4039129456935, 1140.7091191746051, 1213.8846809553079, 719.8776208044645, 752.2928447259668, 854.9700760473354, 861.629499315288, 871.1419252036738, 4974.825881094217, 5136.537711605899, 5241.554467870197, 5252.921206181911, 5325.227841962894, 804.9678012879536, 842.2125312832521, 854.2013217641525, 860.6428332242175, 903.9728808135767, 3427.485877118452, 3547.840347184383, 3563.501109844624, 3564.376234159012, 3586.3903136466865, 9028.413153145024, 9239.168474837297, 9312.394694344846, 9316.627334906529, 9525.857112143323, 9245.861312080324, 9364.578593963288, 9485.14633682958, 9487.857682134774, 9551.140397364132, 6912.723491060402, 6975.965120174366, 7100.538464999759, 7112.110986126734, 7303.123625164908, 5104.69371837691, 5260.763265652979, 5263.973680131575, 5287.471252874836, 5293.5765138789575, 8323.500589964622, 8561.529115898686, 8588.527630980356, 8680.739577812676, 8752.737417877473, 8546.957265213634, 8813.779655508664, 8825.249853762245, 9026.774330641787, 9096.590653420479, 5616.66300022, 5820.563457740602, 5821.330546987151, 6311.810645680637, 6413.198350206224, 6700.430463410665, 7200.567965921852, 7456.701731930879, 7464.0, 7607.923920760722, 6394.840128996812, 6630.900536492053, 6695.09616201826, 6853.383195512428, 7002.369786719016, 6695.296993815774, 6752.0, 6775.4240889524945, 6825.0, 6851.109355783717, 6285.842853928689, 6300.653464059521, 6338.271098823694, 6369.363063693593, 6373.330800265905, 4282.272013757606, 4349.565043495625, 4478.731276123443, 4533.977330113328, 4549.067441174485, 4453.19842428366, 4514.706544074625, 4653.53464653532, 4703.764811759467, 4717.0], "value": 4066.141248505658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.34628719662766, 292.1294542264053, 292.23288866724846, 302.7744330473797, 303.3674788066879, 4736.242201247796, 4750.596199323053, 4762.714237145774, 4776.877433803063, 4780.330753694481, 4718.4809670936165, 4721.238075725704, 4730.526947305268, 4733.976330118353, 4735.621150307976, 3546.379383607871, 3601.7118630509626, 3622.1850083731083, 3734.759144513284, 3769.962300377002, 3664.890053298392, 3734.365157923146, 3736.458213559032, 3750.924981500368, 3765.3034188675047, 3520.9295814083703, 3692.947509959662, 3712.3874560697454, 3713.5915049344685, 3721.6092310307436, 3587.3542762302777, 3693.649103335179, 3698.519192504957, 3723.8696645617542, 3730.3658378075656, 3272.9018129456153, 3287.9342413151844, 3289.3092450585405, 3295.307985323085, 3302.9504557431655, 4618.884527886796, 4620.267399725103, 4626.606738427237, 4630.18971679958, 4643.0, 4164.583541645841, 4238.745675259494, 4251.171021650779, 4260.531341552427, 4277.358396240557, 4885.218365061573, 4902.534259245366, 4928.33467481889, 4931.580815630676, 4958.380202474691, 3588.0, 3595.532580764484, 3612.3858943979585, 3620.4931309616672, 3625.4199328107375, 4958.9008219835405, 5202.167653175474, 5203.869903252411, 5209.0, 5213.42652308242, 3567.696745776638, 3577.9284414312087, 3604.4052731299043, 3605.4591811228524, 3633.345997720383, 3622.4747411625167, 3628.8911332660064, 3630.2376500935097, 3631.819658610962, 3634.254977729612, 4038.3134867072667, 4086.1419101988913, 4153.317906247914, 4170.603792639695, 4195.202911446815, 4856.63575231852, 4881.0, 4881.731504767272, 4894.339264199359, 4902.509749025069, 1249.4564864284066, 1265.9303738294482, 1272.344742457635, 1272.4464857786893, 1273.3696820074122, 792.7502836606451, 799.5402643480022, 837.0708513550077, 858.52780970466, 862.4566523090413, 4353.6299414549485, 4362.302031674917, 4367.366731823868, 4371.453568303962, 4377.474703035592, 5027.567143364124, 5033.0, 5084.161113416319, 5084.6440749147205, 5089.6691715038405, 4265.168292182994, 4364.0, 4404.207242696345, 4419.668524860648, 4431.379606855043, 2671.919842404692, 2695.191442567222, 2711.240852561286, 2715.5247831629385, 2737.3840885800537, 4726.338312636233, 4761.880952976203, 4768.713877167381, 4770.833020844323, 4784.784684689197, 4974.452810190876, 5132.820351287687, 5162.148245539519, 5170.250313704567, 5298.178782288752, 4851.539103785135, 4873.1471992400475, 4877.878053048702, 4879.243717223836, 4881.804727810848, 5155.922661160161, 5160.870978225575, 5161.7677204526635, 5169.844904652867, 5172.0, 4858.7164032904475, 5023.419320689908, 5049.747512624427, 5067.719526213293, 5074.188129899198, 4799.520047995173, 4851.902961940671, 4859.198232291632, 4862.708237505761, 4881.926771098365, 3640.1263696712067, 3646.3254297954963, 3646.6353364663323, 3656.104254457675, 3656.6160553141535, 4984.352034235526, 5153.3815942087185, 5158.793648254028, 5170.8965820684125, 5185.870353241199, 4974.358461707556, 4998.750062496933, 5003.523255988309, 5017.397912250407, 5037.19404895215, 4995.975824955948, 4997.625178111729, 5000.549950504472, 5005.224190250371, 5006.1739812930455, 4684.976575117103, 4898.24077268024, 4913.77887995034, 4933.235348520985, 4981.825636102864, 4844.612431005582, 4960.925586116284, 5034.697918124924, 5051.545360917388, 5054.873628159326, 4905.362302900743, 4925.827596034122, 4936.950630493793, 4938.506149385033, 4959.330490383752], "value": 3746.3022169645806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.8498445357568, 663.7743167323109, 667.1960287853137, 685.8388278754495, 707.9044329015583, 13008.024398170139, 13683.110597811148, 13865.098768580036, 14003.36984835681, 14005.159690418583, 13139.868601313983, 13232.0, 13251.80122298164, 13271.137376070548, 13274.535391261285, 594.2245369792419, 728.5628622826289, 773.4547144263295, 775.1628241499168, 786.4573444323427, 774.7404619452462, 779.8128449172186, 783.1150799596448, 786.4298383671821, 788.3377962511489, 831.995840020799, 839.0225387423644, 839.1776059461731, 840.4411066640677, 840.8066144786703, 626.076537107767, 767.1178145133085, 829.8008477965245, 830.0247209528779, 834.4117397234966, 606.1362558354327, 610.081826850587, 610.7587502936316, 610.7648555306195, 611.4496952742568, 13618.18290902549, 13697.452101916011, 13715.588532344045, 13728.382222799997, 13744.587662370144, 12781.16922400041, 12940.57653658097, 13189.076764626385, 13208.933955330258, 13335.73328533424, 11729.120315976335, 11784.882151178464, 11852.762944741144, 11892.405379730979, 12264.448099835528, 4191.077962848199, 4219.556946520602, 4228.281192197333, 4231.851885184004, 4241.0, 55100.448995510334, 55255.0, 55307.170392444146, 55456.0, 55873.72063139699, 9704.466254355937, 9724.17344525709, 10168.644097456554, 10278.0, 10538.736531586772, 17551.561210969572, 17891.46325610234, 17894.0, 18730.53173670642, 18780.624387512173, 6950.478714096463, 6955.513114081966, 7035.859282814315, 7217.170025447141, 7429.628518574158, 3934.8229329680235, 4054.716169868081, 4069.1251380953236, 4073.551909289976, 4117.3206420940205, 2943.632045994251, 3037.179961410407, 3049.161480592855, 3049.60355153833, 3056.6332040155326, 524.4807640435941, 525.1413938211052, 529.1454301303368, 530.2258702294693, 535.7998084291238, 497.9477154898756, 621.623917529897, 627.0656721484954, 630.2846269484169, 656.7931101702949, 7745.22547745221, 8012.839743205103, 8147.592620368958, 8185.4684607329655, 8186.795330116675, 513.1627734519836, 516.3983958688161, 540.6620861961275, 609.1563184988822, 630.3538872655473, 3879.903002424962, 3952.9011774705864, 3974.3442332014893, 3974.3839704845795, 4019.196160767858, 54924.72537637366, 54994.72502637541, 95681.56477652841, 97104.0, 104592.0, 84165.15834841695, 85426.0, 86829.5658521716, 86907.56546217228, 89063.0, 62214.0, 63294.36705632885, 77653.0, 79970.20029799743, 81566.0, 8188.426810123234, 8435.8734618982, 8645.567721613768, 8683.088275730957, 8720.12798720123, 32090.679093208768, 33907.83046084754, 39911.0, 43825.12349752923, 45798.54201457943, 63134.0, 63321.0, 63372.68313658402, 63941.68029159824, 64104.0, 10766.407847568458, 10976.725581860517, 11425.31448113116, 11617.825732614187, 12301.75396492083, 12071.939640301742, 12140.028797695986, 12901.516325622673, 13415.597532074053, 13899.235542045284, 8253.79365515867, 9936.254780891317, 9968.40189588598, 10275.948620256851, 10686.679399618024, 11810.114241432098, 12417.254964702146, 12469.0, 12560.309182995023, 12754.936225318814, 10527.4736263185, 10607.469626518798, 10645.574177032831, 11049.889501104886, 11103.056240219672, 9443.716688499357, 9472.715818525456, 9523.0, 9820.705378838646, 9839.409635421898, 8922.821543568962, 9131.360804743605, 9216.447013179231, 9344.29997701388, 9574.808503830023], "value": 6550.133795167248, "unit": "score"}], "name": "dromaeo_css", "value": 6402.172521341648, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 133.0, 190.0, 137.0, 158.0, 156.0, 132.0, 199.0, 138.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 163.0, 163.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 82.0, 76.0, 74.0, 74.0, 102.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 119.0, 86.0, 86.0, 87.0, 118.0, 86.0, 86.0, 127.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 84.0, 83.0, 89.0, 85.0, 90.0, 86.0, 133.0, 84.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 129.0, 135.0, 135.0, 132.0, 146.0, 126.0, 153.0, 136.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 171.0, 174.0, 169.0, 169.0, 173.0, 172.0, 173.0, 171.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 67.0, 72.0, 68.0, 66.0, 66.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1556.9999999999998, "alertThreshold": 2.0}]} 02:38:13 INFO - Return code: 0 02:38:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:38:13 INFO - # TBPL SUCCESS # 02:38:13 INFO - Running post-action listener: _resource_record_post_action 02:38:13 INFO - ##### 02:38:13 INFO - ##### Finished run-tests step (success) 02:38:13 INFO - ##### 02:38:13 INFO - Running post-run listener: _resource_record_post_run 02:38:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541863936; Read time: 8; Write time: 546260 02:38:13 INFO - TinderboxPrint: CPU usage
13.1% 02:38:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:38:13 INFO - TinderboxPrint: I/O write bytes / time
541,863,936 / 546,260 02:38:13 INFO - TinderboxPrint: CPU idle
8,330.8 (86.8%) 02:38:13 INFO - TinderboxPrint: CPU user
1,212.4 (12.6%) 02:38:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:38:13 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244879360; Read time: 0; Write time: 309212 02:38:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296984576; Read time: 8; Write time: 237048 02:38:14 INFO - Running post-run listener: _upload_blobber_files 02:38:14 INFO - Blob upload gear active. 02:38:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:14 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:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:15 INFO - (blobuploader) - INFO - Done attempting. 02:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:18 INFO - (blobuploader) - INFO - Done attempting. 02:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:19 INFO - (blobuploader) - INFO - Done attempting. 02:38:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:19 INFO - Return code: 0 02:38:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5077cfa3227b7b72b4ed5b870cd04e0d6f0ecddcecc49d72a5704c3a8c3536044e1e12634f1701d5416efd8bc130eb215248d0102572545ee8dc2f00b7fca625", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37bd0e84dd49d43ff5ac4984c2387b5f9a905d9ad1b2678ceb2bc8abb8ddb3265ac54a9209acd909fe4c49c690337efdda6de8dd330cc6bc2b83164dfe80c892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40ea8462b53f16cb76f477cf23781a849d6f47a963c6f827dc268e79ed5f9fa69627944f04d15973f29b28021d6986d8376889d8b77e145374d334a486122859"} 02:38:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:19 INFO - Contents: 02:38:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5077cfa3227b7b72b4ed5b870cd04e0d6f0ecddcecc49d72a5704c3a8c3536044e1e12634f1701d5416efd8bc130eb215248d0102572545ee8dc2f00b7fca625", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37bd0e84dd49d43ff5ac4984c2387b5f9a905d9ad1b2678ceb2bc8abb8ddb3265ac54a9209acd909fe4c49c690337efdda6de8dd330cc6bc2b83164dfe80c892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40ea8462b53f16cb76f477cf23781a849d6f47a963c6f827dc268e79ed5f9fa69627944f04d15973f29b28021d6986d8376889d8b77e145374d334a486122859"} 02:38:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:19 INFO - Copying logs to upload dir... 02:38:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.070988 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-11 02:38:19.306674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:38:19.312536) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5077cfa3227b7b72b4ed5b870cd04e0d6f0ecddcecc49d72a5704c3a8c3536044e1e12634f1701d5416efd8bc130eb215248d0102572545ee8dc2f00b7fca625", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37bd0e84dd49d43ff5ac4984c2387b5f9a905d9ad1b2678ceb2bc8abb8ddb3265ac54a9209acd909fe4c49c690337efdda6de8dd330cc6bc2b83164dfe80c892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40ea8462b53f16cb76f477cf23781a849d6f47a963c6f827dc268e79ed5f9fa69627944f04d15973f29b28021d6986d8376889d8b77e145374d334a486122859"} build_url:https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/XnXXnmyNSPuCzKivBYmGTw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5077cfa3227b7b72b4ed5b870cd04e0d6f0ecddcecc49d72a5704c3a8c3536044e1e12634f1701d5416efd8bc130eb215248d0102572545ee8dc2f00b7fca625", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37bd0e84dd49d43ff5ac4984c2387b5f9a905d9ad1b2678ceb2bc8abb8ddb3265ac54a9209acd909fe4c49c690337efdda6de8dd330cc6bc2b83164dfe80c892", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40ea8462b53f16cb76f477cf23781a849d6f47a963c6f827dc268e79ed5f9fa69627944f04d15973f29b28021d6986d8376889d8b77e145374d334a486122859"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:38:19.342371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:38:19.342709) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465636460.558897-1257881145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:38:19.426018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:38:19.426446) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:38:19.426986) ========= ========= Total master_lag: 0.17 =========