builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1465376524.64 results: success (0) buildid: 20160607233004 builduid: 91c1474d589245f196ca42ccac1a329f revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.637388) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.637884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.638212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.679057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.679410) ========= 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=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 02:02:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.7M=0s 2016-06-08 02:02:05 (23.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.874411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.874732) ========= 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=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019161 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:04.930700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 02:02:04.931052) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1401fcd673699f8d6e431ccb643ab46e166da2a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1401fcd673699f8d6e431ccb643ab46e166da2a9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 02:02:05,157 truncating revision to first 12 chars 2016-06-08 02:02:05,157 Setting DEBUG logging. 2016-06-08 02:02:05,157 attempt 1/10 2016-06-08 02:02:05,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1401fcd67369?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 02:02:06,406 unpacking tar archive at: fx-team-1401fcd67369/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 02:02:06.542562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:06.542899) ========= script_repo_revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:06.543348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:06.543618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 02:02:06.553137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 02:02:06.553658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:06 INFO - MultiFileLogger online at 20160608 02:02:06 in /builds/slave/test 02:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:06 INFO - {'append_to_log': False, 02:02:06 INFO - 'base_work_dir': '/builds/slave/test', 02:02:06 INFO - 'blob_upload_branch': 'Fx-Team', 02:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:06 INFO - 'branch': 'Fx-Team', 02:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:06 INFO - 'config_files': ('talos/linux_config.py',), 02:02:06 INFO - 'default_actions': ('clobber', 02:02:06 INFO - 'read-buildbot-config', 02:02:06 INFO - 'download-and-extract', 02:02:06 INFO - 'populate-webroot', 02:02:06 INFO - 'create-virtualenv', 02:02:06 INFO - 'install', 02:02:06 INFO - 'run-tests'), 02:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:06 INFO - 'download_minidump_stackwalk': True, 02:02:06 INFO - 'download_symbols': 'ondemand', 02:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:06 INFO - 'installer_path': 'installer.exe', 02:02:06 INFO - 'log_level': 'info', 02:02:06 INFO - 'log_name': 'talos', 02:02:06 INFO - 'log_to_console': True, 02:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:06 INFO - 'opt_config_files': (), 02:02:06 INFO - 'pip_index': False, 02:02:06 INFO - 'sps_profile': False, 02:02:06 INFO - 'sps_profile_interval': 0, 02:02:06 INFO - 'suite': 'dromaeojs', 02:02:06 INFO - 'system_bits': '32', 02:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:06 INFO - 'title': 'talos-linux64-ix-016', 02:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:06 INFO - 'use_talos_json': True, 02:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:06 INFO - 'work_dir': 'build'} 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running clobber step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: clobber 02:02:06 INFO - rmtree: /builds/slave/test/build 02:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - ##### 02:02:07 INFO - ##### Finished clobber step (success) 02:02:07 INFO - ##### 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running read-buildbot-config step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: read_buildbot_config 02:02:07 INFO - Using buildbot properties: 02:02:07 INFO - { 02:02:07 INFO - "project": "", 02:02:07 INFO - "product": "firefox", 02:02:07 INFO - "script_repo_revision": "production", 02:02:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:02:07 INFO - "repository": "", 02:02:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:02:07 INFO - "buildid": "20160607233004", 02:02:07 INFO - "pgo_build": "True", 02:02:07 INFO - "basedir": "/builds/slave/test", 02:02:07 INFO - "buildnumber": 780, 02:02:07 INFO - "slavename": "talos-linux64-ix-016", 02:02:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:02:07 INFO - "platform": "ubuntu64_hw", 02:02:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:02:07 INFO - "branch": "fx-team", 02:02:07 INFO - "repo_path": "integration/fx-team", 02:02:07 INFO - "revision": "1401fcd673699f8d6e431ccb643ab46e166da2a9", 02:02:07 INFO - "stage_platform": "linux64-pgo", 02:02:07 INFO - "builduid": "91c1474d589245f196ca42ccac1a329f", 02:02:07 INFO - "slavebuilddir": "test" 02:02:07 INFO - } 02:02:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - ##### 02:02:07 INFO - ##### Finished read-buildbot-config step (success) 02:02:07 INFO - ##### 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running download-and-extract step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: download_and_extract 02:02:07 INFO - mkdir: /builds/slave/test/build/tests 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:07 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:02:09 INFO - Downloaded 1361 bytes. 02:02:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:09 INFO - Using the following test package requirements: 02:02:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'jsshell-linux-x86_64.zip'], 02:02:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:09 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:11 INFO - Downloaded 24446988 bytes. 02:02:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:12 INFO - Return code: 0 02:02:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:12 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:15 INFO - Downloaded 24446988 bytes. 02:02:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:17 INFO - Return code: 0 02:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:17 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:02:18 INFO - Downloaded 10833369 bytes. 02:02:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:02:18 INFO - Return code: 0 02:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:18 INFO - https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:02:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:02:25 INFO - Downloaded 59188184 bytes. 02:02:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:25 INFO - mkdir: /builds/slave/test/properties 02:02:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:25 INFO - Contents: 02:02:25 INFO - build_url:https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:26 INFO - Running post-action listener: _resource_record_post_action 02:02:26 INFO - Running post-action listener: set_extra_try_arguments 02:02:26 INFO - ##### 02:02:26 INFO - ##### Finished download-and-extract step (success) 02:02:26 INFO - ##### 02:02:26 INFO - ##### 02:02:26 INFO - ##### Running populate-webroot step. 02:02:26 INFO - ##### 02:02:26 INFO - Running pre-action listener: _resource_record_pre_action 02:02:26 INFO - Running main action method: populate_webroot 02:02:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:26 INFO - '--tppagecycles', 02:02:26 INFO - '7'], 02:02:26 INFO - 'tests': ['tsvgm']}}, 02:02:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['damp', 'tps']}, 02:02:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['damp', 'tps']}, 02:02:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['dromaeo_dom']}, 02:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['a11yr', 02:02:26 INFO - 'ts_paint', 02:02:26 INFO - 'tpaint', 02:02:26 INFO - 'sessionrestore', 02:02:26 INFO - 'sessionrestore_no_auto_restore', 02:02:26 INFO - 'tabpaint']}, 02:02:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tsvgx', 02:02:26 INFO - 'tsvgr_opacity', 02:02:26 INFO - 'tart', 02:02:26 INFO - 'tscrollx', 02:02:26 INFO - 'cart']}, 02:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:26 INFO - 'tsvgr_opacity', 02:02:26 INFO - 'tart', 02:02:26 INFO - 'tscrollx', 02:02:26 INFO - 'cart']}, 02:02:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s'], 02:02:26 INFO - 'tests': ['tp5o']}, 02:02:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'tests': ['tp5o']}, 02:02:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--disable-e10s', 02:02:26 INFO - '--xperf_path', 02:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:26 INFO - 'tests': ['tp5n']}, 02:02:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:26 INFO - 'talos_options': ['--xperf_path', 02:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:26 INFO - 'tests': ['tp5n']}}, 02:02:26 INFO - 'talos.zip': {'path': '', 02:02:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:26 INFO - Running post-action listener: _resource_record_post_action 02:02:26 INFO - ##### 02:02:26 INFO - ##### Finished populate-webroot step (success) 02:02:26 INFO - ##### 02:02:26 INFO - ##### 02:02:26 INFO - ##### Running create-virtualenv step. 02:02:26 INFO - ##### 02:02:26 INFO - Running pre-action listener: _resource_record_pre_action 02:02:26 INFO - Running main action method: create_virtualenv 02:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:02:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:26 INFO - Using real prefix '/usr' 02:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:29 INFO - Installing pip.................done. 02:02:29 INFO - Return code: 0 02:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:02:29 INFO - Using env: {'DISPLAY': ':0', 02:02:29 INFO - 'HOME': '/home/cltbld', 02:02:29 INFO - 'LANG': 'en_US.UTF-8', 02:02:29 INFO - 'LANGUAGE': 'en_US:en', 02:02:29 INFO - 'LOGNAME': 'cltbld', 02:02:29 INFO - 'MAIL': '/var/mail/cltbld', 02:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:29 INFO - 'MOZ_NO_REMOTE': '1', 02:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:29 INFO - 'NO_EM_RESTART': '1', 02:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:29 INFO - 'PWD': '/builds/slave/test', 02:02:29 INFO - 'SHELL': '/bin/bash', 02:02:29 INFO - 'SHLVL': '1', 02:02:29 INFO - 'TERM': 'linux', 02:02:29 INFO - 'TMOUT': '86400', 02:02:29 INFO - 'USER': 'cltbld', 02:02:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:29 INFO - '_': '/tools/buildbot/bin/python'} 02:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:02:29 INFO - Cleaning up... 02:02:29 INFO - Return code: 0 02:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:02:29 INFO - Using env: {'DISPLAY': ':0', 02:02:29 INFO - 'HOME': '/home/cltbld', 02:02:29 INFO - 'LANG': 'en_US.UTF-8', 02:02:29 INFO - 'LANGUAGE': 'en_US:en', 02:02:29 INFO - 'LOGNAME': 'cltbld', 02:02:29 INFO - 'MAIL': '/var/mail/cltbld', 02:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:29 INFO - 'MOZ_NO_REMOTE': '1', 02:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:29 INFO - 'NO_EM_RESTART': '1', 02:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:29 INFO - 'PWD': '/builds/slave/test', 02:02:29 INFO - 'SHELL': '/bin/bash', 02:02:29 INFO - 'SHLVL': '1', 02:02:29 INFO - 'TERM': 'linux', 02:02:29 INFO - 'TMOUT': '86400', 02:02:29 INFO - 'USER': 'cltbld', 02:02:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:29 INFO - '_': '/tools/buildbot/bin/python'} 02:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:29 INFO - Downloading/unpacking psutil>=3.1.1 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:31 INFO - Installing collected packages: psutil 02:02:31 INFO - Running setup.py install for psutil 02:02:31 INFO - building 'psutil._psutil_linux' extension 02:02:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:02:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:02:32 INFO - building 'psutil._psutil_posix' extension 02:02:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:02:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:32 INFO - Successfully installed psutil 02:02:32 INFO - Cleaning up... 02:02:32 INFO - Return code: 0 02:02:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:02:32 INFO - Using env: {'DISPLAY': ':0', 02:02:32 INFO - 'HOME': '/home/cltbld', 02:02:32 INFO - 'LANG': 'en_US.UTF-8', 02:02:32 INFO - 'LANGUAGE': 'en_US:en', 02:02:32 INFO - 'LOGNAME': 'cltbld', 02:02:32 INFO - 'MAIL': '/var/mail/cltbld', 02:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:32 INFO - 'MOZ_NO_REMOTE': '1', 02:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:32 INFO - 'NO_EM_RESTART': '1', 02:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:32 INFO - 'PWD': '/builds/slave/test', 02:02:32 INFO - 'SHELL': '/bin/bash', 02:02:32 INFO - 'SHLVL': '1', 02:02:32 INFO - 'TERM': 'linux', 02:02:32 INFO - 'TMOUT': '86400', 02:02:32 INFO - 'USER': 'cltbld', 02:02:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:32 INFO - '_': '/tools/buildbot/bin/python'} 02:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:34 INFO - Installing collected packages: mozsystemmonitor 02:02:34 INFO - Running setup.py install for mozsystemmonitor 02:02:34 INFO - Successfully installed mozsystemmonitor 02:02:34 INFO - Cleaning up... 02:02:34 INFO - Return code: 0 02:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:02:34 INFO - Using env: {'DISPLAY': ':0', 02:02:34 INFO - 'HOME': '/home/cltbld', 02:02:34 INFO - 'LANG': 'en_US.UTF-8', 02:02:34 INFO - 'LANGUAGE': 'en_US:en', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MAIL': '/var/mail/cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SHLVL': '1', 02:02:34 INFO - 'TERM': 'linux', 02:02:34 INFO - 'TMOUT': '86400', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - '_': '/tools/buildbot/bin/python'} 02:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:37 INFO - warning: no files found matching '*.txt' 02:02:37 INFO - no previously-included directories found matching 'build' 02:02:37 INFO - no previously-included directories found matching 'dist' 02:02:37 INFO - no previously-included directories found matching '.git*' 02:02:37 INFO - Installing collected packages: jsonschema, functools32 02:02:37 INFO - Running setup.py install for functools32 02:02:37 INFO - warning: no files found matching '*.txt' 02:02:37 INFO - no previously-included directories found matching 'build' 02:02:37 INFO - no previously-included directories found matching 'dist' 02:02:37 INFO - no previously-included directories found matching '.git*' 02:02:37 INFO - Successfully installed jsonschema functools32 02:02:37 INFO - Cleaning up... 02:02:37 INFO - Return code: 0 02:02:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:02:37 INFO - Using env: {'DISPLAY': ':0', 02:02:37 INFO - 'HOME': '/home/cltbld', 02:02:37 INFO - 'LANG': 'en_US.UTF-8', 02:02:37 INFO - 'LANGUAGE': 'en_US:en', 02:02:37 INFO - 'LOGNAME': 'cltbld', 02:02:37 INFO - 'MAIL': '/var/mail/cltbld', 02:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:37 INFO - 'MOZ_NO_REMOTE': '1', 02:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:37 INFO - 'NO_EM_RESTART': '1', 02:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:37 INFO - 'PWD': '/builds/slave/test', 02:02:37 INFO - 'SHELL': '/bin/bash', 02:02:37 INFO - 'SHLVL': '1', 02:02:37 INFO - 'TERM': 'linux', 02:02:37 INFO - 'TMOUT': '86400', 02:02:37 INFO - 'USER': 'cltbld', 02:02:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:37 INFO - '_': '/tools/buildbot/bin/python'} 02:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:40 INFO - Downloading docopt-0.6.1.tar.gz 02:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:40 INFO - Running setup.py install for blobuploader 02:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:40 INFO - Running setup.py install for requests 02:02:40 INFO - Running setup.py install for docopt 02:02:40 INFO - Successfully installed blobuploader requests docopt 02:02:40 INFO - Cleaning up... 02:02:40 INFO - Return code: 0 02:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:40 INFO - Using env: {'DISPLAY': ':0', 02:02:40 INFO - 'HOME': '/home/cltbld', 02:02:40 INFO - 'LANG': 'en_US.UTF-8', 02:02:40 INFO - 'LANGUAGE': 'en_US:en', 02:02:40 INFO - 'LOGNAME': 'cltbld', 02:02:40 INFO - 'MAIL': '/var/mail/cltbld', 02:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:40 INFO - 'MOZ_NO_REMOTE': '1', 02:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:40 INFO - 'NO_EM_RESTART': '1', 02:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:40 INFO - 'PWD': '/builds/slave/test', 02:02:40 INFO - 'SHELL': '/bin/bash', 02:02:40 INFO - 'SHLVL': '1', 02:02:40 INFO - 'TERM': 'linux', 02:02:40 INFO - 'TMOUT': '86400', 02:02:40 INFO - 'USER': 'cltbld', 02:02:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:40 INFO - '_': '/tools/buildbot/bin/python'} 02:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:41 INFO - Running setup.py (path:/tmp/pip-7hVKpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:41 INFO - Running setup.py (path:/tmp/pip-zIkAA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:41 INFO - Running setup.py (path:/tmp/pip-V6I5w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:41 INFO - Running setup.py (path:/tmp/pip-7XE9Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:41 INFO - Running setup.py (path:/tmp/pip-Z5HCey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:41 INFO - Running setup.py (path:/tmp/pip-7TqNwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:41 INFO - Running setup.py (path:/tmp/pip-EXkCv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:41 INFO - Running setup.py (path:/tmp/pip-zv18Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:41 INFO - Running setup.py (path:/tmp/pip-3zAQKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:41 INFO - Running setup.py (path:/tmp/pip-Cd6Ouh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:41 INFO - Running setup.py (path:/tmp/pip-u4SCid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:41 INFO - Running setup.py (path:/tmp/pip-1HrQMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:42 INFO - Running setup.py (path:/tmp/pip-oQCuBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:42 INFO - Running setup.py (path:/tmp/pip-sGzi0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:42 INFO - Running setup.py (path:/tmp/pip-bJgH5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:42 INFO - Running setup.py (path:/tmp/pip-5RCRSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:42 INFO - Running setup.py (path:/tmp/pip-ibEf2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:42 INFO - Running setup.py install for manifestparser 02:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Running setup.py install for mozcrash 02:02:42 INFO - Running setup.py install for mozdebug 02:02:42 INFO - Running setup.py install for mozdevice 02:02:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Running setup.py install for mozfile 02:02:42 INFO - Running setup.py install for mozhttpd 02:02:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozinfo 02:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozInstall 02:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozleak 02:02:43 INFO - Running setup.py install for mozlog 02:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for moznetwork 02:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozprocess 02:02:43 INFO - Running setup.py install for mozprofile 02:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozrunner 02:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:43 INFO - Running setup.py install for mozscreenshot 02:02:43 INFO - Running setup.py install for moztest 02:02:44 INFO - Running setup.py install for mozversion 02:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:44 INFO - Cleaning up... 02:02:44 INFO - Return code: 0 02:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:44 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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:44 INFO - Using env: {'DISPLAY': ':0', 02:02:44 INFO - 'HOME': '/home/cltbld', 02:02:44 INFO - 'LANG': 'en_US.UTF-8', 02:02:44 INFO - 'LANGUAGE': 'en_US:en', 02:02:44 INFO - 'LOGNAME': 'cltbld', 02:02:44 INFO - 'MAIL': '/var/mail/cltbld', 02:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:44 INFO - 'MOZ_NO_REMOTE': '1', 02:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:44 INFO - 'NO_EM_RESTART': '1', 02:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:44 INFO - 'PWD': '/builds/slave/test', 02:02:44 INFO - 'SHELL': '/bin/bash', 02:02:44 INFO - 'SHLVL': '1', 02:02:44 INFO - 'TERM': 'linux', 02:02:44 INFO - 'TMOUT': '86400', 02:02:44 INFO - 'USER': 'cltbld', 02:02:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:44 INFO - '_': '/tools/buildbot/bin/python'} 02:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:44 INFO - Running setup.py (path:/tmp/pip-rF_vib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:44 INFO - Running setup.py (path:/tmp/pip-no5F2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:44 INFO - Running setup.py (path:/tmp/pip-qalrbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:44 INFO - Running setup.py (path:/tmp/pip-jkBXcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:44 INFO - Running setup.py (path:/tmp/pip-8U8qCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:44 INFO - Running setup.py (path:/tmp/pip-m4BiWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 INFO - Running setup.py (path:/tmp/pip-UOrsND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 INFO - Running setup.py (path:/tmp/pip-C12h4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:44 INFO - Running setup.py (path:/tmp/pip-6ka1gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:45 INFO - Running setup.py (path:/tmp/pip-yQzaX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:45 INFO - Running setup.py (path:/tmp/pip-oczghM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:45 INFO - Running setup.py (path:/tmp/pip-Fv9d81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:45 INFO - Running setup.py (path:/tmp/pip-GzpkES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:45 INFO - Running setup.py (path:/tmp/pip-JSjCNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:45 INFO - Running setup.py (path:/tmp/pip-wW8fRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:45 INFO - Running setup.py (path:/tmp/pip-uYFTko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:45 INFO - Running setup.py (path:/tmp/pip-ZFn3Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:47 INFO - Downloading blessings-1.6.tar.gz 02:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:47 INFO - Installing collected packages: blessings 02:02:47 INFO - Running setup.py install for blessings 02:02:47 INFO - Successfully installed blessings 02:02:47 INFO - Cleaning up... 02:02:47 INFO - Return code: 0 02:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:47 INFO - Reading from file tmpfile_stdout 02:02:47 INFO - Current package versions: 02:02:47 INFO - argparse == 1.2.1 02:02:47 INFO - blessings == 1.6 02:02:47 INFO - blobuploader == 1.2.4 02:02:47 INFO - docopt == 0.6.1 02:02:47 INFO - functools32 == 3.2.3-2 02:02:47 INFO - jsonschema == 2.5.1 02:02:47 INFO - manifestparser == 1.1 02:02:47 INFO - mozInstall == 1.12 02:02:47 INFO - mozcrash == 0.17 02:02:47 INFO - mozdebug == 0.1 02:02:47 INFO - mozdevice == 0.48 02:02:47 INFO - mozfile == 1.2 02:02:47 INFO - mozhttpd == 0.7 02:02:47 INFO - mozinfo == 0.9 02:02:47 INFO - mozleak == 0.1 02:02:47 INFO - mozlog == 3.2 02:02:47 INFO - moznetwork == 0.27 02:02:47 INFO - mozprocess == 0.22 02:02:47 INFO - mozprofile == 0.28 02:02:47 INFO - mozrunner == 6.11 02:02:47 INFO - mozscreenshot == 0.1 02:02:47 INFO - mozsystemmonitor == 0.3 02:02:47 INFO - moztest == 0.7 02:02:47 INFO - mozversion == 1.4 02:02:47 INFO - psutil == 3.1.1 02:02:47 INFO - requests == 1.2.3 02:02:47 INFO - wsgiref == 0.1.2 02:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:47 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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:48 INFO - Using env: {'DISPLAY': ':0', 02:02:48 INFO - 'HOME': '/home/cltbld', 02:02:48 INFO - 'LANG': 'en_US.UTF-8', 02:02:48 INFO - 'LANGUAGE': 'en_US:en', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MAIL': '/var/mail/cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SHLVL': '1', 02:02:48 INFO - 'TERM': 'linux', 02:02:48 INFO - 'TMOUT': '86400', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:48 INFO - Cleaning up... 02:02:48 INFO - Return code: 0 02:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:02:48 INFO - Using env: {'DISPLAY': ':0', 02:02:48 INFO - 'HOME': '/home/cltbld', 02:02:48 INFO - 'LANG': 'en_US.UTF-8', 02:02:48 INFO - 'LANGUAGE': 'en_US:en', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MAIL': '/var/mail/cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SHLVL': '1', 02:02:48 INFO - 'TERM': 'linux', 02:02:48 INFO - 'TMOUT': '86400', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:48 INFO - Cleaning up... 02:02:48 INFO - Return code: 0 02:02:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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 0x7fd96ff65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, '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': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:02:48 INFO - Using env: {'DISPLAY': ':0', 02:02:48 INFO - 'HOME': '/home/cltbld', 02:02:48 INFO - 'LANG': 'en_US.UTF-8', 02:02:48 INFO - 'LANGUAGE': 'en_US:en', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MAIL': '/var/mail/cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SHLVL': '1', 02:02:48 INFO - 'TERM': 'linux', 02:02:48 INFO - 'TMOUT': '86400', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - '_': '/tools/buildbot/bin/python'} 02:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:48 INFO - Downloading/unpacking flake8 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02: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:02: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:02: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:02: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:02: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:02: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:02:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02: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:02: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:02: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:02: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:02: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:02: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:02:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:51 INFO - no previously-included directories found matching 'docs/_build' 02:02:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:51 INFO - Running setup.py install for pep8 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:51 INFO - no previously-included directories found matching 'docs/_build' 02:02:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:51 INFO - Cleaning up... 02:02:51 INFO - Return code: 0 02:02:51 INFO - Running post-action listener: _resource_record_post_action 02:02:51 INFO - Running post-action listener: _start_resource_monitoring 02:02:51 INFO - Starting resource monitoring. 02:02:51 INFO - ##### 02:02:51 INFO - ##### Finished create-virtualenv step (success) 02:02:51 INFO - ##### 02:02:51 INFO - ##### 02:02:51 INFO - ##### Running install step. 02:02:51 INFO - ##### 02:02:51 INFO - Running pre-action listener: _resource_record_pre_action 02:02:51 INFO - Running main action method: install 02:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:51 INFO - Reading from file tmpfile_stdout 02:02:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:52 INFO - Reading from file tmpfile_stdout 02:02:52 INFO - Output received: 02:02:52 INFO - Usage: mozinstall [options] installer 02:02:52 INFO - Options: 02:02:52 INFO - -h, --help show this help message and exit 02:02:52 INFO - -d DEST, --destination=DEST 02:02:52 INFO - Directory to install application into. [default: 02:02:52 INFO - "/builds/slave/test"] 02:02:52 INFO - --app=APP Application being installed. [default: firefox] 02:02:52 INFO - mkdir: /builds/slave/test/build/application 02:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:03:08 INFO - Reading from file tmpfile_stdout 02:03:08 INFO - Output received: 02:03:08 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:08 INFO - Running post-action listener: _resource_record_post_action 02:03:08 INFO - ##### 02:03:08 INFO - ##### Finished install step (success) 02:03:08 INFO - ##### 02:03:08 INFO - ##### 02:03:08 INFO - ##### Running run-tests step. 02:03:08 INFO - ##### 02:03:08 INFO - Running pre-action listener: _resource_record_pre_action 02:03:08 INFO - Running main action method: run_tests 02:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:08 INFO - Python 2.7.3 02:03:08 INFO - Return code: 0 02:03:08 INFO - grabbing minidump binary from tooltool 02:03: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:03:08 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 0x22de1c0>, '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 0x22df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22df550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:03:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:03:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:03:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:08 INFO - Return code: 0 02:03:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:03:09 INFO - Return code: 0 02:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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:03:09 INFO - Using env: {'DISPLAY': ':0', 02:03:09 INFO - 'HOME': '/home/cltbld', 02:03:09 INFO - 'LANG': 'en_US.UTF-8', 02:03:09 INFO - 'LANGUAGE': 'en_US:en', 02:03:09 INFO - 'LOGNAME': 'cltbld', 02:03:09 INFO - 'MAIL': '/var/mail/cltbld', 02:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:09 INFO - 'MOZ_NO_REMOTE': '1', 02:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:09 INFO - 'NO_EM_RESTART': '1', 02:03:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:09 INFO - 'PWD': '/builds/slave/test', 02:03:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:09 INFO - 'SHELL': '/bin/bash', 02:03:09 INFO - 'SHLVL': '1', 02:03:09 INFO - 'TERM': 'linux', 02:03:09 INFO - 'TMOUT': '86400', 02:03:09 INFO - 'USER': 'cltbld', 02:03:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932', 02:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:09 INFO - '_': '/tools/buildbot/bin/python'} 02:03:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:03:09 INFO - mozversion application_buildid: 20160607233004 02:03:09 INFO - mozversion application_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 02:03:09 INFO - mozversion application_display_name: Nightly 02:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:09 INFO - mozversion application_name: Firefox 02:03:09 INFO - mozversion application_remotingname: firefox 02:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:03:09 INFO - mozversion application_vendor: Mozilla 02:03:09 INFO - mozversion application_version: 50.0a1 02:03:09 INFO - mozversion platform_buildid: 20160607233004 02:03:09 INFO - mozversion platform_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 02:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:03:09 INFO - mozversion platform_version: 50.0a1 02:03:09 INFO - using testdate: 1465376589 02:03:09 INFO - actual date: 1465376589 02:03:09 INFO - starting webserver on 'localhost:44415' 02:03:09 INFO - SUITE-START | Running 2 tests 02:03:09 INFO - TEST-START | dromaeo_css 02:03:09 INFO - operating with platform_type : linux_ 02:03:09 INFO - Initialising browser for dromaeo_css test... 02:03:10 INFO - TEST-INFO | started process 29450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1mtHIC/profile http://localhost:44415/getInfo.html) 02:03:14 INFO - PROCESS | 29450 | __metrics Screen width/height:1600/1200 02:03:14 INFO - PROCESS | 29450 | colorDepth:24 02:03:14 INFO - PROCESS | 29450 | Browser inner width/height: 1024/697 02:03:14 INFO - PROCESS | 29450 | __metrics 02:03:15 ERROR - PROCESS | 29450 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:03:15 INFO - PROCESS | 29450 | console.error: PushService: 02:03:15 INFO - PROCESS | 29450 | stateChangeProcessEnqueue: Error transitioning state 02:03:15 INFO - PROCESS | 29450 | UnknownError 02:03:15 INFO - TEST-INFO | 29450: exit 0 02:03:15 INFO - Browser initialized. 02:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:15 INFO - TEST-INFO | started process 29532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1mtHIC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:27 INFO - PROCESS | 29532 | RSS: Main: 155664384 02:03:27 INFO - PROCESS | 29532 | 02:04:18 INFO - PROCESS | 29532 | 1465376658949 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:06:26 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44415/tests/dromaeo/cssquery-ext.html) 02:06:27 INFO - PROCESS | 29532 | RSS: Main: 245194752 02:06:27 INFO - PROCESS | 29532 | 02:09:29 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-ext.html (next: http://localhost:44415/tests/dromaeo/cssquery-jquery.html) 02:09:30 INFO - PROCESS | 29532 | RSS: Main: 245665792 02:09:30 INFO - PROCESS | 29532 | 02:12:32 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44415/tests/dromaeo/cssquery-mootools.html) 02:12:33 INFO - PROCESS | 29532 | RSS: Main: 237490176 02:12:33 INFO - PROCESS | 29532 | 02:15:35 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44415/tests/dromaeo/cssquery-prototype.html) 02:15:35 INFO - PROCESS | 29532 | RSS: Main: 236843008 02:15:35 INFO - PROCESS | 29532 | 02:18:38 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44415/tests/dromaeo/cssquery-yui.html) 02:18:39 INFO - PROCESS | 29532 | RSS: Main: 220430336 02:18:39 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | Cycle 1(1): loaded http://localhost:44415/tests/dromaeo/cssquery-yui.html (next: http://localhost:44415/tests/dromaeo/cssquery-dojo.html) 02:21:41 INFO - PROCESS | 29532 | RSS: Main: 274034688 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | __start_tp_report 02:21:41 INFO - PROCESS | 29532 | _x_x_mozilla_page_load 02:21:41 INFO - PROCESS | 29532 | _x_x_mozilla_page_load_details 02:21:41 INFO - PROCESS | 29532 | |i|pagename|runs| 02:21:41 INFO - PROCESS | 29532 | |0;dojo.html;3132.639746429161;3139.9638119420592;3157.952630710539;3180.268538236204;3196.8401579921015;5066.84799456016;5150.8454746357575;5153.30430391897;5283.867903302419;5302.761375738087;5171.818986335479;5222.3472065991755;5224.8693782655455;5256.894862102756;5274;4555.271156614951;4643.210654188796;4683.8360657377;4726.621870250372;4898.510148985109;4838.733869637169;4901.460839307673;4908.484609116027;4912.140375434285;4935.851924442272;4630.398048253723;4678.672492925513;4679.15775160471;4787.425508938914;4883.658143929926;4633.953660463386;4653;4653.86038418848;4658.557437043475;4747.0505898820375;4675;4692.8122875084955;4698.953010469886;4715.834945776915;4760.190767569521;5067.721275329855;5189.55888749453;5211.296474975868;5278.340207474066;5286.444923283038;5700.914486282709;5747.770089196469;5764.33710123337;5769.653820770767;5770.134479828017;5652.434756524356;5655.038643430586;5667.1782591524;5667.291588551431;5675.744591493392;5124.718140502271;5182.481751824825;5242.528172464458;5258.211268309746;5329.333833270841;5745.6552606843725;5802.274715660543;5808.651480911074;5809;5811.593188476766;5326.201069839555;5579.69311687861;5590.049691552445;5591.944080559224;5594.552435805126;5546.55627549795;5620;5629.634073785191;5663.32040155184;5668.376478587352;5623.831285061455;5632.408597097327;5632.633878797865;5632.662040277596;5639.154126881001;5375.1131063374105;5527.944720552823;5642.7178641067785;5646.632968857011;5652.689102099342;4308.073764140725;4332.1119170569955;4337.761423121696;4370.21336159488;4373.803178856959;3877.3796192609047;3895.5909629488497;3896.103896103912;3903.1803321302846;3931.095847954929;5142.1772516397195;5147;5283.841484755463;5347.1979203119845;5388.326459192601;5696.772129114789;5727.856803579861;5757.309122905278;5758.510526605285;5805.245318108703;5320.201969704498;5320.893582128336;5323.254744335796;5326.520613144836;5381.300430943952;4691.577758001797;4743.430788305425;4779.211430114062;4940.456549779521;4968;5756.510696590837;5763.827085187451;5764.74058667361;5765.279340082489;5801.158831969341;5589.580781441408;5599.076152434803;5602.355729091207;5602.831915042555;5603.411641777555;5588.469095435927;5708.514776244066;5739.799107031234;5745.1956726059225;5747.770089196385;5569.582281328835;5577.135543990688;5579.832605021694;5592.3009623797025;5593.02122128634;5658.151277308437;5667.121596152603;5672.659640421588;5673;5673.687947162781;5300.681959082467;5375.892482150257;5418.756155972912;5461.317335333083;5476.507114359727;5456.645318054314;5457.754401052041;5458.563314934716;5477.287952566141;5491.917621235764;5178.404483484297;5347.866303342447;5377.462253774591;5397.190421436816;5439.809606663748;5407.270018547446;5460.099083651312;5471.616986811045;5534.418886016911;5558.888822223452;5388.946110538845;5396.541293989898;5399.892002160013;5401.648892821954;5446.1558458439 02:21:41 INFO - PROCESS | 29532 | |1;ext.html;598.7096258314716;624.8500359913621;630.3066626710616;646.2987658390646;646.9967650161749;33623.66376336239;42579.361309580345;43431.78284108583;43528.56471435285;43538.782306088506;45621.31568026474;46008.30987535181;46082;46130.308045379265;46213;7970.840583188333;8736.563171841415;8925.866112008325;8926.152015558511;8926.509042002688;10078.143357814595;10560.788784224349;10563.366198028143;10945.507452164631;10951.726206844813;10434.269601127924;10488.632897848576;10494.947525262402;10498.580056797718;10502.894971050306;8114.229148230908;10632.734181645443;10670.78658426831;10782.67651970442;10916.508757105948;10508.894911050867;10575.73560660982;10579.259451838374;10627.628033018884;10634;42439.1512169758;42815.14369712588;42859.35710964338;42881.57118428838;42890.356644650354;3454.464557993515;3749.3063783200196;4171.895702607429;4174.3112386456505;4184.184084103601;32577.837110814533;32928.83535582331;33303.00090997274;33335.16662083443;33543.49684754731;4153.356229784388;4300.569943005675;4303.4190384298345;4347.108842687273;4440.711353761995;343681;344876;344883;346964;347999;60755.69622151861;60986;61375;61390.693046534485;61403.385966139766;65995.34004659989;66169;66322.33677663258;66344.69725376081;66357.33642663511;16616;17056;17069.40257090996;17077.658446830992;17082.316707331567;12936.935315323362;13152.868471315165;13154.671133221555;13159.276239806903;13161.276129812952;16753.91623041877;18348.724769128472;18482;18495.815041849677;18499.630007399777;5927.347991720907;6880.243173251039;6884.351293814287;6937.7571784987285;6962.825929351706;1014.1734486393566;1037.2687255484866;1051.279873286801;1135.8353038809325;1208.7219939413808;32116.897415841566;33197.50203746946;33248.501272480935;33267.833660831544;33525.49711754326;1136.960206392789;1211.745533437988;1229.827824104626;1237.622525129826;1257.2142410993129;17097.743533847002;17274.827251727573;17424.12879356027;17474.47576572705;17490.387836425663;512159;512955;517190;517748;517916;59276;59341.40658593445;59362.40637593655;59498.70250648719;59504.70247648734;1262.9242245465302;1348.6223857319967;1408.2114016150988;1433.4624515806572;1437.1664434627892;33244.667553325125;34165.82917085498;34298.314033718685;34369.14077148091;34448.79429219965;50256.74871625618;51173.744131279105;51210.74394628003;51215;51316.486835131174;409053;419315;419407;419893;420046;35907.64092359043;37379.43930840985;40423.191536168524;42297;42764.572354277305;48393;48537.5146248533;48538.75730621324;49232.75383623059;49785.75107124586;40255;41164;41322;41802.163956720084;42289.365659514515;40865;41050.79474602608;41108;41290.38064428976;41504;37528.43707344447;37607.62392376041;45017.32474012827;46039;46162.538374615826;40017.51052123704;44222.336664949406;44863.55136448724;45402.31896521489;45575;34305.31389372249;35336.82331588326;35420;35453.46819797654;35542.822285888404 02:21:41 INFO - PROCESS | 29532 | |2;jquery.html;379.92591444668284;390.2877249020538;393.2430072111186;399.1760848298342;408.62814838496973;14236.145831250133;16101.355945762185;17920;19247.518812029706;19422.223111075575;17275.654486910254;18104.456866294033;18261.36085237017;18742.156602952866;18828.435146945612;5240.9213861792;5371.650842695231;5390.407055223922;5417.59368047396;5419.674819510842;3801.771893686374;5310.283111779918;5354.705491197982;5638.984982703112;5942.316633587128;5971.790987315445;6000.33996260411;6017.819465416044;6031.24609423822;6034.818955431322;5536.833894983157;5860.179574859523;5885.646861188342;5962.314333851619;5991.730372133243;5382.219578161144;5582.8325150245555;5585.245991791137;5600.4959553640365;5679.176519404705;14060.578182654537;14266.429342826275;14304.141751494944;14350.067245629105;14792.482263120739;2359.1153317505937;2408.747081556429;2542.9618555721677;2645.999999999981;2764.2121995231464;9836.3606365586;9873.308868379216;9896.505174741234;10223.131033862132;10402;1858.869879108463;1869.8223668751448;1884.3687364732832;1897.2600685732575;1909.484439201408;62479.37520624781;64169;68812.3118768811;80980;82080;10526;10880.891191087987;11105.444727763579;11121.27711698737;11225.550977960791;15637.530874073796;15714.842851571566;15747.133907634961;15750.921245393929;15755.684886302439;8013.559254240956;8184.754457366289;8224.958875205586;8302.584870756438;8372;7838.490498117604;7842.333401660922;7842.45102842807;8037.919620803834;8083.959580202061;4821.4696383397795;4826.58973987208;4838.516148385203;4885.071836351082;4892.755362231874;1948.279136719423;1967.6851703727334;1975.8518111141723;1994.3717728915635;2061.2682497713095;860.2988564320059;989.7575094101848;997.4464172384396;1033.7105610429091;1082.9404382758867;18888.52778680544;19158;19472.90263548673;19599.706004409945;19748.50628734293;987.1855719031828;1010.2170817616407;1034.1881622925966;1068.9844647584825;1107.6510899066768;8914;10652;10829.783404331869;11025.669229923114;11086.667399978014;464710;469569;470377;472229;477249;90735;92334.53832730927;92517.53741231251;94748.0525194753;95663;917.1653795046609;994.8756405449319;1041.9791604167874;1050.3120456101267;1050.495762034228;16199.43301984425;17411.47765567035;17471.475855724348;17572.2092505835;18259.54351141232;40678.79660601678;41123.7943810291;41190;42405.363919540614;42997.140057198056;54932.450675492735;58313.4168658308;58363.12455313089;58591;59531.404685952584;8507.276881465144;8795.428297160664;8836.513991730259;8958.148975847284;9090.045545217657;9905.554250058909;13299.66750831237;13420.46318147263;13647.181169129884;13718.45126194941;10932.289401188897;11289.491972861077;11525.654230373102;12050.578229761917;12060.216085954386;11566.479508421973;11645.41772911368;11705.297682139098;11904.107191960811;12149.574764883188;11614.535418583162;11748.530058797895;11941.104417168573;12048;12062.396880156133;7118.8932166018585;7385.224551422239;7510.812229694301;7586.582737949466;9032.63869445215;9608.327417080738;10686.83969740439;10834.34993900337;10841.403722795321;11091.833622495507 02:21:41 INFO - PROCESS | 29532 | |3;mootools.html;1367.7811550151978;1478.2165452310273;1478.238707065861;1634.5504986128813;1796.9281228750842;8229.794255143617;8701.477911325324;8716.30269578433;8918.063603321654;8948.015718270985;8636.222739953419;8821.691240806573;8827.691030813923;8839.513826739527;8848.247898928583;2078.366098340006;2144.7962443567912;2147.2699282244034;2372.0393240737485;2401.3156250468533;2300.5053913408615;2400.6519054737055;2406.3262286559793;2412.8431651942656;2415.311636183688;2311.3528212100637;2323.61660326046;2340.4616938104245;2342;2359.9292021239303;2023.7976202379791;2219.411855858199;2360.2565191964477;2399.748026457214;2400.519896020794;2376.2277259890607;2402.3513651314047;2404.495056038234;2409.9518009639883;2410.240774156135;8779.385443018991;8842.115788421172;8846.557672116369;8847.557622118933;8852.601632926533;5158.974205128988;5283.207518872162;5292.100342941709;5300.09898317287;5303.15149576066;3154.3060526684094;3242.205659613386;3429.2112814052907;3430.2281986552825;3465.2549701813978;1111.3665210829831;1112.6272698645964;1154.3824054131082;1176.7940610393148;1178.1870509348607;12223.266604003788;12285.93857030718;12313.692157696129;12323.383830808514;12362.505499779998;4687.95312046882;4706.294055891643;4791.065742180242;4819.2530157825595;4822.807087716452;10260.384376937407;10415.791684166426;10423.42671153094;10497.685069447929;10527.631532896465;5173.896522069537;5201.609879259071;5209.609279303992;5214.113600687892;5214.895702085937;4323.654107671378;4735.715857048588;4902.28916807061;4965.9751701241985;5035.924461133086;4079.1637714268504;4107.9178416432105;4159.7920103994675;4193.580641935782;4219.451471308772;1239.9070069744805;1250.7435975624976;1253.6803115205746;1260.6659235302652;1282.9550965716155;979.456401697065;980.9215262778961;986.225812736998;992.3450522655013;1005.597760895633;5628.85927851807;5719.542436605062;5784.82645520635;5879.823605291848;5998.310194327621;959.1990687775645;971.1114330387758;981.8625392445064;997.546116516983;1030.444029515422;3934.3705007199283;3967.563568007517;4017.738846974937;4058.5332686741403;4063.329550624173;11266.718332041764;11517.76964460706;11589.478473468715;11630.88369116315;11713;10961.397123158304;11075.390853502973;11090.057345125593;11090.445477726082;11103.44482775858;8165.550894700848;8219.794505137419;8290.4611200273;8335.249827515552;8361.247487726134;5859.648421094748;5900.380460051804;5900.409959004237;5971.0744834550715;5977.3126090500145;9992;10428.687139385831;10443.477826108816;10474.738131546468;10475.109615682448;10061.748456288651;10455.320404174008;10621.734456638645;10645.361278323326;10647.520861561403;7618.276263754934;7879;8007.879881801661;8054.83890322202;8323.542205178774;8185.058718247477;8256.917430825855;8376.455530390505;8460.238578527962;8469.491830490191;7271.454640901848;7524.2851929066655;7663.616819158909;7687.423443241667;7825.843483130192;7536.660850261642;7633.6564854580565;7643.503172293783;7781.455298129076;7782.338501227459;6834.077399550997;6943.375096241362;6958;6962.930370696228;6968;4751.762411879461;4765.404324459442;4844.249141383091;4889.804407823647;5054.393472783289;4943.703377797344;4985.750712464434;5052.065367906949;5090.872728181825;5093.4651861554 02:21:41 INFO - PROCESS | 29532 | |4;prototype.html;333.4647890136331;337.4870197300104;343.33221883436715;344.4316877152699;345.8841288168462;5270.156774916009;5355.6251062425645;5379.408265090842;5384.057789886774;5408.971635636636;5248.317718696574;5276.973615131928;5330.946690533094;5333.573314134869;5340.839774806752;4011.117554138085;4014.618611231943;4131.442255295527;4135.937960930589;4155.896102597429;4125.958740412588;4133.627973482386;4139.710220284582;4150.937735933963;4153.293940030187;3859.4176387681055;4095.488063992001;4104.22964498962;4130.607592278744;4149.315362965107;4018.3369743992207;4097.323941549641;4099.405586190015;4109.137081212949;4132.29750942339;3633.745637805355;3651.5253017107607;3674.926501469982;3676.117731744389;3682.1346983458866;5076.593872490192;5101.4133374662015;5138.306328645623;5138.640295179339;5145.562627176694;4599.103174880899;4745.976270118627;4755.595774359183;4773.711098003554;4776.11641846256;5452.727363631802;5465.9180112298345;5486.231927530149;5516.152089050173;5521.199426083195;4059.5737447567876;4079.4900637420324;4094.488188976378;4100.384942258685;4102.876913692594;5602.0196465618765;5723.195634139283;5727.11229759388;5733.483986441241;5740.54075673945;4091.3249313863475;4122.629488044387;4129.938050929239;4147.336426171798;4163.065039147394;4211.810468528924;4214.25108579942;4216.852410165629;4219.240536703362;4244.596763307481;4570.020192421908;4715.740634265148;4722.905541889143;4728.59806916416;4739.691920025188;5514.862128446821;5519.834404967857;5550.639208451437;5570.41510641385;5594.440555944454;1419.985800142006;1424.223798030076;1432.842387337392;1434.3115304653616;1435.8584924984661;954.3510412919143;954.9066319064771;955.8338826631499;973.8003709239589;999.6850991937516;5271.710055946883;5328.333958255218;5345.492178243061;5350;5351.357837059578;5657.915131273035;5661.660300381908;5664.960614178893;5682.545396368363;5687;5126.436092029874;5215;5293.867653308698;5303.15149576066;5325.733713314319;2939.7354238118673;2970.376220993572;2989.342344684166;3019.8641061152302;3023.969760302413;5765.84683063389;5788.321386797866;5793.94206057934;5801.187833703285;5804.013317735995;5499.157782143026;5720.197103419295;5734.913976290359;5736.942630573724;5739.8565035874435;5738.225339579187;5738.340090889517;5770.422957704196;5797.420257974253;5812.389699081536;5392.325959255093;5622.522085622768;5628.577856660849;5630.296212973379;5668.26312579362;5521.199426083276;5551.611387203018;5564.443555644403;5580.972095139498;5600.4959553640365;5747.540196784331;5790.9420905792085;5794.333651630117;5803.303603567599;5806.332271788799;4030.91938161241;4118.402831589343;4140.937885931653;4151.97924010378;4168.353905144708;5640.71796410186;5682.261306030189;5685.800996965087;5697.800576979786;5720.513756330592;5320.17537281722;5320.52115309624;5550.47270509301;5588.748506317307;5589.105743081088;5540.695261760642;5548.278723765885;5558;5562.527185189304;5576.470235327637;5204.895902082013;5463.617546771688;5472.589555783412;5477.370102438271;5477.589180811376;5579.2746942897165;5583.776648934159;5613.158026296088;5626.143372686922;5642.830715078554;5447.891042179055;5464.890702186013;5474.397816240131;5487.368952570506;5504.862378440571 02:21:41 INFO - PROCESS | 29532 | |5;yui.html;693.2686016252854;697.5431092634323;729.9343059124684;788.2275370137266;793.4326956226299;15597.298121584528;15808.20958952052;16028.118453485054;16042.117683527402;16069.116198609086;14916.7016659667;15033.398664053424;15242.771358429605;15975.281112349943;16045.83954160458;821.4250024982506;822.0341099208437;828.0849661124461;828.204923273658;829.1956801902176;685.0477835808206;797.4736673795296;827.0323721246126;830.7715378270993;834.3742193354984;843.4981186194235;844.5312851367488;846.3060290561742;849.3332733803965;849.5539841583156;710.7725527831096;854.3549620036863;855.2772906893696;859.4027151129967;860.1957170046027;601.2934801608093;624.4816802054283;624.8531595075153;627.0343670747044;629.128656810321;15418.691626167414;15420.151891645955;15446.0732356059;15454.072755634697;15541;13752;14336.92831535846;14446.638834029129;14485.78271325931;14519.491817786433;12536.247825130431;12755.489780408772;12792.232466052066;12838.293893835835;12994.935025324907;3798.2213646202463;3841.4045822897215;3901;3977.085270387798;4015.257177422186;76729.61635191845;77785;77943;78317;80592.19407805905;11038.17213708975;11173.72065698364;11273.436328183558;11567.305961642329;12021.398930053463;20041.599168016557;20046.599068018557;20059.699104513445;20448;22696;8492.74521764348;8902.955485222532;8931.330150238759;8958.86561701575;8964.820703585892;4699.812007519729;4726.456457507362;4781.928271075936;4885.2427873679635;4896.534829191221;3655.250673611903;3804.0680033391995;3816.809159542012;3823.808809559511;3830.7318487705593;614.6803662095774;616.8026231605933;630.9716062777186;649.6978904809287;654.045094162528;701.1025886864821;718.6370882704201;722.5772922840092;731.5574077682925;756.34198247525;10360.740981475523;10534.789304213873;10607.098396636373;10608.840867386996;10618.840717389245;603.8339456649456;695.942167904792;704.7322017633267;716.7240612364277;736.8563130189561;4689.296605509201;4703.244132157314;4810.7835147418455;4889;4964.15609346412;71025.64487177531;71651;104179.47910260552;121512.39243803725;129365.35317323353;103741.48129259306;108952;109591;110475.44762276138;110523;87725.56137219274;92840.53579732194;93990.53004734933;95626.52186739161;96515.99999999859;9144.131307525775;9212.3090768194;9398.95300523493;9424.670136545188;9467.810643786948;54570.45429545654;54576.18135727888;55571.16643250274;56064.15903761365;58725.825483490946;78876;81018.5949070251;81129.59435202787;83287.5835620818;84454.57772711097;12515.45808066505;12636;12753.48986040548;12924.870751292367;12956.611301660965;12564.497420103093;12593.496260149492;12789.296588687712;12797;13290.933545332211;12162.452689628812;12355.796758694443;12504.374781261082;12592.622221333375;12940.417681204557;12318.445669944695;12430.502779888704;13075.476980921037;13148.276844773629;13204.973767260331;12906.354682266037;13002.869971300544;13039.934800326317;13086.269259207358;13437.664058398619;9609.56756945953;9655.951720241354;10090.404203919888;10186.745331366776;10360.689179324632;10488.580456781643;10951.100171700153;11052.225622651902;11294.265872718248;11328.376939268419 02:21:41 INFO - PROCESS | 29532 | __end_tp_report 02:21:41 INFO - PROCESS | 29532 | __start_cc_report 02:21:41 INFO - PROCESS | 29532 | _x_x_mozilla_cycle_collect,815 02:21:41 INFO - PROCESS | 29532 | __end_cc_report 02:21:41 INFO - PROCESS | 29532 | __startTimestamp1465377701936__endTimestamp 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | ------- Summary: start ------- 02:21:41 INFO - PROCESS | 29532 | Number of tests: 6 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#0] dojo.html Cycles:165 Average:5216.93 Median:5388.95 stddev:581.42 (10.8%) stddev-sans-first:559.74 02:21:41 INFO - PROCESS | 29532 | Values: 3132.6 3140.0 3158.0 3180.3 3196.8 5066.8 5150.8 5153.3 5283.9 5302.8 5171.8 5222.3 5224.9 5256.9 5274.0 4555.3 4643.2 4683.8 4726.6 4898.5 4838.7 4901.5 4908.5 4912.1 4935.9 4630.4 4678.7 4679.2 4787.4 4883.7 4634.0 4653.0 4653.9 4658.6 4747.1 4675.0 4692.8 4699.0 4715.8 4760.2 5067.7 5189.6 5211.3 5278.3 5286.4 5700.9 5747.8 5764.3 5769.7 5770.1 5652.4 5655.0 5667.2 5667.3 5675.7 5124.7 5182.5 5242.5 5258.2 5329.3 5745.7 5802.3 5808.7 5809.0 5811.6 5326.2 5579.7 5590.0 5591.9 5594.6 5546.6 5620.0 5629.6 5663.3 5668.4 5623.8 5632.4 5632.6 5632.7 5639.2 5375.1 5527.9 5642.7 5646.6 5652.7 4308.1 4332.1 4337.8 4370.2 4373.8 3877.4 3895.6 3896.1 3903.2 3931.1 5142.2 5147.0 5283.8 5347.2 5388.3 5696.8 5727.9 5757.3 5758.5 5805.2 5320.2 5320.9 5323.3 5326.5 5381.3 4691.6 4743.4 4779.2 4940.5 4968.0 5756.5 5763.8 5764.7 5765.3 5801.2 5589.6 5599.1 5602.4 5602.8 5603.4 5588.5 5708.5 5739.8 5745.2 5747.8 5569.6 5577.1 5579.8 5592.3 5593.0 5658.2 5667.1 5672.7 5673.0 5673.7 5300.7 5375.9 5418.8 5461.3 5476.5 5456.6 5457.8 5458.6 5477.3 5491.9 5178.4 5347.9 5377.5 5397.2 5439.8 5407.3 5460.1 5471.6 5534.4 5558.9 5388.9 5396.5 5399.9 5401.6 5446.2 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#1] ext.html Cycles:180 Average:60429.13 Median:225051.90 stddev:114042.99 (50.7%) stddev-sans-first:114274.44 02:21:41 INFO - PROCESS | 29532 | Values: 598.7 624.9 630.3 646.3 647.0 33623.7 42579.4 43431.8 43528.6 43538.8 45621.3 46008.3 46082.0 46130.3 46213.0 7970.8 8736.6 8925.9 8926.2 8926.5 10078.1 10560.8 10563.4 10945.5 10951.7 10434.3 10488.6 10494.9 10498.6 10502.9 8114.2 10632.7 10670.8 10782.7 10916.5 10508.9 10575.7 10579.3 10627.6 10634.0 42439.2 42815.1 42859.4 42881.6 42890.4 3454.5 3749.3 4171.9 4174.3 4184.2 32577.8 32928.8 33303.0 33335.2 33543.5 4153.4 4300.6 4303.4 4347.1 4440.7 343681.0 344876.0 344883.0 346964.0 347999.0 60755.7 60986.0 61375.0 61390.7 61403.4 65995.3 66169.0 66322.3 66344.7 66357.3 16616.0 17056.0 17069.4 17077.7 17082.3 12936.9 13152.9 13154.7 13159.3 13161.3 16753.9 18348.7 18482.0 18495.8 18499.6 5927.3 6880.2 6884.4 6937.8 6962.8 1014.2 1037.3 1051.3 1135.8 1208.7 32116.9 33197.5 33248.5 33267.8 33525.5 1137.0 1211.7 1229.8 1237.6 1257.2 17097.7 17274.8 17424.1 17474.5 17490.4 512159.0 512955.0 517190.0 517748.0 517916.0 59276.0 59341.4 59362.4 59498.7 59504.7 1262.9 1348.6 1408.2 1433.5 1437.2 33244.7 34165.8 34298.3 34369.1 34448.8 50256.7 51173.7 51210.7 51215.0 51316.5 409053.0 419315.0 419407.0 419893.0 420046.0 35907.6 37379.4 40423.2 42297.0 42764.6 48393.0 48537.5 48538.8 49232.8 49785.8 40255.0 41164.0 41322.0 41802.2 42289.4 40865.0 41050.8 41108.0 41290.4 41504.0 37528.4 37607.6 45017.3 46039.0 46162.5 40017.5 44222.3 44863.6 45402.3 45575.0 34305.3 35336.8 35420.0 35453.5 35542.8 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#2] jquery.html Cycles:180 Average:27872.80 Median:391.77 stddev:77673.50 (19826.5%) stddev-sans-first:77863.96 02:21:41 INFO - PROCESS | 29532 | Values: 379.9 390.3 393.2 399.2 408.6 14236.1 16101.4 17920.0 19247.5 19422.2 17275.7 18104.5 18261.4 18742.2 18828.4 5240.9 5371.7 5390.4 5417.6 5419.7 3801.8 5310.3 5354.7 5639.0 5942.3 5971.8 6000.3 6017.8 6031.2 6034.8 5536.8 5860.2 5885.6 5962.3 5991.7 5382.2 5582.8 5585.2 5600.5 5679.2 14060.6 14266.4 14304.1 14350.1 14792.5 2359.1 2408.7 2543.0 2646.0 2764.2 9836.4 9873.3 9896.5 10223.1 10402.0 1858.9 1869.8 1884.4 1897.3 1909.5 62479.4 64169.0 68812.3 80980.0 82080.0 10526.0 10880.9 11105.4 11121.3 11225.6 15637.5 15714.8 15747.1 15750.9 15755.7 8013.6 8184.8 8225.0 8302.6 8372.0 7838.5 7842.3 7842.5 8037.9 8084.0 4821.5 4826.6 4838.5 4885.1 4892.8 1948.3 1967.7 1975.9 1994.4 2061.3 860.3 989.8 997.4 1033.7 1082.9 18888.5 19158.0 19472.9 19599.7 19748.5 987.2 1010.2 1034.2 1069.0 1107.7 8914.0 10652.0 10829.8 11025.7 11086.7 464710.0 469569.0 470377.0 472229.0 477249.0 90735.0 92334.5 92517.5 94748.1 95663.0 917.2 994.9 1042.0 1050.3 1050.5 16199.4 17411.5 17471.5 17572.2 18259.5 40678.8 41123.8 41190.0 42405.4 42997.1 54932.5 58313.4 58363.1 58591.0 59531.4 8507.3 8795.4 8836.5 8958.1 9090.0 9905.6 13299.7 13420.5 13647.2 13718.5 10932.3 11289.5 11525.7 12050.6 12060.2 11566.5 11645.4 11705.3 11904.1 12149.6 11614.5 11748.5 11941.1 12048.0 12062.4 7118.9 7385.2 7510.8 7586.6 9032.6 9608.3 10686.8 10834.3 10841.4 11091.8 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#3] mootools.html Cycles:180 Average:5834.31 Median:4758.58 stddev:3354.05 (70.5%) stddev-sans-first:3346.66 02:21:41 INFO - PROCESS | 29532 | Values: 1367.8 1478.2 1478.2 1634.6 1796.9 8229.8 8701.5 8716.3 8918.1 8948.0 8636.2 8821.7 8827.7 8839.5 8848.2 2078.4 2144.8 2147.3 2372.0 2401.3 2300.5 2400.7 2406.3 2412.8 2415.3 2311.4 2323.6 2340.5 2342.0 2359.9 2023.8 2219.4 2360.3 2399.7 2400.5 2376.2 2402.4 2404.5 2410.0 2410.2 8779.4 8842.1 8846.6 8847.6 8852.6 5159.0 5283.2 5292.1 5300.1 5303.2 3154.3 3242.2 3429.2 3430.2 3465.3 1111.4 1112.6 1154.4 1176.8 1178.2 12223.3 12285.9 12313.7 12323.4 12362.5 4688.0 4706.3 4791.1 4819.3 4822.8 10260.4 10415.8 10423.4 10497.7 10527.6 5173.9 5201.6 5209.6 5214.1 5214.9 4323.7 4735.7 4902.3 4966.0 5035.9 4079.2 4107.9 4159.8 4193.6 4219.5 1239.9 1250.7 1253.7 1260.7 1283.0 979.5 980.9 986.2 992.3 1005.6 5628.9 5719.5 5784.8 5879.8 5998.3 959.2 971.1 981.9 997.5 1030.4 3934.4 3967.6 4017.7 4058.5 4063.3 11266.7 11517.8 11589.5 11630.9 11713.0 10961.4 11075.4 11090.1 11090.4 11103.4 8165.6 8219.8 8290.5 8335.2 8361.2 5859.6 5900.4 5900.4 5971.1 5977.3 9992.0 10428.7 10443.5 10474.7 10475.1 10061.7 10455.3 10621.7 10645.4 10647.5 7618.3 7879.0 8007.9 8054.8 8323.5 8185.1 8256.9 8376.5 8460.2 8469.5 7271.5 7524.3 7663.6 7687.4 7825.8 7536.7 7633.7 7643.5 7781.5 7782.3 6834.1 6943.4 6958.0 6962.9 6968.0 4751.8 4765.4 4844.2 4889.8 5054.4 4943.7 4985.8 5052.1 5090.9 5093.5 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#4] prototype.html Cycles:180 Average:4665.54 Median:5343.17 stddev:1354.28 (25.3%) stddev-sans-first:1318.47 02:21:41 INFO - PROCESS | 29532 | Values: 333.5 337.5 343.3 344.4 345.9 5270.2 5355.6 5379.4 5384.1 5409.0 5248.3 5277.0 5330.9 5333.6 5340.8 4011.1 4014.6 4131.4 4135.9 4155.9 4126.0 4133.6 4139.7 4150.9 4153.3 3859.4 4095.5 4104.2 4130.6 4149.3 4018.3 4097.3 4099.4 4109.1 4132.3 3633.7 3651.5 3674.9 3676.1 3682.1 5076.6 5101.4 5138.3 5138.6 5145.6 4599.1 4746.0 4755.6 4773.7 4776.1 5452.7 5465.9 5486.2 5516.2 5521.2 4059.6 4079.5 4094.5 4100.4 4102.9 5602.0 5723.2 5727.1 5733.5 5740.5 4091.3 4122.6 4129.9 4147.3 4163.1 4211.8 4214.3 4216.9 4219.2 4244.6 4570.0 4715.7 4722.9 4728.6 4739.7 5514.9 5519.8 5550.6 5570.4 5594.4 1420.0 1424.2 1432.8 1434.3 1435.9 954.4 954.9 955.8 973.8 999.7 5271.7 5328.3 5345.5 5350.0 5351.4 5657.9 5661.7 5665.0 5682.5 5687.0 5126.4 5215.0 5293.9 5303.2 5325.7 2939.7 2970.4 2989.3 3019.9 3024.0 5765.8 5788.3 5793.9 5801.2 5804.0 5499.2 5720.2 5734.9 5736.9 5739.9 5738.2 5738.3 5770.4 5797.4 5812.4 5392.3 5622.5 5628.6 5630.3 5668.3 5521.2 5551.6 5564.4 5581.0 5600.5 5747.5 5790.9 5794.3 5803.3 5806.3 4030.9 4118.4 4140.9 4152.0 4168.4 5640.7 5682.3 5685.8 5697.8 5720.5 5320.2 5320.5 5550.5 5588.7 5589.1 5540.7 5548.3 5558.0 5562.5 5576.5 5204.9 5463.6 5472.6 5477.4 5477.6 5579.3 5583.8 5613.2 5626.1 5642.8 5447.9 5464.9 5474.4 5487.4 5504.9 02:21:41 INFO - PROCESS | 29532 | 02:21:41 INFO - PROCESS | 29532 | [#5] yui.html Cycles:180 Average:21144.14 Median:4352.28 stddev:30792.68 (707.5%) stddev-sans-first:30840.78 02:21:41 INFO - PROCESS | 29532 | Values: 693.3 697.5 729.9 788.2 793.4 15597.3 15808.2 16028.1 16042.1 16069.1 14916.7 15033.4 15242.8 15975.3 16045.8 821.4 822.0 828.1 828.2 829.2 685.0 797.5 827.0 830.8 834.4 843.5 844.5 846.3 849.3 849.6 710.8 854.4 855.3 859.4 860.2 601.3 624.5 624.9 627.0 629.1 15418.7 15420.2 15446.1 15454.1 15541.0 13752.0 14336.9 14446.6 14485.8 14519.5 12536.2 12755.5 12792.2 12838.3 12994.9 3798.2 3841.4 3901.0 3977.1 4015.3 76729.6 77785.0 77943.0 78317.0 80592.2 11038.2 11173.7 11273.4 11567.3 12021.4 20041.6 20046.6 20059.7 20448.0 22696.0 8492.7 8903.0 8931.3 8958.9 8964.8 4699.8 4726.5 4781.9 4885.2 4896.5 3655.3 3804.1 3816.8 3823.8 3830.7 614.7 616.8 631.0 649.7 654.0 701.1 718.6 722.6 731.6 756.3 10360.7 10534.8 10607.1 10608.8 10618.8 603.8 695.9 704.7 716.7 736.9 4689.3 4703.2 4810.8 4889.0 4964.2 71025.6 71651.0 104179.5 121512.4 129365.4 103741.5 108952.0 109591.0 110475.4 110523.0 87725.6 92840.5 93990.5 95626.5 96516.0 9144.1 9212.3 9399.0 9424.7 9467.8 54570.5 54576.2 55571.2 56064.2 58725.8 78876.0 81018.6 81129.6 83287.6 84454.6 12515.5 12636.0 12753.5 12924.9 12956.6 12564.5 12593.5 12789.3 12797.0 13290.9 12162.5 12355.8 12504.4 12592.6 12940.4 12318.4 12430.5 13075.5 13148.3 13205.0 12906.4 13002.9 13039.9 13086.3 13437.7 9609.6 9656.0 10090.4 10186.7 10360.7 10488.6 10951.1 11052.2 11294.3 11328.4 02:21:41 INFO - PROCESS | 29532 | -------- Summary: end -------- 02:21:41 INFO - PROCESS | 29532 | 02:21:42 INFO - TEST-INFO | 29532: exit 0 02:21:42 INFO - TEST-OK | dromaeo_css | took 1112684ms 02:21:42 INFO - TEST-START | kraken 02:21:42 INFO - operating with platform_type : linux_ 02:21:42 INFO - Initialising browser for kraken test... 02:21:42 INFO - TEST-INFO | started process 29712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3rqhA/profile http://localhost:44415/getInfo.html) 02:21:46 INFO - PROCESS | 29712 | __metrics Screen width/height:1600/1200 02:21:46 INFO - PROCESS | 29712 | colorDepth:24 02:21:46 INFO - PROCESS | 29712 | Browser inner width/height: 1024/697 02:21:46 INFO - PROCESS | 29712 | __metrics 02:21:47 ERROR - PROCESS | 29712 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:21:47 INFO - PROCESS | 29712 | console.error: PushService: 02:21:47 INFO - PROCESS | 29712 | stateChangeProcessEnqueue: Error transitioning state 02:21:47 INFO - PROCESS | 29712 | UnknownError 02:21:48 INFO - TEST-INFO | 29712: exit 0 02:21:48 INFO - Browser initialized. 02:21:48 INFO - Running cycle 1/1 for kraken test... 02:21:48 INFO - TEST-INFO | started process 29796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3rqhA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:00 INFO - PROCESS | 29796 | RSS: Main: 155783168 02:22:00 INFO - PROCESS | 29796 | 02:22:02 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44415/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:03 INFO - PROCESS | 29796 | RSS: Main: 214392832 02:22:03 INFO - PROCESS | 29796 | 02:22:06 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44415/tests/kraken/driver.html?testName=audio-dft) 02:22:07 INFO - PROCESS | 29796 | RSS: Main: 201605120 02:22:07 INFO - PROCESS | 29796 | 02:22:10 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44415/tests/kraken/driver.html?testName=audio-fft) 02:22:10 INFO - PROCESS | 29796 | RSS: Main: 268517376 02:22:10 INFO - PROCESS | 29796 | 02:22:12 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44415/tests/kraken/driver.html?testName=audio-oscillator) 02:22:13 INFO - PROCESS | 29796 | RSS: Main: 179298304 02:22:13 INFO - PROCESS | 29796 | 02:22:15 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:16 INFO - PROCESS | 29796 | RSS: Main: 183345152 02:22:16 INFO - PROCESS | 29796 | 02:22:19 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44415/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:19 INFO - PROCESS | 29796 | RSS: Main: 219525120 02:22:19 INFO - PROCESS | 29796 | 02:22:23 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44415/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:23 INFO - PROCESS | 29796 | RSS: Main: 220274688 02:22:23 INFO - PROCESS | 29796 | 02:22:26 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44415/tests/kraken/driver.html?testName=json-parse-financial) 02:22:27 INFO - PROCESS | 29796 | RSS: Main: 220663808 02:22:27 INFO - PROCESS | 29796 | 02:22:28 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:29 INFO - PROCESS | 29796 | RSS: Main: 207695872 02:22:29 INFO - PROCESS | 29796 | 02:22:31 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:31 INFO - PROCESS | 29796 | RSS: Main: 209387520 02:22:31 INFO - PROCESS | 29796 | 02:22:33 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:34 INFO - PROCESS | 29796 | RSS: Main: 216461312 02:22:34 INFO - PROCESS | 29796 | 02:22:37 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:37 INFO - PROCESS | 29796 | RSS: Main: 221544448 02:22:37 INFO - PROCESS | 29796 | 02:22:40 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:40 INFO - PROCESS | 29796 | RSS: Main: 220909568 02:22:40 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:44415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44415/tests/kraken/driver.html?testName=ai-astar) 02:22:42 INFO - PROCESS | 29796 | RSS: Main: 263294976 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | __start_tp_report 02:22:42 INFO - PROCESS | 29796 | _x_x_mozilla_page_load 02:22:42 INFO - PROCESS | 29796 | _x_x_mozilla_page_load_details 02:22:42 INFO - PROCESS | 29796 | |i|pagename|runs| 02:22:42 INFO - PROCESS | 29796 | |0;ai-astar;111;105;109;111;111;112;110;111;109;110 02:22:42 INFO - PROCESS | 29796 | |1;audio-beat-detection;154;131;141;186;129;150;153;137;199;127 02:22:42 INFO - PROCESS | 29796 | |2;audio-dft;161;161;160;161;160;162;161;162;161;162 02:22:42 INFO - PROCESS | 29796 | |3;audio-fft;75;75;75;135;77;75;73;74;98;75 02:22:42 INFO - PROCESS | 29796 | |4;audio-oscillator;85;84;114;85;84;85;117;86;85;134 02:22:42 INFO - PROCESS | 29796 | |5;imaging-gaussian-blur;116;117;116;117;116;116;116;118;117;117 02:22:42 INFO - PROCESS | 29796 | |6;imaging-darkroom;145;146;145;145;146;146;146;145;145;146 02:22:42 INFO - PROCESS | 29796 | |7;imaging-desaturate;95;95;94;94;94;96;95;95;95;95 02:22:42 INFO - PROCESS | 29796 | |8;json-parse-financial;56;56;58;56;57;56;55;56;55;55 02:22:42 INFO - PROCESS | 29796 | |9;json-stringify-tinderbox;62;61;61;61;63;62;61;60;62;62 02:22:42 INFO - PROCESS | 29796 | |10;stanford-crypto-aes;79;79;79;80;81;80;81;81;109;86 02:22:42 INFO - PROCESS | 29796 | |11;stanford-crypto-ccm;135;133;131;120;127;137;127;121;131;122 02:22:42 INFO - PROCESS | 29796 | |12;stanford-crypto-pbkdf2;162;159;161;162;162;162;166;161;165;157 02:22:42 INFO - PROCESS | 29796 | |13;stanford-crypto-sha256-iterative;65;63;62;65;62;63;63;60;61;61 02:22:42 INFO - PROCESS | 29796 | __end_tp_report 02:22:42 INFO - PROCESS | 29796 | __start_cc_report 02:22:42 INFO - PROCESS | 29796 | _x_x_mozilla_cycle_collect,1649 02:22:42 INFO - PROCESS | 29796 | __end_cc_report 02:22:42 INFO - PROCESS | 29796 | __startTimestamp1465377762856__endTimestamp 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | ------- Summary: start ------- 02:22:42 INFO - PROCESS | 29796 | Number of tests: 14 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.97 (1.8%) stddev-sans-first:2.05 02:22:42 INFO - PROCESS | 29796 | Values: 111.0 105.0 109.0 111.0 111.0 112.0 110.0 111.0 109.0 110.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:151.50 stddev:24.26 (16.0%) stddev-sans-first:25.71 02:22:42 INFO - PROCESS | 29796 | Values: 154.0 131.0 141.0 186.0 129.0 150.0 153.0 137.0 199.0 127.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:22:42 INFO - PROCESS | 29796 | Values: 161.0 161.0 160.0 161.0 160.0 162.0 161.0 162.0 161.0 162.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:19.62 (26.2%) stddev-sans-first:20.59 02:22:42 INFO - PROCESS | 29796 | Values: 75.0 75.0 75.0 135.0 77.0 75.0 73.0 74.0 98.0 75.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:18.50 (21.8%) stddev-sans-first:19.20 02:22:42 INFO - PROCESS | 29796 | Values: 85.0 84.0 114.0 85.0 84.0 85.0 117.0 86.0 85.0 134.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 02:22:42 INFO - PROCESS | 29796 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 116.0 118.0 117.0 117.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:22:42 INFO - PROCESS | 29796 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:22:42 INFO - PROCESS | 29796 | Values: 95.0 95.0 94.0 94.0 94.0 96.0 95.0 95.0 95.0 95.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 02:22:42 INFO - PROCESS | 29796 | Values: 56.0 56.0 58.0 56.0 57.0 56.0 55.0 56.0 55.0 55.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 02:22:42 INFO - PROCESS | 29796 | Values: 62.0 61.0 61.0 61.0 63.0 62.0 61.0 60.0 62.0 62.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.50 stddev:9.19 (11.4%) stddev-sans-first:9.60 02:22:42 INFO - PROCESS | 29796 | Values: 79.0 79.0 79.0 80.0 81.0 80.0 81.0 81.0 109.0 86.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.00 stddev:5.99 (4.6%) stddev-sans-first:5.85 02:22:42 INFO - PROCESS | 29796 | Values: 135.0 133.0 131.0 120.0 127.0 137.0 127.0 121.0 131.0 122.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 02:22:42 INFO - PROCESS | 29796 | Values: 162.0 159.0 161.0 162.0 162.0 162.0 166.0 161.0 165.0 157.0 02:22:42 INFO - PROCESS | 29796 | 02:22:42 INFO - PROCESS | 29796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.48 02:22:42 INFO - PROCESS | 29796 | Values: 65.0 63.0 62.0 65.0 62.0 63.0 63.0 60.0 61.0 61.0 02:22:42 INFO - PROCESS | 29796 | -------- Summary: end -------- 02:22:42 INFO - PROCESS | 29796 | 02:22:43 INFO - TEST-INFO | 29796: exit 0 02:22:43 INFO - TEST-OK | kraken | took 61123ms 02:22:43 INFO - SUITE-END | took 1173s 02:22:44 INFO - Completed test suite (00:19:34) 02:22:44 INFO - javascript benchmark 02:22:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.639746429161, 3139.9638119420592, 3157.952630710539, 3180.268538236204, 3196.8401579921015, 5066.84799456016, 5150.8454746357575, 5153.30430391897, 5283.867903302419, 5302.761375738087, 5171.818986335479, 5222.3472065991755, 5224.8693782655455, 5256.894862102756, 5274.0, 4555.271156614951, 4643.210654188796, 4683.8360657377, 4726.621870250372, 4898.510148985109, 4838.733869637169, 4901.460839307673, 4908.484609116027, 4912.140375434285, 4935.851924442272, 4630.398048253723, 4678.672492925513, 4679.15775160471, 4787.425508938914, 4883.658143929926, 4633.953660463386, 4653.0, 4653.86038418848, 4658.557437043475, 4747.0505898820375, 4675.0, 4692.8122875084955, 4698.953010469886, 4715.834945776915, 4760.190767569521, 5067.721275329855, 5189.55888749453, 5211.296474975868, 5278.340207474066, 5286.444923283038, 5700.914486282709, 5747.770089196469, 5764.33710123337, 5769.653820770767, 5770.134479828017, 5652.434756524356, 5655.038643430586, 5667.1782591524, 5667.291588551431, 5675.744591493392, 5124.718140502271, 5182.481751824825, 5242.528172464458, 5258.211268309746, 5329.333833270841, 5745.6552606843725, 5802.274715660543, 5808.651480911074, 5809.0, 5811.593188476766, 5326.201069839555, 5579.69311687861, 5590.049691552445, 5591.944080559224, 5594.552435805126, 5546.55627549795, 5620.0, 5629.634073785191, 5663.32040155184, 5668.376478587352, 5623.831285061455, 5632.408597097327, 5632.633878797865, 5632.662040277596, 5639.154126881001, 5375.1131063374105, 5527.944720552823, 5642.7178641067785, 5646.632968857011, 5652.689102099342, 4308.073764140725, 4332.1119170569955, 4337.761423121696, 4370.21336159488, 4373.803178856959, 3877.3796192609047, 3895.5909629488497, 3896.103896103912, 3903.1803321302846, 3931.095847954929, 5142.1772516397195, 5147.0, 5283.841484755463, 5347.1979203119845, 5388.326459192601, 5696.772129114789, 5727.856803579861, 5757.309122905278, 5758.510526605285, 5805.245318108703, 5320.201969704498, 5320.893582128336, 5323.254744335796, 5326.520613144836, 5381.300430943952, 4691.577758001797, 4743.430788305425, 4779.211430114062, 4940.456549779521, 4968.0, 5756.510696590837, 5763.827085187451, 5764.74058667361, 5765.279340082489, 5801.158831969341, 5589.580781441408, 5599.076152434803, 5602.355729091207, 5602.831915042555, 5603.411641777555, 5588.469095435927, 5708.514776244066, 5739.799107031234, 5745.1956726059225, 5747.770089196385, 5569.582281328835, 5577.135543990688, 5579.832605021694, 5592.3009623797025, 5593.02122128634, 5658.151277308437, 5667.121596152603, 5672.659640421588, 5673.0, 5673.687947162781, 5300.681959082467, 5375.892482150257, 5418.756155972912, 5461.317335333083, 5476.507114359727, 5456.645318054314, 5457.754401052041, 5458.563314934716, 5477.287952566141, 5491.917621235764, 5178.404483484297, 5347.866303342447, 5377.462253774591, 5397.190421436816, 5439.809606663748, 5407.270018547446, 5460.099083651312, 5471.616986811045, 5534.418886016911, 5558.888822223452, 5388.946110538845, 5396.541293989898, 5399.892002160013, 5401.648892821954, 5446.1558458439], "value": 5179.462215782261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7096258314716, 624.8500359913621, 630.3066626710616, 646.2987658390646, 646.9967650161749, 33623.66376336239, 42579.361309580345, 43431.78284108583, 43528.56471435285, 43538.782306088506, 45621.31568026474, 46008.30987535181, 46082.0, 46130.308045379265, 46213.0, 7970.840583188333, 8736.563171841415, 8925.866112008325, 8926.152015558511, 8926.509042002688, 10078.143357814595, 10560.788784224349, 10563.366198028143, 10945.507452164631, 10951.726206844813, 10434.269601127924, 10488.632897848576, 10494.947525262402, 10498.580056797718, 10502.894971050306, 8114.229148230908, 10632.734181645443, 10670.78658426831, 10782.67651970442, 10916.508757105948, 10508.894911050867, 10575.73560660982, 10579.259451838374, 10627.628033018884, 10634.0, 42439.1512169758, 42815.14369712588, 42859.35710964338, 42881.57118428838, 42890.356644650354, 3454.464557993515, 3749.3063783200196, 4171.895702607429, 4174.3112386456505, 4184.184084103601, 32577.837110814533, 32928.83535582331, 33303.00090997274, 33335.16662083443, 33543.49684754731, 4153.356229784388, 4300.569943005675, 4303.4190384298345, 4347.108842687273, 4440.711353761995, 343681.0, 344876.0, 344883.0, 346964.0, 347999.0, 60755.69622151861, 60986.0, 61375.0, 61390.693046534485, 61403.385966139766, 65995.34004659989, 66169.0, 66322.33677663258, 66344.69725376081, 66357.33642663511, 16616.0, 17056.0, 17069.40257090996, 17077.658446830992, 17082.316707331567, 12936.935315323362, 13152.868471315165, 13154.671133221555, 13159.276239806903, 13161.276129812952, 16753.91623041877, 18348.724769128472, 18482.0, 18495.815041849677, 18499.630007399777, 5927.347991720907, 6880.243173251039, 6884.351293814287, 6937.7571784987285, 6962.825929351706, 1014.1734486393566, 1037.2687255484866, 1051.279873286801, 1135.8353038809325, 1208.7219939413808, 32116.897415841566, 33197.50203746946, 33248.501272480935, 33267.833660831544, 33525.49711754326, 1136.960206392789, 1211.745533437988, 1229.827824104626, 1237.622525129826, 1257.2142410993129, 17097.743533847002, 17274.827251727573, 17424.12879356027, 17474.47576572705, 17490.387836425663, 512159.0, 512955.0, 517190.0, 517748.0, 517916.0, 59276.0, 59341.40658593445, 59362.40637593655, 59498.70250648719, 59504.70247648734, 1262.9242245465302, 1348.6223857319967, 1408.2114016150988, 1433.4624515806572, 1437.1664434627892, 33244.667553325125, 34165.82917085498, 34298.314033718685, 34369.14077148091, 34448.79429219965, 50256.74871625618, 51173.744131279105, 51210.74394628003, 51215.0, 51316.486835131174, 409053.0, 419315.0, 419407.0, 419893.0, 420046.0, 35907.64092359043, 37379.43930840985, 40423.191536168524, 42297.0, 42764.572354277305, 48393.0, 48537.5146248533, 48538.75730621324, 49232.75383623059, 49785.75107124586, 40255.0, 41164.0, 41322.0, 41802.163956720084, 42289.365659514515, 40865.0, 41050.79474602608, 41108.0, 41290.38064428976, 41504.0, 37528.43707344447, 37607.62392376041, 45017.32474012827, 46039.0, 46162.538374615826, 40017.51052123704, 44222.336664949406, 44863.55136448724, 45402.31896521489, 45575.0, 34305.31389372249, 35336.82331588326, 35420.0, 35453.46819797654, 35542.822285888404], "value": 21226.032103692396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.92591444668284, 390.2877249020538, 393.2430072111186, 399.1760848298342, 408.62814838496973, 14236.145831250133, 16101.355945762185, 17920.0, 19247.518812029706, 19422.223111075575, 17275.654486910254, 18104.456866294033, 18261.36085237017, 18742.156602952866, 18828.435146945612, 5240.9213861792, 5371.650842695231, 5390.407055223922, 5417.59368047396, 5419.674819510842, 3801.771893686374, 5310.283111779918, 5354.705491197982, 5638.984982703112, 5942.316633587128, 5971.790987315445, 6000.33996260411, 6017.819465416044, 6031.24609423822, 6034.818955431322, 5536.833894983157, 5860.179574859523, 5885.646861188342, 5962.314333851619, 5991.730372133243, 5382.219578161144, 5582.8325150245555, 5585.245991791137, 5600.4959553640365, 5679.176519404705, 14060.578182654537, 14266.429342826275, 14304.141751494944, 14350.067245629105, 14792.482263120739, 2359.1153317505937, 2408.747081556429, 2542.9618555721677, 2645.999999999981, 2764.2121995231464, 9836.3606365586, 9873.308868379216, 9896.505174741234, 10223.131033862132, 10402.0, 1858.869879108463, 1869.8223668751448, 1884.3687364732832, 1897.2600685732575, 1909.484439201408, 62479.37520624781, 64169.0, 68812.3118768811, 80980.0, 82080.0, 10526.0, 10880.891191087987, 11105.444727763579, 11121.27711698737, 11225.550977960791, 15637.530874073796, 15714.842851571566, 15747.133907634961, 15750.921245393929, 15755.684886302439, 8013.559254240956, 8184.754457366289, 8224.958875205586, 8302.584870756438, 8372.0, 7838.490498117604, 7842.333401660922, 7842.45102842807, 8037.919620803834, 8083.959580202061, 4821.4696383397795, 4826.58973987208, 4838.516148385203, 4885.071836351082, 4892.755362231874, 1948.279136719423, 1967.6851703727334, 1975.8518111141723, 1994.3717728915635, 2061.2682497713095, 860.2988564320059, 989.7575094101848, 997.4464172384396, 1033.7105610429091, 1082.9404382758867, 18888.52778680544, 19158.0, 19472.90263548673, 19599.706004409945, 19748.50628734293, 987.1855719031828, 1010.2170817616407, 1034.1881622925966, 1068.9844647584825, 1107.6510899066768, 8914.0, 10652.0, 10829.783404331869, 11025.669229923114, 11086.667399978014, 464710.0, 469569.0, 470377.0, 472229.0, 477249.0, 90735.0, 92334.53832730927, 92517.53741231251, 94748.0525194753, 95663.0, 917.1653795046609, 994.8756405449319, 1041.9791604167874, 1050.3120456101267, 1050.495762034228, 16199.43301984425, 17411.47765567035, 17471.475855724348, 17572.2092505835, 18259.54351141232, 40678.79660601678, 41123.7943810291, 41190.0, 42405.363919540614, 42997.140057198056, 54932.450675492735, 58313.4168658308, 58363.12455313089, 58591.0, 59531.404685952584, 8507.276881465144, 8795.428297160664, 8836.513991730259, 8958.148975847284, 9090.045545217657, 9905.554250058909, 13299.66750831237, 13420.46318147263, 13647.181169129884, 13718.45126194941, 10932.289401188897, 11289.491972861077, 11525.654230373102, 12050.578229761917, 12060.216085954386, 11566.479508421973, 11645.41772911368, 11705.297682139098, 11904.107191960811, 12149.574764883188, 11614.535418583162, 11748.530058797895, 11941.104417168573, 12048.0, 12062.396880156133, 7118.8932166018585, 7385.224551422239, 7510.812229694301, 7586.582737949466, 9032.63869445215, 9608.327417080738, 10686.83969740439, 10834.34993900337, 10841.403722795321, 11091.833622495507], "value": 8991.951529449403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.7811550151978, 1478.2165452310273, 1478.238707065861, 1634.5504986128813, 1796.9281228750842, 8229.794255143617, 8701.477911325324, 8716.30269578433, 8918.063603321654, 8948.015718270985, 8636.222739953419, 8821.691240806573, 8827.691030813923, 8839.513826739527, 8848.247898928583, 2078.366098340006, 2144.7962443567912, 2147.2699282244034, 2372.0393240737485, 2401.3156250468533, 2300.5053913408615, 2400.6519054737055, 2406.3262286559793, 2412.8431651942656, 2415.311636183688, 2311.3528212100637, 2323.61660326046, 2340.4616938104245, 2342.0, 2359.9292021239303, 2023.7976202379791, 2219.411855858199, 2360.2565191964477, 2399.748026457214, 2400.519896020794, 2376.2277259890607, 2402.3513651314047, 2404.495056038234, 2409.9518009639883, 2410.240774156135, 8779.385443018991, 8842.115788421172, 8846.557672116369, 8847.557622118933, 8852.601632926533, 5158.974205128988, 5283.207518872162, 5292.100342941709, 5300.09898317287, 5303.15149576066, 3154.3060526684094, 3242.205659613386, 3429.2112814052907, 3430.2281986552825, 3465.2549701813978, 1111.3665210829831, 1112.6272698645964, 1154.3824054131082, 1176.7940610393148, 1178.1870509348607, 12223.266604003788, 12285.93857030718, 12313.692157696129, 12323.383830808514, 12362.505499779998, 4687.95312046882, 4706.294055891643, 4791.065742180242, 4819.2530157825595, 4822.807087716452, 10260.384376937407, 10415.791684166426, 10423.42671153094, 10497.685069447929, 10527.631532896465, 5173.896522069537, 5201.609879259071, 5209.609279303992, 5214.113600687892, 5214.895702085937, 4323.654107671378, 4735.715857048588, 4902.28916807061, 4965.9751701241985, 5035.924461133086, 4079.1637714268504, 4107.9178416432105, 4159.7920103994675, 4193.580641935782, 4219.451471308772, 1239.9070069744805, 1250.7435975624976, 1253.6803115205746, 1260.6659235302652, 1282.9550965716155, 979.456401697065, 980.9215262778961, 986.225812736998, 992.3450522655013, 1005.597760895633, 5628.85927851807, 5719.542436605062, 5784.82645520635, 5879.823605291848, 5998.310194327621, 959.1990687775645, 971.1114330387758, 981.8625392445064, 997.546116516983, 1030.444029515422, 3934.3705007199283, 3967.563568007517, 4017.738846974937, 4058.5332686741403, 4063.329550624173, 11266.718332041764, 11517.76964460706, 11589.478473468715, 11630.88369116315, 11713.0, 10961.397123158304, 11075.390853502973, 11090.057345125593, 11090.445477726082, 11103.44482775858, 8165.550894700848, 8219.794505137419, 8290.4611200273, 8335.249827515552, 8361.247487726134, 5859.648421094748, 5900.380460051804, 5900.409959004237, 5971.0744834550715, 5977.3126090500145, 9992.0, 10428.687139385831, 10443.477826108816, 10474.738131546468, 10475.109615682448, 10061.748456288651, 10455.320404174008, 10621.734456638645, 10645.361278323326, 10647.520861561403, 7618.276263754934, 7879.0, 8007.879881801661, 8054.83890322202, 8323.542205178774, 8185.058718247477, 8256.917430825855, 8376.455530390505, 8460.238578527962, 8469.491830490191, 7271.454640901848, 7524.2851929066655, 7663.616819158909, 7687.423443241667, 7825.843483130192, 7536.660850261642, 7633.6564854580565, 7643.503172293783, 7781.455298129076, 7782.338501227459, 6834.077399550997, 6943.375096241362, 6958.0, 6962.930370696228, 6968.0, 4751.762411879461, 4765.404324459442, 4844.249141383091, 4889.804407823647, 5054.393472783289, 4943.703377797344, 4985.750712464434, 5052.065367906949, 5090.872728181825, 5093.4651861554], "value": 4661.922872590414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4647890136331, 337.4870197300104, 343.33221883436715, 344.4316877152699, 345.8841288168462, 5270.156774916009, 5355.6251062425645, 5379.408265090842, 5384.057789886774, 5408.971635636636, 5248.317718696574, 5276.973615131928, 5330.946690533094, 5333.573314134869, 5340.839774806752, 4011.117554138085, 4014.618611231943, 4131.442255295527, 4135.937960930589, 4155.896102597429, 4125.958740412588, 4133.627973482386, 4139.710220284582, 4150.937735933963, 4153.293940030187, 3859.4176387681055, 4095.488063992001, 4104.22964498962, 4130.607592278744, 4149.315362965107, 4018.3369743992207, 4097.323941549641, 4099.405586190015, 4109.137081212949, 4132.29750942339, 3633.745637805355, 3651.5253017107607, 3674.926501469982, 3676.117731744389, 3682.1346983458866, 5076.593872490192, 5101.4133374662015, 5138.306328645623, 5138.640295179339, 5145.562627176694, 4599.103174880899, 4745.976270118627, 4755.595774359183, 4773.711098003554, 4776.11641846256, 5452.727363631802, 5465.9180112298345, 5486.231927530149, 5516.152089050173, 5521.199426083195, 4059.5737447567876, 4079.4900637420324, 4094.488188976378, 4100.384942258685, 4102.876913692594, 5602.0196465618765, 5723.195634139283, 5727.11229759388, 5733.483986441241, 5740.54075673945, 4091.3249313863475, 4122.629488044387, 4129.938050929239, 4147.336426171798, 4163.065039147394, 4211.810468528924, 4214.25108579942, 4216.852410165629, 4219.240536703362, 4244.596763307481, 4570.020192421908, 4715.740634265148, 4722.905541889143, 4728.59806916416, 4739.691920025188, 5514.862128446821, 5519.834404967857, 5550.639208451437, 5570.41510641385, 5594.440555944454, 1419.985800142006, 1424.223798030076, 1432.842387337392, 1434.3115304653616, 1435.8584924984661, 954.3510412919143, 954.9066319064771, 955.8338826631499, 973.8003709239589, 999.6850991937516, 5271.710055946883, 5328.333958255218, 5345.492178243061, 5350.0, 5351.357837059578, 5657.915131273035, 5661.660300381908, 5664.960614178893, 5682.545396368363, 5687.0, 5126.436092029874, 5215.0, 5293.867653308698, 5303.15149576066, 5325.733713314319, 2939.7354238118673, 2970.376220993572, 2989.342344684166, 3019.8641061152302, 3023.969760302413, 5765.84683063389, 5788.321386797866, 5793.94206057934, 5801.187833703285, 5804.013317735995, 5499.157782143026, 5720.197103419295, 5734.913976290359, 5736.942630573724, 5739.8565035874435, 5738.225339579187, 5738.340090889517, 5770.422957704196, 5797.420257974253, 5812.389699081536, 5392.325959255093, 5622.522085622768, 5628.577856660849, 5630.296212973379, 5668.26312579362, 5521.199426083276, 5551.611387203018, 5564.443555644403, 5580.972095139498, 5600.4959553640365, 5747.540196784331, 5790.9420905792085, 5794.333651630117, 5803.303603567599, 5806.332271788799, 4030.91938161241, 4118.402831589343, 4140.937885931653, 4151.97924010378, 4168.353905144708, 5640.71796410186, 5682.261306030189, 5685.800996965087, 5697.800576979786, 5720.513756330592, 5320.17537281722, 5320.52115309624, 5550.47270509301, 5588.748506317307, 5589.105743081088, 5540.695261760642, 5548.278723765885, 5558.0, 5562.527185189304, 5576.470235327637, 5204.895902082013, 5463.617546771688, 5472.589555783412, 5477.370102438271, 5477.589180811376, 5579.2746942897165, 5583.776648934159, 5613.158026296088, 5626.143372686922, 5642.830715078554, 5447.891042179055, 5464.890702186013, 5474.397816240131, 5487.368952570506, 5504.862378440571], "value": 4237.513919659202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.2686016252854, 697.5431092634323, 729.9343059124684, 788.2275370137266, 793.4326956226299, 15597.298121584528, 15808.20958952052, 16028.118453485054, 16042.117683527402, 16069.116198609086, 14916.7016659667, 15033.398664053424, 15242.771358429605, 15975.281112349943, 16045.83954160458, 821.4250024982506, 822.0341099208437, 828.0849661124461, 828.204923273658, 829.1956801902176, 685.0477835808206, 797.4736673795296, 827.0323721246126, 830.7715378270993, 834.3742193354984, 843.4981186194235, 844.5312851367488, 846.3060290561742, 849.3332733803965, 849.5539841583156, 710.7725527831096, 854.3549620036863, 855.2772906893696, 859.4027151129967, 860.1957170046027, 601.2934801608093, 624.4816802054283, 624.8531595075153, 627.0343670747044, 629.128656810321, 15418.691626167414, 15420.151891645955, 15446.0732356059, 15454.072755634697, 15541.0, 13752.0, 14336.92831535846, 14446.638834029129, 14485.78271325931, 14519.491817786433, 12536.247825130431, 12755.489780408772, 12792.232466052066, 12838.293893835835, 12994.935025324907, 3798.2213646202463, 3841.4045822897215, 3901.0, 3977.085270387798, 4015.257177422186, 76729.61635191845, 77785.0, 77943.0, 78317.0, 80592.19407805905, 11038.17213708975, 11173.72065698364, 11273.436328183558, 11567.305961642329, 12021.398930053463, 20041.599168016557, 20046.599068018557, 20059.699104513445, 20448.0, 22696.0, 8492.74521764348, 8902.955485222532, 8931.330150238759, 8958.86561701575, 8964.820703585892, 4699.812007519729, 4726.456457507362, 4781.928271075936, 4885.2427873679635, 4896.534829191221, 3655.250673611903, 3804.0680033391995, 3816.809159542012, 3823.808809559511, 3830.7318487705593, 614.6803662095774, 616.8026231605933, 630.9716062777186, 649.6978904809287, 654.045094162528, 701.1025886864821, 718.6370882704201, 722.5772922840092, 731.5574077682925, 756.34198247525, 10360.740981475523, 10534.789304213873, 10607.098396636373, 10608.840867386996, 10618.840717389245, 603.8339456649456, 695.942167904792, 704.7322017633267, 716.7240612364277, 736.8563130189561, 4689.296605509201, 4703.244132157314, 4810.7835147418455, 4889.0, 4964.15609346412, 71025.64487177531, 71651.0, 104179.47910260552, 121512.39243803725, 129365.35317323353, 103741.48129259306, 108952.0, 109591.0, 110475.44762276138, 110523.0, 87725.56137219274, 92840.53579732194, 93990.53004734933, 95626.52186739161, 96515.99999999859, 9144.131307525775, 9212.3090768194, 9398.95300523493, 9424.670136545188, 9467.810643786948, 54570.45429545654, 54576.18135727888, 55571.16643250274, 56064.15903761365, 58725.825483490946, 78876.0, 81018.5949070251, 81129.59435202787, 83287.5835620818, 84454.57772711097, 12515.45808066505, 12636.0, 12753.48986040548, 12924.870751292367, 12956.611301660965, 12564.497420103093, 12593.496260149492, 12789.296588687712, 12797.0, 13290.933545332211, 12162.452689628812, 12355.796758694443, 12504.374781261082, 12592.622221333375, 12940.417681204557, 12318.445669944695, 12430.502779888704, 13075.476980921037, 13148.276844773629, 13204.973767260331, 12906.354682266037, 13002.869971300544, 13039.934800326317, 13086.269259207358, 13437.664058398619, 9609.56756945953, 9655.951720241354, 10090.404203919888, 10186.745331366776, 10360.689179324632, 10488.580456781643, 10951.100171700153, 11052.225622651902, 11294.265872718248, 11328.376939268419], "value": 7573.705065447309, "unit": "score"}], "name": "dromaeo_css", "value": 7272.324021557817, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 111.0, 111.0, 112.0, 110.0, 111.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 141.0, 186.0, 129.0, 150.0, 153.0, 137.0, 199.0, 127.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 135.0, 77.0, 75.0, 73.0, 74.0, 98.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 85.0, 84.0, 85.0, 117.0, 86.0, 85.0, 134.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 56.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 63.0, 62.0, 61.0, 60.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 81.0, 80.0, 81.0, 81.0, 109.0, 86.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 131.0, 120.0, 127.0, 137.0, 127.0, 121.0, 131.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 162.0, 162.0, 162.0, 166.0, 161.0, 165.0, 157.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 65.0, 62.0, 63.0, 63.0, 60.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1511.3000000000002, "alertThreshold": 2.0}]} 02:22:44 INFO - Return code: 0 02:22:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:44 ERROR - # TBPL SUCCESS # 02:22:44 INFO - Running post-action listener: _resource_record_post_action 02:22:44 INFO - ##### 02:22:44 INFO - ##### Finished run-tests step (success) 02:22:44 INFO - ##### 02:22:44 INFO - Running post-run listener: _resource_record_post_run 02:22:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312303616; Read time: 16; Write time: 155452 02:22:44 INFO - TinderboxPrint: CPU usage
13.1% 02:22:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:22:44 INFO - TinderboxPrint: I/O write bytes / time
312,303,616 / 155,452 02:22:44 INFO - TinderboxPrint: CPU idle
8,264.8 (86.9%) 02:22:44 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 02:22:44 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 18948096; Read time: 0; Write time: 4908 02:22:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293355520; Read time: 16; Write time: 150544 02:22:44 INFO - Running post-run listener: _upload_blobber_files 02:22:44 INFO - Blob upload gear active. 02:22:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:45 INFO - (blobuploader) - INFO - Done attempting. 02:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:49 INFO - (blobuploader) - INFO - Done attempting. 02:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:50 INFO - (blobuploader) - INFO - Done attempting. 02:22:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:50 INFO - Return code: 0 02:22:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d73e44757fb8d09f2ab06c801a5f223f78dd3699a8fed915b04e7e54133f399490c1a2f6e3057e0a29e408608d3412dc42959ce13188058e35fe23416d099b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3add318e5c58f844d74119044ac034c841b42ae9c549f2bc3cc5d8c76d121144b9ecdf8411be109dda73969e7c391ab7803b4251d0fa4ba9da7fd76f7d2d082d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afa78a51cd1ff518c5c490cd52301f91fdd2af8b3f03247d5aa6a82884bb27f3d0dd9116d60313eecf946a7a3b0c92520882dc3855be697b3d6ca23d02b7a90e"} 02:22:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:50 INFO - Contents: 02:22:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d73e44757fb8d09f2ab06c801a5f223f78dd3699a8fed915b04e7e54133f399490c1a2f6e3057e0a29e408608d3412dc42959ce13188058e35fe23416d099b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3add318e5c58f844d74119044ac034c841b42ae9c549f2bc3cc5d8c76d121144b9ecdf8411be109dda73969e7c391ab7803b4251d0fa4ba9da7fd76f7d2d082d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afa78a51cd1ff518c5c490cd52301f91fdd2af8b3f03247d5aa6a82884bb27f3d0dd9116d60313eecf946a7a3b0c92520882dc3855be697b3d6ca23d02b7a90e"} 02:22:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:50 INFO - Copying logs to upload dir... 02:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.404589 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 02:22:49.997649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:50.000667) ========= 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=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d73e44757fb8d09f2ab06c801a5f223f78dd3699a8fed915b04e7e54133f399490c1a2f6e3057e0a29e408608d3412dc42959ce13188058e35fe23416d099b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3add318e5c58f844d74119044ac034c841b42ae9c549f2bc3cc5d8c76d121144b9ecdf8411be109dda73969e7c391ab7803b4251d0fa4ba9da7fd76f7d2d082d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afa78a51cd1ff518c5c490cd52301f91fdd2af8b3f03247d5aa6a82884bb27f3d0dd9116d60313eecf946a7a3b0c92520882dc3855be697b3d6ca23d02b7a90e"} build_url:https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/A6UETFSsR7eZgZajRZIs9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d73e44757fb8d09f2ab06c801a5f223f78dd3699a8fed915b04e7e54133f399490c1a2f6e3057e0a29e408608d3412dc42959ce13188058e35fe23416d099b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3add318e5c58f844d74119044ac034c841b42ae9c549f2bc3cc5d8c76d121144b9ecdf8411be109dda73969e7c391ab7803b4251d0fa4ba9da7fd76f7d2d082d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afa78a51cd1ff518c5c490cd52301f91fdd2af8b3f03247d5aa6a82884bb27f3d0dd9116d60313eecf946a7a3b0c92520882dc3855be697b3d6ca23d02b7a90e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:50.028754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:50.029082) ========= 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=00204705a9daa57ed339a427000001b9-1465376342.556507-1786107932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 02:22:50.109033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 02:22:50.112384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 02:22:50.112684) ========= ========= Total master_lag: 0.20 =========