builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1465463996.11 results: success (0) buildid: 20160608233033 builduid: 6ed1ef468a554f849a6e001d1fea6907 revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.105499) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.105948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.106226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.121377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.121864) ========= 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-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 02:19:56-- 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% 27.9M=0s 2016-06-09 02:19:56 (27.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.221008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.221360) ========= 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-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:56.271313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:19:56.271730) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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 f8bdceb55c9d191380176ab25e2385737bd9e1ab --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-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 02:19:56,417 truncating revision to first 12 chars 2016-06-09 02:19:56,417 Setting DEBUG logging. 2016-06-09 02:19:56,417 attempt 1/10 2016-06-09 02:19:56,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 02:19:57,398 unpacking tar archive at: fx-team-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:19:57.616693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:57.617020) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:57.617415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:57.617682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:57.629192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 02:19:57.629797) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:57 INFO - MultiFileLogger online at 20160609 02:19:57 in /builds/slave/test 02:19:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:19:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:57 INFO - {'append_to_log': False, 02:19:57 INFO - 'base_work_dir': '/builds/slave/test', 02:19:57 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:57 INFO - 'branch': 'Fx-Team', 02:19:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:57 INFO - 'config_files': ('talos/linux_config.py',), 02:19:57 INFO - 'default_actions': ('clobber', 02:19:57 INFO - 'read-buildbot-config', 02:19:57 INFO - 'download-and-extract', 02:19:57 INFO - 'populate-webroot', 02:19:57 INFO - 'create-virtualenv', 02:19:57 INFO - 'install', 02:19:57 INFO - 'run-tests'), 02:19:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:57 INFO - 'download_minidump_stackwalk': True, 02:19:57 INFO - 'download_symbols': 'ondemand', 02:19:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:57 INFO - 'installer_path': 'installer.exe', 02:19:57 INFO - 'log_level': 'info', 02:19:57 INFO - 'log_name': 'talos', 02:19:57 INFO - 'log_to_console': True, 02:19:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:57 INFO - 'opt_config_files': (), 02:19:57 INFO - 'pip_index': False, 02:19:57 INFO - 'sps_profile': False, 02:19:57 INFO - 'sps_profile_interval': 0, 02:19:57 INFO - 'suite': 'dromaeojs-e10s', 02:19:57 INFO - 'system_bits': '32', 02:19:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:57 INFO - 'title': 'talos-linux64-ix-016', 02:19:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:57 INFO - 'use_talos_json': True, 02:19:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:57 INFO - 'work_dir': 'build'} 02:19:57 INFO - ##### 02:19:57 INFO - ##### Running clobber step. 02:19:57 INFO - ##### 02:19:57 INFO - Running pre-action listener: _resource_record_pre_action 02:19:57 INFO - Running main action method: clobber 02:19:57 INFO - rmtree: /builds/slave/test/build 02:19:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:58 INFO - Running post-action listener: _resource_record_post_action 02:19:58 INFO - ##### 02:19:58 INFO - ##### Finished clobber step (success) 02:19:58 INFO - ##### 02:19:58 INFO - ##### 02:19:58 INFO - ##### Running read-buildbot-config step. 02:19:58 INFO - ##### 02:19:58 INFO - Running pre-action listener: _resource_record_pre_action 02:19:58 INFO - Running main action method: read_buildbot_config 02:19:58 INFO - Using buildbot properties: 02:19:58 INFO - { 02:19:58 INFO - "project": "", 02:19:58 INFO - "product": "firefox", 02:19:58 INFO - "script_repo_revision": "production", 02:19:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:19:58 INFO - "repository": "", 02:19:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:19:58 INFO - "buildid": "20160608233033", 02:19:58 INFO - "pgo_build": "True", 02:19:58 INFO - "basedir": "/builds/slave/test", 02:19:58 INFO - "buildnumber": 548, 02:19:58 INFO - "slavename": "talos-linux64-ix-016", 02:19:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:19:58 INFO - "platform": "ubuntu64_hw", 02:19:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:19:58 INFO - "branch": "fx-team", 02:19:58 INFO - "repo_path": "integration/fx-team", 02:19:58 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 02:19:58 INFO - "stage_platform": "linux64-pgo", 02:19:58 INFO - "builduid": "6ed1ef468a554f849a6e001d1fea6907", 02:19:58 INFO - "slavebuilddir": "test" 02:19:58 INFO - } 02:19:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:19:58 INFO - Running post-action listener: _resource_record_post_action 02:19:58 INFO - ##### 02:19:58 INFO - ##### Finished read-buildbot-config step (success) 02:19:58 INFO - ##### 02:19:58 INFO - ##### 02:19:58 INFO - ##### Running download-and-extract step. 02:19:58 INFO - ##### 02:19:58 INFO - Running pre-action listener: _resource_record_pre_action 02:19:58 INFO - Running main action method: download_and_extract 02:19:58 INFO - mkdir: /builds/slave/test/build/tests 02:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:58 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:19:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:00 INFO - Downloaded 1361 bytes. 02:20:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:00 INFO - Using the following test package requirements: 02:20:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'jsshell-linux-x86_64.zip'], 02:20:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:00 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:01 INFO - Downloaded 24451237 bytes. 02:20:01 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:20:01 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:20:03 INFO - Return code: 0 02:20:03 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:20:03 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:20:03 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:04 INFO - Downloaded 24451237 bytes. 02:20:04 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:20:04 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:20:06 INFO - Return code: 0 02:20:06 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:20:06 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:07 INFO - Downloaded 10833369 bytes. 02:20:07 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:20:07 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:20:07 INFO - Return code: 0 02:20: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:20:07 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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:20:09 INFO - Downloaded 59319784 bytes. 02:20:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:09 INFO - mkdir: /builds/slave/test/properties 02:20:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:09 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:09 INFO - Contents: 02:20:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:09 INFO - Running post-action listener: _resource_record_post_action 02:20:09 INFO - Running post-action listener: set_extra_try_arguments 02:20:09 INFO - ##### 02:20:09 INFO - ##### Finished download-and-extract step (success) 02:20:09 INFO - ##### 02:20:09 INFO - ##### 02:20:09 INFO - ##### Running populate-webroot step. 02:20:09 INFO - ##### 02:20:09 INFO - Running pre-action listener: _resource_record_pre_action 02:20:09 INFO - Running main action method: populate_webroot 02:20:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:09 INFO - '--tppagecycles', 02:20:09 INFO - '7'], 02:20:09 INFO - 'tests': ['tsvgm']}}, 02:20:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['damp', 'tps']}, 02:20:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'tests': ['damp', 'tps']}, 02:20:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['dromaeo_dom']}, 02:20:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['a11yr', 02:20:09 INFO - 'ts_paint', 02:20:09 INFO - 'tpaint', 02:20:09 INFO - 'sessionrestore', 02:20:09 INFO - 'sessionrestore_no_auto_restore', 02:20:09 INFO - 'tabpaint']}, 02:20:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['tsvgx', 02:20:09 INFO - 'tsvgr_opacity', 02:20:09 INFO - 'tart', 02:20:09 INFO - 'tscrollx', 02:20:09 INFO - 'cart']}, 02:20:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:09 INFO - 'tsvgr_opacity', 02:20:09 INFO - 'tart', 02:20:09 INFO - 'tscrollx', 02:20:09 INFO - 'cart']}, 02:20:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'talos_options': ['--disable-e10s'], 02:20:09 INFO - 'tests': ['tp5o']}, 02:20:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'tests': ['tp5o']}, 02:20:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'talos_options': ['--disable-e10s', 02:20:09 INFO - '--xperf_path', 02:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:09 INFO - 'tests': ['tp5n']}, 02:20:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:09 INFO - 'talos_options': ['--xperf_path', 02:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:09 INFO - 'tests': ['tp5n']}}, 02:20:09 INFO - 'talos.zip': {'path': '', 02:20:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:09 INFO - Running post-action listener: _resource_record_post_action 02:20:09 INFO - ##### 02:20:09 INFO - ##### Finished populate-webroot step (success) 02:20:09 INFO - ##### 02:20:09 INFO - ##### 02:20:09 INFO - ##### Running create-virtualenv step. 02:20:09 INFO - ##### 02:20:09 INFO - Running pre-action listener: _resource_record_pre_action 02:20:09 INFO - Running main action method: create_virtualenv 02:20:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:09 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:20:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:10 INFO - Using real prefix '/usr' 02:20:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:10 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:12 INFO - Installing pip.................done. 02:20:12 INFO - Return code: 0 02:20:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20: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:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:12 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:12 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:20:12 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:20:12 INFO - Using env: {'DISPLAY': ':0', 02:20:12 INFO - 'HOME': '/home/cltbld', 02:20:12 INFO - 'LANG': 'en_US.UTF-8', 02:20:12 INFO - 'LANGUAGE': 'en_US:en', 02:20:12 INFO - 'LOGNAME': 'cltbld', 02:20:12 INFO - 'MAIL': '/var/mail/cltbld', 02:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:12 INFO - 'MOZ_NO_REMOTE': '1', 02:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:12 INFO - 'NO_EM_RESTART': '1', 02:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:12 INFO - 'PWD': '/builds/slave/test', 02:20:12 INFO - 'SHELL': '/bin/bash', 02:20:12 INFO - 'SHLVL': '1', 02:20:12 INFO - 'TERM': 'linux', 02:20:12 INFO - 'TMOUT': '86400', 02:20:12 INFO - 'USER': 'cltbld', 02:20:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:12 INFO - '_': '/tools/buildbot/bin/python'} 02:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:12 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:20:12 INFO - Cleaning up... 02:20:12 INFO - Return code: 0 02:20:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20: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:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:12 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:12 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:20:12 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:20:12 INFO - Using env: {'DISPLAY': ':0', 02:20:12 INFO - 'HOME': '/home/cltbld', 02:20:12 INFO - 'LANG': 'en_US.UTF-8', 02:20:12 INFO - 'LANGUAGE': 'en_US:en', 02:20:12 INFO - 'LOGNAME': 'cltbld', 02:20:12 INFO - 'MAIL': '/var/mail/cltbld', 02:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:12 INFO - 'MOZ_NO_REMOTE': '1', 02:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:12 INFO - 'NO_EM_RESTART': '1', 02:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:12 INFO - 'PWD': '/builds/slave/test', 02:20:12 INFO - 'SHELL': '/bin/bash', 02:20:12 INFO - 'SHLVL': '1', 02:20:12 INFO - 'TERM': 'linux', 02:20:12 INFO - 'TMOUT': '86400', 02:20:12 INFO - 'USER': 'cltbld', 02:20:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:12 INFO - '_': '/tools/buildbot/bin/python'} 02:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:12 INFO - Downloading/unpacking psutil>=3.1.1 02:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:14 INFO - Installing collected packages: psutil 02:20:14 INFO - Running setup.py install for psutil 02:20:15 INFO - building 'psutil._psutil_linux' extension 02:20:15 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:20:15 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:20:15 INFO - building 'psutil._psutil_posix' extension 02:20:15 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:20:15 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:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:15 INFO - Successfully installed psutil 02:20:15 INFO - Cleaning up... 02:20:15 INFO - Return code: 0 02:20:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:15 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:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 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:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:15 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:20:15 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:20:15 INFO - Using env: {'DISPLAY': ':0', 02:20:15 INFO - 'HOME': '/home/cltbld', 02:20:15 INFO - 'LANG': 'en_US.UTF-8', 02:20:15 INFO - 'LANGUAGE': 'en_US:en', 02:20:15 INFO - 'LOGNAME': 'cltbld', 02:20:15 INFO - 'MAIL': '/var/mail/cltbld', 02:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:15 INFO - 'MOZ_NO_REMOTE': '1', 02:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:15 INFO - 'NO_EM_RESTART': '1', 02:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:15 INFO - 'PWD': '/builds/slave/test', 02:20:15 INFO - 'SHELL': '/bin/bash', 02:20:15 INFO - 'SHLVL': '1', 02:20:15 INFO - 'TERM': 'linux', 02:20:15 INFO - 'TMOUT': '86400', 02:20:15 INFO - 'USER': 'cltbld', 02:20:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:15 INFO - '_': '/tools/buildbot/bin/python'} 02:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:17 INFO - Installing collected packages: mozsystemmonitor 02:20:17 INFO - Running setup.py install for mozsystemmonitor 02:20:17 INFO - Successfully installed mozsystemmonitor 02:20:17 INFO - Cleaning up... 02:20:17 INFO - Return code: 0 02:20:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20: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:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:17 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:17 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:20:17 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:20:17 INFO - Using env: {'DISPLAY': ':0', 02:20:17 INFO - 'HOME': '/home/cltbld', 02:20:17 INFO - 'LANG': 'en_US.UTF-8', 02:20:17 INFO - 'LANGUAGE': 'en_US:en', 02:20:17 INFO - 'LOGNAME': 'cltbld', 02:20:17 INFO - 'MAIL': '/var/mail/cltbld', 02:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:17 INFO - 'MOZ_NO_REMOTE': '1', 02:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:17 INFO - 'NO_EM_RESTART': '1', 02:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:17 INFO - 'PWD': '/builds/slave/test', 02:20:17 INFO - 'SHELL': '/bin/bash', 02:20:17 INFO - 'SHLVL': '1', 02:20:17 INFO - 'TERM': 'linux', 02:20:17 INFO - 'TMOUT': '86400', 02:20:17 INFO - 'USER': 'cltbld', 02:20:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:17 INFO - '_': '/tools/buildbot/bin/python'} 02:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:18 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:18 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:20:18 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:20:18 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:20:18 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:20:18 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:20:18 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:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:19 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:20:19 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:20:19 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:20:19 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:20:19 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:20:19 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:20:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:20 INFO - warning: no files found matching '*.txt' 02:20:20 INFO - no previously-included directories found matching 'build' 02:20:20 INFO - no previously-included directories found matching 'dist' 02:20:20 INFO - no previously-included directories found matching '.git*' 02:20:20 INFO - Installing collected packages: jsonschema, functools32 02:20:20 INFO - Running setup.py install for functools32 02:20:20 INFO - warning: no files found matching '*.txt' 02:20:20 INFO - no previously-included directories found matching 'build' 02:20:20 INFO - no previously-included directories found matching 'dist' 02:20:20 INFO - no previously-included directories found matching '.git*' 02:20:20 INFO - Successfully installed jsonschema functools32 02:20:20 INFO - Cleaning up... 02:20:20 INFO - Return code: 0 02:20:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:20 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:20:20 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:20:20 INFO - Using env: {'DISPLAY': ':0', 02:20:20 INFO - 'HOME': '/home/cltbld', 02:20:20 INFO - 'LANG': 'en_US.UTF-8', 02:20:20 INFO - 'LANGUAGE': 'en_US:en', 02:20:20 INFO - 'LOGNAME': 'cltbld', 02:20:20 INFO - 'MAIL': '/var/mail/cltbld', 02:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:20 INFO - 'MOZ_NO_REMOTE': '1', 02:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:20 INFO - 'NO_EM_RESTART': '1', 02:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:20 INFO - 'PWD': '/builds/slave/test', 02:20:20 INFO - 'SHELL': '/bin/bash', 02:20:20 INFO - 'SHLVL': '1', 02:20:20 INFO - 'TERM': 'linux', 02:20:20 INFO - 'TMOUT': '86400', 02:20:20 INFO - 'USER': 'cltbld', 02:20:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:20 INFO - '_': '/tools/buildbot/bin/python'} 02:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:20 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:20 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:20:20 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:20:20 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:20:20 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:20:20 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:20:20 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:20:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:22 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:20:22 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:20:22 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:20:22 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:20:22 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:20:22 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:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:22 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:20:22 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:20:22 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:20:22 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:20:22 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:20:22 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:20:23 INFO - Downloading docopt-0.6.1.tar.gz 02:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:23 INFO - Running setup.py install for blobuploader 02:20:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:23 INFO - Running setup.py install for requests 02:20:23 INFO - Running setup.py install for docopt 02:20:23 INFO - Successfully installed blobuploader requests docopt 02:20:23 INFO - Cleaning up... 02:20:23 INFO - Return code: 0 02:20:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:23 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:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 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:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:23 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:20:23 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:20:23 INFO - Using env: {'DISPLAY': ':0', 02:20:23 INFO - 'HOME': '/home/cltbld', 02:20:23 INFO - 'LANG': 'en_US.UTF-8', 02:20:23 INFO - 'LANGUAGE': 'en_US:en', 02:20:23 INFO - 'LOGNAME': 'cltbld', 02:20:23 INFO - 'MAIL': '/var/mail/cltbld', 02:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:23 INFO - 'MOZ_NO_REMOTE': '1', 02:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:23 INFO - 'NO_EM_RESTART': '1', 02:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:23 INFO - 'PWD': '/builds/slave/test', 02:20:23 INFO - 'SHELL': '/bin/bash', 02:20:23 INFO - 'SHLVL': '1', 02:20:23 INFO - 'TERM': 'linux', 02:20:23 INFO - 'TMOUT': '86400', 02:20:23 INFO - 'USER': 'cltbld', 02:20:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:23 INFO - '_': '/tools/buildbot/bin/python'} 02:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:24 INFO - Running setup.py (path:/tmp/pip-xmT5fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:24 INFO - Running setup.py (path:/tmp/pip-fFk0j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:24 INFO - Running setup.py (path:/tmp/pip-dGWWS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:24 INFO - Running setup.py (path:/tmp/pip-Knhdwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:24 INFO - Running setup.py (path:/tmp/pip-ErKpel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:24 INFO - Running setup.py (path:/tmp/pip-CEDMR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:24 INFO - Running setup.py (path:/tmp/pip-XRRnRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:24 INFO - Running setup.py (path:/tmp/pip-v3D8JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:24 INFO - Running setup.py (path:/tmp/pip-O1J3f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:24 INFO - Running setup.py (path:/tmp/pip-G_Up0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:24 INFO - Running setup.py (path:/tmp/pip-TulwNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:24 INFO - Running setup.py (path:/tmp/pip-qC6MB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:24 INFO - Running setup.py (path:/tmp/pip-e5xc_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:25 INFO - Running setup.py (path:/tmp/pip-rG1ek7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:25 INFO - Running setup.py (path:/tmp/pip-86Xnsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:25 INFO - Running setup.py (path:/tmp/pip-JXVERR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:25 INFO - Running setup.py (path:/tmp/pip-YAtAbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:25 INFO - Running setup.py install for manifestparser 02:20:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Running setup.py install for mozcrash 02:20:25 INFO - Running setup.py install for mozdebug 02:20:25 INFO - Running setup.py install for mozdevice 02:20:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Running setup.py install for mozfile 02:20:25 INFO - Running setup.py install for mozhttpd 02:20:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Running setup.py install for mozinfo 02:20:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for mozInstall 02:20:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for mozleak 02:20:26 INFO - Running setup.py install for mozlog 02:20:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for moznetwork 02:20:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for mozprocess 02:20:26 INFO - Running setup.py install for mozprofile 02:20:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for mozrunner 02:20:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:26 INFO - Running setup.py install for mozscreenshot 02:20:26 INFO - Running setup.py install for moztest 02:20:26 INFO - Running setup.py install for mozversion 02:20:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:27 INFO - Cleaning up... 02:20:27 INFO - Return code: 0 02:20:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:27 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:27 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:20:27 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:20:27 INFO - Using env: {'DISPLAY': ':0', 02:20:27 INFO - 'HOME': '/home/cltbld', 02:20:27 INFO - 'LANG': 'en_US.UTF-8', 02:20:27 INFO - 'LANGUAGE': 'en_US:en', 02:20:27 INFO - 'LOGNAME': 'cltbld', 02:20:27 INFO - 'MAIL': '/var/mail/cltbld', 02:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:27 INFO - 'MOZ_NO_REMOTE': '1', 02:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:27 INFO - 'NO_EM_RESTART': '1', 02:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:27 INFO - 'PWD': '/builds/slave/test', 02:20:27 INFO - 'SHELL': '/bin/bash', 02:20:27 INFO - 'SHLVL': '1', 02:20:27 INFO - 'TERM': 'linux', 02:20:27 INFO - 'TMOUT': '86400', 02:20:27 INFO - 'USER': 'cltbld', 02:20:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:27 INFO - '_': '/tools/buildbot/bin/python'} 02:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:27 INFO - Running setup.py (path:/tmp/pip-97Ibe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:27 INFO - Running setup.py (path:/tmp/pip-ooXEoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:27 INFO - Running setup.py (path:/tmp/pip-1JA6Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:27 INFO - Running setup.py (path:/tmp/pip-54Xrts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:27 INFO - Running setup.py (path:/tmp/pip-y60vjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:27 INFO - Running setup.py (path:/tmp/pip-ILMh0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:27 INFO - Running setup.py (path:/tmp/pip-l_6mqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:27 INFO - Running setup.py (path:/tmp/pip-Z8Q88E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:27 INFO - Running setup.py (path:/tmp/pip-rsiqK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:27 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:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:27 INFO - Running setup.py (path:/tmp/pip-ttviZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:28 INFO - Running setup.py (path:/tmp/pip-ZsIx2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:28 INFO - Running setup.py (path:/tmp/pip-GX65UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:28 INFO - Running setup.py (path:/tmp/pip-44a7zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:28 INFO - Running setup.py (path:/tmp/pip-y9QCXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:28 INFO - Running setup.py (path:/tmp/pip-hzOHXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:28 INFO - Running setup.py (path:/tmp/pip-KYiB3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:28 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:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:28 INFO - Running setup.py (path:/tmp/pip-A_LSHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:30 INFO - Downloading blessings-1.6.tar.gz 02:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:30 INFO - Installing collected packages: blessings 02:20:30 INFO - Running setup.py install for blessings 02:20:30 INFO - Successfully installed blessings 02:20:30 INFO - Cleaning up... 02:20:30 INFO - Return code: 0 02:20:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:30 INFO - Reading from file tmpfile_stdout 02:20:30 INFO - Current package versions: 02:20:30 INFO - argparse == 1.2.1 02:20:30 INFO - blessings == 1.6 02:20:30 INFO - blobuploader == 1.2.4 02:20:30 INFO - docopt == 0.6.1 02:20:30 INFO - functools32 == 3.2.3-2 02:20:30 INFO - jsonschema == 2.5.1 02:20:30 INFO - manifestparser == 1.1 02:20:30 INFO - mozInstall == 1.12 02:20:30 INFO - mozcrash == 0.17 02:20:30 INFO - mozdebug == 0.1 02:20:30 INFO - mozdevice == 0.48 02:20:30 INFO - mozfile == 1.2 02:20:30 INFO - mozhttpd == 0.7 02:20:30 INFO - mozinfo == 0.9 02:20:30 INFO - mozleak == 0.1 02:20:30 INFO - mozlog == 3.2 02:20:30 INFO - moznetwork == 0.27 02:20:30 INFO - mozprocess == 0.22 02:20:30 INFO - mozprofile == 0.28 02:20:30 INFO - mozrunner == 6.11 02:20:30 INFO - mozscreenshot == 0.1 02:20:30 INFO - mozsystemmonitor == 0.3 02:20:30 INFO - moztest == 0.7 02:20:30 INFO - mozversion == 1.4 02:20:30 INFO - psutil == 3.1.1 02:20:30 INFO - requests == 1.2.3 02:20:30 INFO - wsgiref == 0.1.2 02:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 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 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:30 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:20:30 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:20:30 INFO - Using env: {'DISPLAY': ':0', 02:20:30 INFO - 'HOME': '/home/cltbld', 02:20:30 INFO - 'LANG': 'en_US.UTF-8', 02:20:30 INFO - 'LANGUAGE': 'en_US:en', 02:20:30 INFO - 'LOGNAME': 'cltbld', 02:20:30 INFO - 'MAIL': '/var/mail/cltbld', 02:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:30 INFO - 'MOZ_NO_REMOTE': '1', 02:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:30 INFO - 'NO_EM_RESTART': '1', 02:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:30 INFO - 'PWD': '/builds/slave/test', 02:20:30 INFO - 'SHELL': '/bin/bash', 02:20:30 INFO - 'SHLVL': '1', 02:20:30 INFO - 'TERM': 'linux', 02:20:30 INFO - 'TMOUT': '86400', 02:20:30 INFO - 'USER': 'cltbld', 02:20:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:30 INFO - '_': '/tools/buildbot/bin/python'} 02:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 INFO - Cleaning up... 02:20:31 INFO - Return code: 0 02:20:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:31 INFO - Using env: {'DISPLAY': ':0', 02:20:31 INFO - 'HOME': '/home/cltbld', 02:20:31 INFO - 'LANG': 'en_US.UTF-8', 02:20:31 INFO - 'LANGUAGE': 'en_US:en', 02:20:31 INFO - 'LOGNAME': 'cltbld', 02:20:31 INFO - 'MAIL': '/var/mail/cltbld', 02:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:31 INFO - 'MOZ_NO_REMOTE': '1', 02:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:31 INFO - 'NO_EM_RESTART': '1', 02:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:31 INFO - 'PWD': '/builds/slave/test', 02:20:31 INFO - 'SHELL': '/bin/bash', 02:20:31 INFO - 'SHLVL': '1', 02:20:31 INFO - 'TERM': 'linux', 02:20:31 INFO - 'TMOUT': '86400', 02:20:31 INFO - 'USER': 'cltbld', 02:20:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:31 INFO - '_': '/tools/buildbot/bin/python'} 02:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:31 INFO - Cleaning up... 02:20:31 INFO - Return code: 0 02:20:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f396fbdcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, '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-1465463995.596697-41213578', '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:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:20:31 INFO - Using env: {'DISPLAY': ':0', 02:20:31 INFO - 'HOME': '/home/cltbld', 02:20:31 INFO - 'LANG': 'en_US.UTF-8', 02:20:31 INFO - 'LANGUAGE': 'en_US:en', 02:20:31 INFO - 'LOGNAME': 'cltbld', 02:20:31 INFO - 'MAIL': '/var/mail/cltbld', 02:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:31 INFO - 'MOZ_NO_REMOTE': '1', 02:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:31 INFO - 'NO_EM_RESTART': '1', 02:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:31 INFO - 'PWD': '/builds/slave/test', 02:20:31 INFO - 'SHELL': '/bin/bash', 02:20:31 INFO - 'SHLVL': '1', 02:20:31 INFO - 'TERM': 'linux', 02:20:31 INFO - 'TMOUT': '86400', 02:20:31 INFO - 'USER': 'cltbld', 02:20:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:31 INFO - '_': '/tools/buildbot/bin/python'} 02:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:31 INFO - Downloading/unpacking flake8 02:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:33 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:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:34 INFO - no previously-included directories found matching 'docs/_build' 02:20:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:34 INFO - Running setup.py install for pep8 02:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:34 INFO - no previously-included directories found matching 'docs/_build' 02:20:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:34 INFO - Cleaning up... 02:20:34 INFO - Return code: 0 02:20:34 INFO - Running post-action listener: _resource_record_post_action 02:20:34 INFO - Running post-action listener: _start_resource_monitoring 02:20:34 INFO - Starting resource monitoring. 02:20:34 INFO - ##### 02:20:34 INFO - ##### Finished create-virtualenv step (success) 02:20:34 INFO - ##### 02:20:34 INFO - ##### 02:20:34 INFO - ##### Running install step. 02:20:34 INFO - ##### 02:20:34 INFO - Running pre-action listener: _resource_record_pre_action 02:20:34 INFO - Running main action method: install 02:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:34 INFO - Reading from file tmpfile_stdout 02:20:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:34 INFO - Reading from file tmpfile_stdout 02:20:34 INFO - Output received: 02:20:34 INFO - Usage: mozinstall [options] installer 02:20:34 INFO - Options: 02:20:34 INFO - -h, --help show this help message and exit 02:20:34 INFO - -d DEST, --destination=DEST 02:20:34 INFO - Directory to install application into. [default: 02:20:34 INFO - "/builds/slave/test"] 02:20:34 INFO - --app=APP Application being installed. [default: firefox] 02:20:34 INFO - mkdir: /builds/slave/test/build/application 02:20:34 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:20:34 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:20:51 INFO - Reading from file tmpfile_stdout 02:20:51 INFO - Output received: 02:20:51 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:51 INFO - Running post-action listener: _resource_record_post_action 02:20:51 INFO - ##### 02:20:51 INFO - ##### Finished install step (success) 02:20:51 INFO - ##### 02:20:51 INFO - ##### 02:20:51 INFO - ##### Running run-tests step. 02:20:51 INFO - ##### 02:20:51 INFO - Running pre-action listener: _resource_record_pre_action 02:20:51 INFO - Running main action method: run_tests 02:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:51 INFO - Python 2.7.3 02:20:51 INFO - Return code: 0 02:20:51 INFO - grabbing minidump binary from tooltool 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:51 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 0x246f010>, '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 0x246fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24703a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:51 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:20:51 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:20:51 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:20:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:51 INFO - Return code: 0 02:20:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:20:52 INFO - Return code: 0 02:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:20:52 INFO - Using env: {'DISPLAY': ':0', 02:20:52 INFO - 'HOME': '/home/cltbld', 02:20:52 INFO - 'LANG': 'en_US.UTF-8', 02:20:52 INFO - 'LANGUAGE': 'en_US:en', 02:20:52 INFO - 'LOGNAME': 'cltbld', 02:20:52 INFO - 'MAIL': '/var/mail/cltbld', 02:20:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:52 INFO - 'MOZ_NO_REMOTE': '1', 02:20:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:52 INFO - 'NO_EM_RESTART': '1', 02:20:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:52 INFO - 'PWD': '/builds/slave/test', 02:20:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:52 INFO - 'SHELL': '/bin/bash', 02:20:52 INFO - 'SHLVL': '1', 02:20:52 INFO - 'TERM': 'linux', 02:20:52 INFO - 'TMOUT': '86400', 02:20:52 INFO - 'USER': 'cltbld', 02:20:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465463995.596697-41213578', 02:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:52 INFO - '_': '/tools/buildbot/bin/python'} 02:20:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:20:52 INFO - mozversion application_buildid: 20160608233033 02:20:52 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:20:52 INFO - mozversion application_display_name: Nightly 02:20:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:52 INFO - mozversion application_name: Firefox 02:20:52 INFO - mozversion application_remotingname: firefox 02:20:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:52 INFO - mozversion application_vendor: Mozilla 02:20:52 INFO - mozversion application_version: 50.0a1 02:20:52 INFO - mozversion platform_buildid: 20160608233033 02:20:52 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:20:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:52 INFO - mozversion platform_version: 50.0a1 02:20:52 INFO - using testdate: 1465464052 02:20:52 INFO - actual date: 1465464052 02:20:52 INFO - starting webserver on 'localhost:39410' 02:20:52 INFO - SUITE-START | Running 2 tests 02:20:52 INFO - TEST-START | dromaeo_css 02:20:52 INFO - operating with platform_type : linux_ 02:20:52 INFO - Initialising browser for dromaeo_css test... 02:20:52 INFO - TEST-INFO | started process 25637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb87HBQ/profile http://localhost:39410/getInfo.html) 02:20:57 INFO - PROCESS | 25637 | __metrics Screen width/height:1600/1200 02:20:57 INFO - PROCESS | 25637 | colorDepth:24 02:20:57 INFO - PROCESS | 25637 | Browser inner width/height: 1024/697 02:20:57 INFO - PROCESS | 25637 | __metrics 02:20:58 ERROR - PROCESS | 25637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:20:58 INFO - TEST-INFO | 25637: exit 0 02:20:58 INFO - Browser initialized. 02:20:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:58 INFO - TEST-INFO | started process 25759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb87HBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:10 INFO - PROCESS | 25759 | RSS: Main: 167649280 02:21:10 INFO - PROCESS | 25759 | 02:22:00 INFO - PROCESS | 25759 | 1465464120392 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:24:08 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39410/tests/dromaeo/cssquery-ext.html) 02:24:10 INFO - PROCESS | 25759 | RSS: Main: 170917888 02:24:10 INFO - PROCESS | 25759 | 02:27:12 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-ext.html (next: http://localhost:39410/tests/dromaeo/cssquery-jquery.html) 02:27:12 INFO - PROCESS | 25759 | RSS: Main: 170127360 02:27:12 INFO - PROCESS | 25759 | 02:30:14 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39410/tests/dromaeo/cssquery-mootools.html) 02:30:15 INFO - PROCESS | 25759 | RSS: Main: 171524096 02:30:15 INFO - PROCESS | 25759 | 02:33:17 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39410/tests/dromaeo/cssquery-prototype.html) 02:33:17 INFO - PROCESS | 25759 | RSS: Main: 169291776 02:33:17 INFO - PROCESS | 25759 | 02:36:20 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39410/tests/dromaeo/cssquery-yui.html) 02:36:20 INFO - PROCESS | 25759 | RSS: Main: 171470848 02:36:20 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | Cycle 1(1): loaded http://localhost:39410/tests/dromaeo/cssquery-yui.html (next: http://localhost:39410/tests/dromaeo/cssquery-dojo.html) 02:39:23 INFO - PROCESS | 25759 | RSS: Main: 172511232 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | __start_tp_report 02:39:23 INFO - PROCESS | 25759 | _x_x_mozilla_page_load 02:39:23 INFO - PROCESS | 25759 | _x_x_mozilla_page_load_details 02:39:23 INFO - PROCESS | 25759 | |i|pagename|runs| 02:39:23 INFO - PROCESS | 25759 | |0;dojo.html;3183.315587148763;3205.727513161381;3235.530848027036;3237.2068843133434;3257.560229369036;5402.702851343174;5428.050091234038;5436.945630543693;5524.944750552493;5536.861578460541;5447.645903016301;5480.6437581557275;5481.314835645544;5499.120140777476;5522.5581953443725;4965.553100220979;4998.425181104165;5033.270175824503;5132.640715149941;5145.151050076752;5034.949650503503;5164.586833053347;5202.583793296527;5203.869903252411;5208.192730126836;4969.503049695019;4984.925226121611;5016.423111342187;5018.648694591362;5025;5025.572826309768;5027.522385373383;5027.723475208862;5032.924506132411;5083.6441449098575;4986.052649996525;4994.05113028527;5012.774425150877;5020.953821957234;5035.924461133086;5374.274472946141;5394.865128371822;5414.160805075219;5438.945610543883;5440.374356948962;5928.347881733006;5970.6716130612795;5972.581919265654;5977.7608895644125;5982.401759824026;5751.654900705971;5774.335951365605;6033.788817391414;6054.091886217103;6057.727402266909;5527.060399732055;5566.638168519034;5571.804986825442;5597.384287728347;5610.38285788567;6111.205543279345;6119.816405507842;6127.754889804358;6129.693515324216;6130.6628135452975;5670.829875103754;5779.768809247667;5833.708314584339;5858.677772722541;5861.443162899518;5858.736356863951;5952.494038006731;5966.522678185735;5986.431289027535;5987.6108052976415;5693.259876216065;5744.368119506851;5752.856178595569;5881.735321910524;5928.466438020599;5781.653100813965;5785.681787501644;5843.24037875082;5846.356900740915;5900.616459930091;4430.42404487421;4478.932816007762;4497.2129877271345;4508.954910450919;4556.612687921497;3929.174873276587;3951.8024098794945;3958.4062390641634;3999.6400323970984;4006.4390985262085;5600.6919619420505;5604.635698679573;5630.60585758993;5633.887322253614;5643.915341269884;5696.231008813757;5899.852503687356;5987.970060149672;6003.579749417586;6015.097735339734;5550.777968881281;5586.35756887955;5604.075327570987;5640.407757185437;5645.887082258332;5117.820876269313;5133.332666753298;5135.8172776570555;5136.845894623168;5208.947910520922;5961.374055724174;6032.819015429544;6042.093685947055;6181.289151747516;6193.256809182927;5866.50134738552;5897.144913987534;5916.290045194432;5957.344692083954;5994.130851026664;6075;6095.603785753912;6122.785702500391;6125.816225513242;6125.927962606437;5688.857778555569;5784.913226301693;5849.736761845812;5851.912221316598;5857.765689372548;5966.671833049224;5975.641461512323;5994.790182343597;6056.121862330026;6108.8778224436155;5741.196232527366;5808.5353171747;5810.273715785527;5835.44563266489;5861.296644402699;5606.046972014686;5756.510696590837;5773.422657734193;5865.970670146622;5867.061270196748;5704.916065947456;5715.8571035724435;5732;5733;5781.132830075522;5841.007028805198;5853.560982926212;5860.179574859609;5863;5882.911756323573;5523.447655234444;5650.63270887391;5684.147377893349;5722.685252311163;5733.254676891977 02:39:23 INFO - PROCESS | 25759 | |1;ext.html;571.1632458448372;624.9531285153614;646.5021933111507;646.5409559212959;660.8182749743822;36861.447078293844;42728.504502342425;42851.78574107125;43094.13811723768;43128.56871431289;42815.14369712604;43029.7848510757;43506.7824660877;43625.127497450034;43831;8574.528400937947;8813.206811386974;8864.556772161399;8879.51162686052;8888.644454221823;8690.130986901291;8734.912650873473;8829.911700882973;8836.42563233391;8836.46981181128;8727.60725767342;8783.429077109968;8795.164459376349;8823.338249631272;8850.955745221265;8754.124587541195;8760.12398760122;8803.515806630632;8805.867911981326;8814.515201663906;8625.309975202032;8671.21959023691;8686.739397818075;8697.869531957025;8704.608292626785;39951.40072898909;40280.798596007124;40471.79764101161;40498.190036199405;40510.18979620391;3491.17957280039;3645.890623281279;3787.280416720814;4169.145325208325;4384.188925048876;30661;31901.680983190105;32373.190670233198;32725.18187045343;33608.15979600505;4329.805158767863;4410.404595379615;4429.003474218307;4482.6413886889295;4554.7039442436135;352770;353458;355388;356391;357373;34471.65528344735;35069.298614027575;35124.82437587847;60406.697966509884;60423.697881510314;37272;37830.81084594559;37912;37933.24133517369;37940.43089353662;15538.145402002998;15844.683106337809;15852.68294634124;15853.841461585236;15917.602059948362;12246.081543884244;12351.876481235253;12391.814122788166;12407.875921240671;12415;8361;8447.873281900776;8458.957705211435;8501.44740591872;8533.74398768038;3232.3696879108347;3261.2662151015834;3271.492918597621;3309.4373956427467;3314.0720598232533;944.8582712593029;1009.8990100989989;1032.5921261101823;1057.9947100264449;1087.1954753482523;31417.528737068962;31625.20936976594;31835.20411989719;32198.35603287968;32746.836265818518;1117.7373317270435;1180.5513904716154;1210.8002179640437;1226.2029680707433;1229.9385030748426;16680.916595416944;16975.575610609834;16999.150042497826;17027;17058;629197;640772;641465;642689;646204;41081;42249.36625950613;58499.41500585025;58716.412835871946;58955.705221474476;1373.979390309146;1384.5707830572353;1388.2850332078988;1400;1405.6485878530368;29888.55167172451;30754.692453076077;31004.379912401175;31375.84312078425;31722.20694482564;51152;51357.743211283705;51979.74010129925;51989;52098.73950630374;487680;490147;491215;493980;495259;25794.61308080343;28576.85711571512;28746.281342966595;28788.280292992844;28856.99000535055;48967.21376782789;49971.25043124429;50206.748966254934;50224;50599.241011384125;40430.59569404386;41821;42026;42183.578164217965;42602.57397425986;39118.413223802236;41141.382879257435;41669.79165104276;41962;42068.78965605152;36707.44938825973;40228.19543609053;40307.395389069774;40604.39093413542;40821.18357632771;35389.46915796317;38122.23755524818;38259.80870095632;38765.41851872168;39011;28422.289442764097;28724;28937.276568085967;28982;29155 02:39:23 INFO - PROCESS | 25759 | |2;jquery.html;382.95404551453845;387.9003026420099;389.56952567413015;395.7941870227482;412.8967758060485;13816.654583635414;18724.344647937323;18727.4381768547;19328.420147395584;19432.028398580067;17938.10309484527;18351;18365.632687346246;18534.0732963352;18612;4919.188333924898;5446.782128714846;5588.329400471949;5597.244372009767;5607.355154157283;5518.558515318765;5521.668699878;5562.443755624426;5596.58025648076;5596.58025648076;5279.604029697769;5455.509004189622;5497.422770609089;5508.7521061552325;5520.613557051008;5486.506214440699;5497.47773961473;5507.972460137694;5513.062779327524;5517.613767036309;4742.288656701522;4868.269759536062;4939.580135688435;4955.157623204064;4960.900781984376;21225.257116000867;21983.450413739785;22123.668144977837;22246.777532224794;22265.332040038826;2188.9014994325134;2350.17743789674;2543.300592337104;2653.4162484253434;2926.75122614578;13703.588892333146;14045.71908561823;14166;14245;14464.132152070804;1934.1489744512369;1969.5863868587614;1979.5644958109192;1980.5048737815546;1985.9404217873343;77948.22051779466;82529.58735206345;83160;83574.58212708897;84194.15805841924;10066.345687530433;10161.949190254001;10197.898021019695;10261.127804136731;10601.575936962436;14251.928740356232;14316.355763990645;14325.35535900887;14422.206778627276;14429.639259018399;7628.504147230412;7769.53382797034;7821.608919554;7977.2022797719765;7987.281144696889;7547.358474529617;7614.581198034161;7646.3882889368715;7709.614519274014;7740.187280335484;6341.365863413714;6343.714532846033;6439.967800160969;6444.162258906312;6463.15978922737;1905.3712274949235;1919.2227148005081;1928.594995051027;1965.2040923426036;1985.057097878496;919.2554031234588;962.2061799015839;1009.5759780892043;1041.422010784007;1090.6019302954523;17890.821091788916;18632.906835465736;19032.52418689516;19080.236790528503;19093.427197184108;999.7350702063959;1054.314695447965;1067.199600299775;1070.6948519671855;1088.9727756806144;10630.415327157081;10977.560897564008;10995.670129896116;11029.503672334764;11073.172926467043;492590;503485;504954;510967;521471;82620;84540.15459845446;85182;85505.14494854971;87209;1021.3973755484151;1062.4369084385135;1075.7633320669597;1096.2928910852456;1101.5098281264761;16004.599885002968;16205.837941620433;16353.591160221089;16514.917425412797;16578.668426631157;39414.80292598519;41997.580024199364;42171.7891410541;43656.12687746164;46621;57044;57904;59318;61004;62790;11974.22167559106;12465.62878083392;12540.749185016066;12698.682532936751;12793.552225672056;13117.278549679477;13600.319984000958;13655.453781849012;13765.38055787472;13791.241481718602;11519.136064795006;11694.181407301407;11975.341356225492;11988.46051927648;12188.634340969431;11122.777544448903;11850;11985.28088314704;12117.69705757363;12330.876691232972;11955.462004209658;11970.521179152736;11979.04167666602;11994.700132496757;12227.327496987751;12558.246505209716;12779.680507987374;12840.935795320964;12870.356482175666;12874.935625321814;11753.47109380097;11792.76414471723;11810;11828.23116497425;11881 02:39:23 INFO - PROCESS | 25759 | |3;mootools.html;1462.1592584264051;1520;1638.3119089982206;1762.2950819672137;1764.664713704397;7764.456488045825;8105.554194519299;8408.57957102144;8867.201951824334;8894.421862578936;8509.744707658765;8710.60802263898;8766.912330876688;8800.735977920673;8807.603657835396;2335.100986120339;2356.7761062699014;2357.799587035104;2361.055577768889;2367.8579285242854;2310.1452462588863;2323.314622186459;2326.1044497868356;2341.379534423371;2348.1077190667525;2293.841609986954;2307.0541078157958;2310.27226423676;2330.7669233076726;2341.028473183627;2269.6708977198296;2285.611446054175;2290.03818396274;2302.689136966505;2314.4792421705065;2346.9295921122393;2360.280114565057;2361.716594008713;2369.57347677418;2371.5256948610345;8755.781105472413;8811.471311721318;8821.955890220572;8872.955635221848;8879.51162686052;5115.820946266863;5225.4513276105845;5292.788288468457;5303.761330740126;5349.812756553541;3315.8673653053847;3423.1442139465134;3454.2055327274866;3502.124468882779;3508.28080243552;1103.7406209540752;1110.8111621024445;1115.760111576007;1136.2671077155271;1140.5209811878947;12214.938925305316;12220;12229.816552751716;12236.99999999991;12243.265404075784;4534.36518887356;4575.542445755398;4649.721016739007;4680.906381872412;4686.343911852344;10375.584976600852;10399;10411.635592754217;10426.957304269512;10450.059494645518;5273.077211487975;5282.550983166474;5312.92030619541;5313.0967735485065;5325.440828713007;4022.4368588397647;4486.573775491323;4615;4663.347131401607;4926.187179115406;3903.2388684206876;3940.0937784309767;4011.338129208706;4020.8994775130855;4058.918821623551;1248.2011512631923;1273.1533530202496;1273.1724379153625;1290.7160424706549;1290.7418516296777;1025.1747343388645;1030.5620111452602;1032.9896701033044;1037.8131936251395;1044.3211912257093;6090.451859332593;6136.386361363917;6139.785107521305;6187.3503282155625;6272.6236425814595;457.154264610468;462.5836746927792;464.4496271917788;467.5231264110588;476.7735325720255;4136.276151673445;4169.91660166795;4248.235317642854;4264.57354264571;4326.58897404746;10629.574817007233;10833.620823271147;10890.509927053301;10983.286086404518;10998.505067271992;10597.25819192649;10614.12040253275;10747.247692661595;10768.892311076946;10824.350538967687;8090.393220508367;8215.507069575844;8254.42219044673;8284.668613255522;8319.084900660922;5878.382769809108;5986.102084687158;6029;6064.696090340598;6127.387261273837;9661.372010819274;9910.207183425453;9963.701088967342;9979.950100249453;10006.949965250418;10017.348872323568;10143.492825358555;10155.695329140137;10187.7453063674;10476.842847357144;7214.422846172399;7435.591042492499;7645;7991.560464174526;8162.347012239125;8444.197801208875;8532.530710810965;8537.402381833212;8568.742937711879;8619.396642234984;7472;7732.7680169595005;7792.6103694816165;7794.025746781653;7804.921950780419;7472.103347598323;7585.16563178061;7590.7722768317035;7629.16079231273;7785.961070194613;6616.040674102132;6620.304867988792;6664.333566643297;6684.598924064571;6718.126643536309;4847.200211965127;5056.266841307916;5075.390953085654;5157.793688252428;5167.354080739908;5087.211482220262;5195.606319895;5255.421903590525;5255.500727430888;5281.841544753664 02:39:23 INFO - PROCESS | 25759 | |4;prototype.html;332.64407084419673;333.8347517978601;338.82381161795865;342.9794212347258;344.3749594486009;5626.746796394157;5667.461591148839;5671.468703450066;5689.715514224293;5697.259356283683;5548.389677135522;5600.08795426378;5614.242077319561;5617.185508101323;5634.464725851048;4156.438880751098;4163.812628431712;4274.059706864485;4314.223439780838;4329.675274354436;4293.635041021517;4319.287317592609;4324.935125973113;4328.156009578133;4348.434703488542;4314.762688052156;4324.654027677778;4324.805383757723;4333.263345231318;4339.717918335314;4049.2711311963835;4249.6387807036435;4251.319788833772;4272.722273052242;4330.004099057219;3700.4079347304573;3724.832382542792;3728.12389088564;3749.550053993511;3756.455313979485;5324.41431442541;5369.691032855871;5382.9730851345885;5387.892242155174;5433.755481003364;4712.481627021025;4920.926186107211;4936.950630493721;4944;4985.376827896513;5755.165501002373;5777.653340799566;5810.709464526757;5844.298684157886;5856.76572937082;4157.667386609094;4158.750474971512;4168.083021735213;4172.436721042651;4184.602462766033;5860;6032.547558933097;6060.636361818261;6111.51107911366;6112.755489780404;4210.452641156691;4222.59885310895;4230.302000169999;4237.851675191354;4241.300185469363;4257.531671516131;4267.25323068468;4284.742915425085;4313.97843010783;4330.588594083557;4648.140094082605;4925.852224433273;4949.589367030379;4953.612988363264;4970.428400733962;5858.677772722541;5882.705864706748;5902.760420311697;5922.555808314393;5961.940380596138;1475.9409623614936;1488.7866388893017;1492.544773843988;1497.7678459838742;1498.9850101499064;950.6530116507425;964.6430820596424;976.7069879036261;1011.6155860773007;1019.2915923433291;5520.309961254843;5556.833295001156;5572.916406253909;5590;5591.524720398812;5952.422608008881;6010.025037606413;6030.33666296707;6039.124326972565;6071.150038994544;5388.91916621251;5626.521745651666;5631.633943793722;5738.426157384228;5773.364929857712;3249.3988612106837;3251.902442926716;3254;3287.3096649703352;3304.2069903223532;6141.232345956755;6281.371862813773;6283.842903927439;6307.148534947723;6393.712282947278;6215.228659831926;6230.376962303733;6241.875162496724;6242.250929888442;6246.718897649616;6092.51259899207;6279.780207692709;6281.277653069956;6316.757551069396;6321.3678632137335;6038;6042.154098426312;6072;6092.573519853568;6109.84725381869;6014.609050411709;6047.637141771508;6050.304215015153;6055.818325450244;6096.420840020191;6039.63762174271;6278.874422511615;6290.24517057956;6305.684715764101;6314.463270622048;4221.68337374692;4243.618074373321;4248.723832950848;4249.638780703551;4269.743815371087;5891.852703682443;5993.340732519507;6155.446009858955;6169.56813023102;6176.598521096114;5800.274965629296;5906.911396328973;5919.792807251725;5938.277899409123;5941.702914854153;5836.241288632451;5888.381719919518;5894.145348924296;5895.9115613266695;5900.082473196314;5547.667139971614;5762.5389968801555;5776.335721392094;5796.101604251347;5810.389909059657;5849.899553236792;5891.882162356815;5906.734196961061;5977.505623594101;6009.819705408845;5693;5714.685692286964;5792.8551786204;5795.536357091507;5851.356350801493 02:39:23 INFO - PROCESS | 25759 | |5;yui.html;703.1386551474444;735.1105162753068;802.0230132722837;802.5906787538361;808.2402541610884;15750.92124539377;16467.423640172598;16618.086005269735;16738.83261167388;16740.49778506645;14814.851851481482;15056.924715376408;15108.320125594348;15166.090034597932;15248.847511524882;667.5894324990132;784.3137254901961;796.3350602247131;805.2068712318362;808.107041718898;788.692409960116;796.5977181523351;797.5055465611329;801.5591424716412;802.33005440457;854.1970547685156;856.6230858422306;856.8372009318209;857.9613917373701;858.9785255368603;848.2577744473585;849.3078141314809;852.6759831264142;852.7527017165046;855.5209082913526;614.3917521653575;617.7837756785134;618.3383779356091;620.1256228717486;623.5603899251017;15155.242237888062;15226.46707365237;15243.771343429857;15304.693906121927;15328.616784580363;13250.933745331211;13304.73390532184;13560.186388816604;15626.374945002186;15665.21673916311;12804.295763732991;12952.611421657366;13049.238352822342;13233.272170030645;13927.094738841943;4426.535213802536;4474.6420286377015;4497.100579884036;4535.523770004168;4571.771411429415;74431;74992.62503687502;75444.24555754427;76669.61665191693;76701.61649191774;11240.437978101227;11275.605353812742;11439.771204575862;11477.139214558942;11567.248128871597;20808.47978800512;20828.791712082686;20832.687509687366;20910.268140615004;20999.895000525205;8967.910320896837;9020.594073266719;9050.637974481078;9189.3108016899;9190.632374704937;4850.175470170079;4869.293952376956;4887.877803054952;4899.3385892904;4992.700437973734;3577.499150118985;3682.8158592070827;3691.483192353073;3708.8331025103935;3709.3137769512186;643.8615697625033;644.3620815392821;654.6759354119741;661.632793799446;663.9468842492686;667.8163505036154;671.4863129705778;741.4402126394646;750.7297372945735;778.505648912933;9481.194098501566;9483.668071617598;9855.852162217572;9872.950635246778;9960.601575936882;718.4755128755933;762.6121451942012;767.8387538616842;774.1832366852911;780.9258120478545;4196.160767846443;4211.220924129046;4247.426597409372;4281.636060934793;4319;103721;107674.46162769136;109676;111317;112987.43506282417;75310.62344688241;95823;95844.52077739566;95998.52000739952;96292.51853740687;52038;85565.57217213999;86320.56839715887;89245;89627.65558516627;9169.174774270348;9179.954100229455;9249.398789078688;9300.627974880928;9311.706782827543;49988.25017624811;50068.24897626611;50591.49408505868;51664.74167629138;52576.474235257156;52362;75640.62179689066;76340;77351.61324193569;78273.60863195875;12331.876681233072;12579.496820127459;12673.176243544509;12872.16330938486;12953.287569183785;13609;13621;13968.930155349159;14104.224267665377;14118.78821817653;12656.6835829105;13051.151675141085;13317.667058323232;13517.391717372939;13555.728885422039;12381.75236495247;12407.447057476202;12548.811767823307;12796.488140474277;12873.163244389085;12124.454399551865;13020.934895325463;13273.070885038342;13298.135621184592;13312.733745324846;10653.840192396965;10929.508172132115;10945.671629851116;10947.397893115636;11286.322820630789;9637.71086867395;10265.84601230997;10531.684049478528;10687.51906164209;10773.245872789143 02:39:23 INFO - PROCESS | 25759 | __end_tp_report 02:39:23 INFO - PROCESS | 25759 | __start_cc_report 02:39:23 INFO - PROCESS | 25759 | _x_x_mozilla_cycle_collect,358 02:39:23 INFO - PROCESS | 25759 | __end_cc_report 02:39:23 INFO - PROCESS | 25759 | __startTimestamp1465465163621__endTimestamp 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | ------- Summary: start ------- 02:39:23 INFO - PROCESS | 25759 | Number of tests: 6 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#0] dojo.html Cycles:165 Average:5496.54 Median:5696.23 stddev:627.73 (11.0%) stddev-sans-first:602.86 02:39:23 INFO - PROCESS | 25759 | Values: 3183.3 3205.7 3235.5 3237.2 3257.6 5402.7 5428.1 5436.9 5524.9 5536.9 5447.6 5480.6 5481.3 5499.1 5522.6 4965.6 4998.4 5033.3 5132.6 5145.2 5034.9 5164.6 5202.6 5203.9 5208.2 4969.5 4984.9 5016.4 5018.6 5025.0 5025.6 5027.5 5027.7 5032.9 5083.6 4986.1 4994.1 5012.8 5021.0 5035.9 5374.3 5394.9 5414.2 5438.9 5440.4 5928.3 5970.7 5972.6 5977.8 5982.4 5751.7 5774.3 6033.8 6054.1 6057.7 5527.1 5566.6 5571.8 5597.4 5610.4 6111.2 6119.8 6127.8 6129.7 6130.7 5670.8 5779.8 5833.7 5858.7 5861.4 5858.7 5952.5 5966.5 5986.4 5987.6 5693.3 5744.4 5752.9 5881.7 5928.5 5781.7 5785.7 5843.2 5846.4 5900.6 4430.4 4478.9 4497.2 4509.0 4556.6 3929.2 3951.8 3958.4 3999.6 4006.4 5600.7 5604.6 5630.6 5633.9 5643.9 5696.2 5899.9 5988.0 6003.6 6015.1 5550.8 5586.4 5604.1 5640.4 5645.9 5117.8 5133.3 5135.8 5136.8 5208.9 5961.4 6032.8 6042.1 6181.3 6193.3 5866.5 5897.1 5916.3 5957.3 5994.1 6075.0 6095.6 6122.8 6125.8 6125.9 5688.9 5784.9 5849.7 5851.9 5857.8 5966.7 5975.6 5994.8 6056.1 6108.9 5741.2 5808.5 5810.3 5835.4 5861.3 5606.0 5756.5 5773.4 5866.0 5867.1 5704.9 5715.9 5732.0 5733.0 5781.1 5841.0 5853.6 5860.2 5863.0 5882.9 5523.4 5650.6 5684.1 5722.7 5733.3 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#1] ext.html Cycles:180 Average:63189.20 Median:40557.29 stddev:136077.35 (335.5%) stddev-sans-first:136377.86 02:39:23 INFO - PROCESS | 25759 | Values: 571.2 625.0 646.5 646.5 660.8 36861.4 42728.5 42851.8 43094.1 43128.6 42815.1 43029.8 43506.8 43625.1 43831.0 8574.5 8813.2 8864.6 8879.5 8888.6 8690.1 8734.9 8829.9 8836.4 8836.5 8727.6 8783.4 8795.2 8823.3 8851.0 8754.1 8760.1 8803.5 8805.9 8814.5 8625.3 8671.2 8686.7 8697.9 8704.6 39951.4 40280.8 40471.8 40498.2 40510.2 3491.2 3645.9 3787.3 4169.1 4384.2 30661.0 31901.7 32373.2 32725.2 33608.2 4329.8 4410.4 4429.0 4482.6 4554.7 352770.0 353458.0 355388.0 356391.0 357373.0 34471.7 35069.3 35124.8 60406.7 60423.7 37272.0 37830.8 37912.0 37933.2 37940.4 15538.1 15844.7 15852.7 15853.8 15917.6 12246.1 12351.9 12391.8 12407.9 12415.0 8361.0 8447.9 8459.0 8501.4 8533.7 3232.4 3261.3 3271.5 3309.4 3314.1 944.9 1009.9 1032.6 1058.0 1087.2 31417.5 31625.2 31835.2 32198.4 32746.8 1117.7 1180.6 1210.8 1226.2 1229.9 16680.9 16975.6 16999.2 17027.0 17058.0 629197.0 640772.0 641465.0 642689.0 646204.0 41081.0 42249.4 58499.4 58716.4 58955.7 1374.0 1384.6 1388.3 1400.0 1405.6 29888.6 30754.7 31004.4 31375.8 31722.2 51152.0 51357.7 51979.7 51989.0 52098.7 487680.0 490147.0 491215.0 493980.0 495259.0 25794.6 28576.9 28746.3 28788.3 28857.0 48967.2 49971.3 50206.7 50224.0 50599.2 40430.6 41821.0 42026.0 42183.6 42602.6 39118.4 41141.4 41669.8 41962.0 42068.8 36707.4 40228.2 40307.4 40604.4 40821.2 35389.5 38122.2 38259.8 38765.4 39011.0 28422.3 28724.0 28937.3 28982.0 29155.0 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#2] jquery.html Cycles:180 Average:29572.76 Median:10698.62 stddev:83320.22 (778.8%) stddev-sans-first:83525.13 02:39:23 INFO - PROCESS | 25759 | Values: 383.0 387.9 389.6 395.8 412.9 13816.7 18724.3 18727.4 19328.4 19432.0 17938.1 18351.0 18365.6 18534.1 18612.0 4919.2 5446.8 5588.3 5597.2 5607.4 5518.6 5521.7 5562.4 5596.6 5596.6 5279.6 5455.5 5497.4 5508.8 5520.6 5486.5 5497.5 5508.0 5513.1 5517.6 4742.3 4868.3 4939.6 4955.2 4960.9 21225.3 21983.5 22123.7 22246.8 22265.3 2188.9 2350.2 2543.3 2653.4 2926.8 13703.6 14045.7 14166.0 14245.0 14464.1 1934.1 1969.6 1979.6 1980.5 1985.9 77948.2 82529.6 83160.0 83574.6 84194.2 10066.3 10161.9 10197.9 10261.1 10601.6 14251.9 14316.4 14325.4 14422.2 14429.6 7628.5 7769.5 7821.6 7977.2 7987.3 7547.4 7614.6 7646.4 7709.6 7740.2 6341.4 6343.7 6440.0 6444.2 6463.2 1905.4 1919.2 1928.6 1965.2 1985.1 919.3 962.2 1009.6 1041.4 1090.6 17890.8 18632.9 19032.5 19080.2 19093.4 999.7 1054.3 1067.2 1070.7 1089.0 10630.4 10977.6 10995.7 11029.5 11073.2 492590.0 503485.0 504954.0 510967.0 521471.0 82620.0 84540.2 85182.0 85505.1 87209.0 1021.4 1062.4 1075.8 1096.3 1101.5 16004.6 16205.8 16353.6 16514.9 16578.7 39414.8 41997.6 42171.8 43656.1 46621.0 57044.0 57904.0 59318.0 61004.0 62790.0 11974.2 12465.6 12540.7 12698.7 12793.6 13117.3 13600.3 13655.5 13765.4 13791.2 11519.1 11694.2 11975.3 11988.5 12188.6 11122.8 11850.0 11985.3 12117.7 12330.9 11955.5 11970.5 11979.0 11994.7 12227.3 12558.2 12779.7 12840.9 12870.4 12874.9 11753.5 11792.8 11810.0 11828.2 11881.0 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#3] mootools.html Cycles:180 Average:5770.99 Median:4595.27 stddev:3280.67 (71.4%) stddev-sans-first:3273.89 02:39:23 INFO - PROCESS | 25759 | Values: 1462.2 1520.0 1638.3 1762.3 1764.7 7764.5 8105.6 8408.6 8867.2 8894.4 8509.7 8710.6 8766.9 8800.7 8807.6 2335.1 2356.8 2357.8 2361.1 2367.9 2310.1 2323.3 2326.1 2341.4 2348.1 2293.8 2307.1 2310.3 2330.8 2341.0 2269.7 2285.6 2290.0 2302.7 2314.5 2346.9 2360.3 2361.7 2369.6 2371.5 8755.8 8811.5 8822.0 8873.0 8879.5 5115.8 5225.5 5292.8 5303.8 5349.8 3315.9 3423.1 3454.2 3502.1 3508.3 1103.7 1110.8 1115.8 1136.3 1140.5 12214.9 12220.0 12229.8 12237.0 12243.3 4534.4 4575.5 4649.7 4680.9 4686.3 10375.6 10399.0 10411.6 10427.0 10450.1 5273.1 5282.6 5312.9 5313.1 5325.4 4022.4 4486.6 4615.0 4663.3 4926.2 3903.2 3940.1 4011.3 4020.9 4058.9 1248.2 1273.2 1273.2 1290.7 1290.7 1025.2 1030.6 1033.0 1037.8 1044.3 6090.5 6136.4 6139.8 6187.4 6272.6 457.2 462.6 464.4 467.5 476.8 4136.3 4169.9 4248.2 4264.6 4326.6 10629.6 10833.6 10890.5 10983.3 10998.5 10597.3 10614.1 10747.2 10768.9 10824.4 8090.4 8215.5 8254.4 8284.7 8319.1 5878.4 5986.1 6029.0 6064.7 6127.4 9661.4 9910.2 9963.7 9980.0 10006.9 10017.3 10143.5 10155.7 10187.7 10476.8 7214.4 7435.6 7645.0 7991.6 8162.3 8444.2 8532.5 8537.4 8568.7 8619.4 7472.0 7732.8 7792.6 7794.0 7804.9 7472.1 7585.2 7590.8 7629.2 7786.0 6616.0 6620.3 6664.3 6684.6 6718.1 4847.2 5056.3 5075.4 5157.8 5167.4 5087.2 5195.6 5255.4 5255.5 5281.8 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#4] prototype.html Cycles:180 Average:4936.98 Median:5633.05 stddev:1474.04 (26.2%) stddev-sans-first:1437.09 02:39:23 INFO - PROCESS | 25759 | Values: 332.6 333.8 338.8 343.0 344.4 5626.7 5667.5 5671.5 5689.7 5697.3 5548.4 5600.1 5614.2 5617.2 5634.5 4156.4 4163.8 4274.1 4314.2 4329.7 4293.6 4319.3 4324.9 4328.2 4348.4 4314.8 4324.7 4324.8 4333.3 4339.7 4049.3 4249.6 4251.3 4272.7 4330.0 3700.4 3724.8 3728.1 3749.6 3756.5 5324.4 5369.7 5383.0 5387.9 5433.8 4712.5 4920.9 4937.0 4944.0 4985.4 5755.2 5777.7 5810.7 5844.3 5856.8 4157.7 4158.8 4168.1 4172.4 4184.6 5860.0 6032.5 6060.6 6111.5 6112.8 4210.5 4222.6 4230.3 4237.9 4241.3 4257.5 4267.3 4284.7 4314.0 4330.6 4648.1 4925.9 4949.6 4953.6 4970.4 5858.7 5882.7 5902.8 5922.6 5961.9 1475.9 1488.8 1492.5 1497.8 1499.0 950.7 964.6 976.7 1011.6 1019.3 5520.3 5556.8 5572.9 5590.0 5591.5 5952.4 6010.0 6030.3 6039.1 6071.2 5388.9 5626.5 5631.6 5738.4 5773.4 3249.4 3251.9 3254.0 3287.3 3304.2 6141.2 6281.4 6283.8 6307.1 6393.7 6215.2 6230.4 6241.9 6242.3 6246.7 6092.5 6279.8 6281.3 6316.8 6321.4 6038.0 6042.2 6072.0 6092.6 6109.8 6014.6 6047.6 6050.3 6055.8 6096.4 6039.6 6278.9 6290.2 6305.7 6314.5 4221.7 4243.6 4248.7 4249.6 4269.7 5891.9 5993.3 6155.4 6169.6 6176.6 5800.3 5906.9 5919.8 5938.3 5941.7 5836.2 5888.4 5894.1 5895.9 5900.1 5547.7 5762.5 5776.3 5796.1 5810.4 5849.9 5891.9 5906.7 5977.5 6009.8 5693.0 5714.7 5792.9 5795.5 5851.4 02:39:23 INFO - PROCESS | 25759 | 02:39:23 INFO - PROCESS | 25759 | [#5] yui.html Cycles:180 Average:20154.57 Median:4878.59 stddev:28556.36 (585.3%) stddev-sans-first:28599.12 02:39:23 INFO - PROCESS | 25759 | Values: 703.1 735.1 802.0 802.6 808.2 15750.9 16467.4 16618.1 16738.8 16740.5 14814.9 15056.9 15108.3 15166.1 15248.8 667.6 784.3 796.3 805.2 808.1 788.7 796.6 797.5 801.6 802.3 854.2 856.6 856.8 858.0 859.0 848.3 849.3 852.7 852.8 855.5 614.4 617.8 618.3 620.1 623.6 15155.2 15226.5 15243.8 15304.7 15328.6 13250.9 13304.7 13560.2 15626.4 15665.2 12804.3 12952.6 13049.2 13233.3 13927.1 4426.5 4474.6 4497.1 4535.5 4571.8 74431.0 74992.6 75444.2 76669.6 76701.6 11240.4 11275.6 11439.8 11477.1 11567.2 20808.5 20828.8 20832.7 20910.3 20999.9 8967.9 9020.6 9050.6 9189.3 9190.6 4850.2 4869.3 4887.9 4899.3 4992.7 3577.5 3682.8 3691.5 3708.8 3709.3 643.9 644.4 654.7 661.6 663.9 667.8 671.5 741.4 750.7 778.5 9481.2 9483.7 9855.9 9873.0 9960.6 718.5 762.6 767.8 774.2 780.9 4196.2 4211.2 4247.4 4281.6 4319.0 103721.0 107674.5 109676.0 111317.0 112987.4 75310.6 95823.0 95844.5 95998.5 96292.5 52038.0 85565.6 86320.6 89245.0 89627.7 9169.2 9180.0 9249.4 9300.6 9311.7 49988.3 50068.2 50591.5 51664.7 52576.5 52362.0 75640.6 76340.0 77351.6 78273.6 12331.9 12579.5 12673.2 12872.2 12953.3 13609.0 13621.0 13968.9 14104.2 14118.8 12656.7 13051.2 13317.7 13517.4 13555.7 12381.8 12407.4 12548.8 12796.5 12873.2 12124.5 13020.9 13273.1 13298.1 13312.7 10653.8 10929.5 10945.7 10947.4 11286.3 9637.7 10265.8 10531.7 10687.5 10773.2 02:39:23 INFO - PROCESS | 25759 | -------- Summary: end -------- 02:39:23 INFO - PROCESS | 25759 | 02:39:24 INFO - TEST-INFO | 25759: exit 0 02:39:24 INFO - TEST-OK | dromaeo_css | took 1111593ms 02:39:24 INFO - TEST-START | kraken 02:39:24 INFO - operating with platform_type : linux_ 02:39:24 INFO - Initialising browser for kraken test... 02:39:24 INFO - TEST-INFO | started process 25994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYvpNTd/profile http://localhost:39410/getInfo.html) 02:39:28 INFO - PROCESS | 25994 | __metrics Screen width/height:1600/1200 02:39:28 INFO - PROCESS | 25994 | colorDepth:24 02:39:28 INFO - PROCESS | 25994 | Browser inner width/height: 1024/697 02:39:28 INFO - PROCESS | 25994 | __metrics 02:39:29 ERROR - PROCESS | 25994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:39:30 INFO - TEST-INFO | 25994: exit 0 02:39:30 INFO - Browser initialized. 02:39:30 INFO - Running cycle 1/1 for kraken test... 02:39:30 INFO - TEST-INFO | started process 26116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYvpNTd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:42 INFO - PROCESS | 26116 | RSS: Main: 167706624 02:39:42 INFO - PROCESS | 26116 | 02:39:44 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39410/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:45 INFO - PROCESS | 26116 | RSS: Main: 173285376 02:39:45 INFO - PROCESS | 26116 | 02:39:48 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39410/tests/kraken/driver.html?testName=audio-dft) 02:39:48 INFO - PROCESS | 26116 | RSS: Main: 172023808 02:39:48 INFO - PROCESS | 26116 | 02:39:51 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39410/tests/kraken/driver.html?testName=audio-fft) 02:39:52 INFO - PROCESS | 26116 | RSS: Main: 167133184 02:39:52 INFO - PROCESS | 26116 | 02:39:54 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39410/tests/kraken/driver.html?testName=audio-oscillator) 02:39:55 INFO - PROCESS | 26116 | RSS: Main: 167895040 02:39:55 INFO - PROCESS | 26116 | 02:39:57 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:58 INFO - PROCESS | 26116 | RSS: Main: 168251392 02:39:58 INFO - PROCESS | 26116 | 02:40:01 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39410/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:02 INFO - PROCESS | 26116 | RSS: Main: 168738816 02:40:02 INFO - PROCESS | 26116 | 02:40:05 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39410/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:06 INFO - PROCESS | 26116 | RSS: Main: 166182912 02:40:06 INFO - PROCESS | 26116 | 02:40:08 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39410/tests/kraken/driver.html?testName=json-parse-financial) 02:40:09 INFO - PROCESS | 26116 | RSS: Main: 167280640 02:40:09 INFO - PROCESS | 26116 | 02:40:11 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:11 INFO - PROCESS | 26116 | RSS: Main: 168226816 02:40:11 INFO - PROCESS | 26116 | 02:40:13 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:14 INFO - PROCESS | 26116 | RSS: Main: 167297024 02:40:14 INFO - PROCESS | 26116 | 02:40:16 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:16 INFO - PROCESS | 26116 | RSS: Main: 167489536 02:40:16 INFO - PROCESS | 26116 | 02:40:19 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:20 INFO - PROCESS | 26116 | RSS: Main: 168091648 02:40:20 INFO - PROCESS | 26116 | 02:40:22 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:23 INFO - PROCESS | 26116 | RSS: Main: 168357888 02:40:23 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | Cycle 1(1): loaded http://localhost:39410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39410/tests/kraken/driver.html?testName=ai-astar) 02:40:25 INFO - PROCESS | 26116 | RSS: Main: 169148416 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | __start_tp_report 02:40:25 INFO - PROCESS | 26116 | _x_x_mozilla_page_load 02:40:25 INFO - PROCESS | 26116 | _x_x_mozilla_page_load_details 02:40:25 INFO - PROCESS | 26116 | |i|pagename|runs| 02:40:25 INFO - PROCESS | 26116 | |0;ai-astar;109;106;111;110;111;111;110;111;111;110 02:40:25 INFO - PROCESS | 26116 | |1;audio-beat-detection;158;138;159;173;135;153;169;134;193;128 02:40:25 INFO - PROCESS | 26116 | |2;audio-dft;163;168;163;162;163;179;163;164;165;162 02:40:25 INFO - PROCESS | 26116 | |3;audio-fft;76;75;75;171;76;75;76;76;158;78 02:40:25 INFO - PROCESS | 26116 | |4;audio-oscillator;87;95;147;85;85;84;151;86;86;146 02:40:25 INFO - PROCESS | 26116 | |5;imaging-gaussian-blur;119;117;117;120;117;116;118;118;118;118 02:40:25 INFO - PROCESS | 26116 | |6;imaging-darkroom;148;147;146;146;148;148;147;149;148;146 02:40:25 INFO - PROCESS | 26116 | |7;imaging-desaturate;95;96;95;96;96;96;95;95;95;96 02:40:25 INFO - PROCESS | 26116 | |8;json-parse-financial;58;56;60;58;58;57;56;54;55;55 02:40:25 INFO - PROCESS | 26116 | |9;json-stringify-tinderbox;61;60;60;62;61;61;61;61;61;61 02:40:25 INFO - PROCESS | 26116 | |10;stanford-crypto-aes;82;82;87;81;82;81;81;82;104;82 02:40:25 INFO - PROCESS | 26116 | |11;stanford-crypto-ccm;122;120;131;127;121;132;125;133;132;123 02:40:25 INFO - PROCESS | 26116 | |12;stanford-crypto-pbkdf2;163;163;160;159;159;161;163;157;161;169 02:40:25 INFO - PROCESS | 26116 | |13;stanford-crypto-sha256-iterative;66;67;64;63;71;63;63;64;63;63 02:40:25 INFO - PROCESS | 26116 | __end_tp_report 02:40:25 INFO - PROCESS | 26116 | __start_cc_report 02:40:25 INFO - PROCESS | 26116 | _x_x_mozilla_cycle_collect,886 02:40:25 INFO - PROCESS | 26116 | __end_cc_report 02:40:25 INFO - PROCESS | 26116 | __startTimestamp1465465225362__endTimestamp 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | ------- Summary: start ------- 02:40:25 INFO - PROCESS | 26116 | Number of tests: 14 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:1.62 02:40:25 INFO - PROCESS | 26116 | Values: 109.0 106.0 111.0 110.0 111.0 111.0 110.0 111.0 111.0 110.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:158.50 stddev:20.66 (13.0%) stddev-sans-first:21.86 02:40:25 INFO - PROCESS | 26116 | Values: 158.0 138.0 159.0 173.0 135.0 153.0 169.0 134.0 193.0 128.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#2] audio-dft Cycles:10 Average:165.20 Median:163.50 stddev:5.16 (3.2%) stddev-sans-first:5.41 02:40:25 INFO - PROCESS | 26116 | Values: 163.0 168.0 163.0 162.0 163.0 179.0 163.0 164.0 165.0 162.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.50 (49.3%) stddev-sans-first:39.23 02:40:25 INFO - PROCESS | 26116 | Values: 76.0 75.0 75.0 171.0 76.0 75.0 76.0 76.0 158.0 78.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:85.50 stddev:29.72 (34.8%) stddev-sans-first:30.78 02:40:25 INFO - PROCESS | 26116 | Values: 87.0 95.0 147.0 85.0 85.0 84.0 151.0 86.0 86.0 146.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 02:40:25 INFO - PROCESS | 26116 | Values: 119.0 117.0 117.0 120.0 117.0 116.0 118.0 118.0 118.0 118.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 02:40:25 INFO - PROCESS | 26116 | Values: 148.0 147.0 146.0 146.0 148.0 148.0 147.0 149.0 148.0 146.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:40:25 INFO - PROCESS | 26116 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:1.83 (3.2%) stddev-sans-first:1.88 02:40:25 INFO - PROCESS | 26116 | Values: 58.0 56.0 60.0 58.0 58.0 57.0 56.0 54.0 55.0 55.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:40:25 INFO - PROCESS | 26116 | Values: 61.0 60.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:7.11 (8.7%) stddev-sans-first:7.48 02:40:25 INFO - PROCESS | 26116 | Values: 82.0 82.0 87.0 81.0 82.0 81.0 81.0 82.0 104.0 82.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:129.00 stddev:5.06 (3.9%) stddev-sans-first:5.09 02:40:25 INFO - PROCESS | 26116 | Values: 122.0 120.0 131.0 127.0 121.0 132.0 125.0 133.0 132.0 123.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:3.31 (2.0%) stddev-sans-first:3.46 02:40:25 INFO - PROCESS | 26116 | Values: 163.0 163.0 160.0 159.0 159.0 161.0 163.0 157.0 161.0 169.0 02:40:25 INFO - PROCESS | 26116 | 02:40:25 INFO - PROCESS | 26116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.00 stddev:2.63 (4.1%) stddev-sans-first:2.74 02:40:25 INFO - PROCESS | 26116 | Values: 66.0 67.0 64.0 63.0 71.0 63.0 63.0 64.0 63.0 63.0 02:40:25 INFO - PROCESS | 26116 | -------- Summary: end -------- 02:40:25 INFO - PROCESS | 26116 | 02:40:26 INFO - TEST-INFO | 26116: exit 0 02:40:26 INFO - TEST-OK | kraken | took 61915ms 02:40:26 INFO - SUITE-END | took 1173s 02:40:26 INFO - Completed test suite (00:19:33) 02:40:26 INFO - javascript benchmark 02:40:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.576988277074, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.315587148763, 3205.727513161381, 3235.530848027036, 3237.2068843133434, 3257.560229369036, 5402.702851343174, 5428.050091234038, 5436.945630543693, 5524.944750552493, 5536.861578460541, 5447.645903016301, 5480.6437581557275, 5481.314835645544, 5499.120140777476, 5522.5581953443725, 4965.553100220979, 4998.425181104165, 5033.270175824503, 5132.640715149941, 5145.151050076752, 5034.949650503503, 5164.586833053347, 5202.583793296527, 5203.869903252411, 5208.192730126836, 4969.503049695019, 4984.925226121611, 5016.423111342187, 5018.648694591362, 5025.0, 5025.572826309768, 5027.522385373383, 5027.723475208862, 5032.924506132411, 5083.6441449098575, 4986.052649996525, 4994.05113028527, 5012.774425150877, 5020.953821957234, 5035.924461133086, 5374.274472946141, 5394.865128371822, 5414.160805075219, 5438.945610543883, 5440.374356948962, 5928.347881733006, 5970.6716130612795, 5972.581919265654, 5977.7608895644125, 5982.401759824026, 5751.654900705971, 5774.335951365605, 6033.788817391414, 6054.091886217103, 6057.727402266909, 5527.060399732055, 5566.638168519034, 5571.804986825442, 5597.384287728347, 5610.38285788567, 6111.205543279345, 6119.816405507842, 6127.754889804358, 6129.693515324216, 6130.6628135452975, 5670.829875103754, 5779.768809247667, 5833.708314584339, 5858.677772722541, 5861.443162899518, 5858.736356863951, 5952.494038006731, 5966.522678185735, 5986.431289027535, 5987.6108052976415, 5693.259876216065, 5744.368119506851, 5752.856178595569, 5881.735321910524, 5928.466438020599, 5781.653100813965, 5785.681787501644, 5843.24037875082, 5846.356900740915, 5900.616459930091, 4430.42404487421, 4478.932816007762, 4497.2129877271345, 4508.954910450919, 4556.612687921497, 3929.174873276587, 3951.8024098794945, 3958.4062390641634, 3999.6400323970984, 4006.4390985262085, 5600.6919619420505, 5604.635698679573, 5630.60585758993, 5633.887322253614, 5643.915341269884, 5696.231008813757, 5899.852503687356, 5987.970060149672, 6003.579749417586, 6015.097735339734, 5550.777968881281, 5586.35756887955, 5604.075327570987, 5640.407757185437, 5645.887082258332, 5117.820876269313, 5133.332666753298, 5135.8172776570555, 5136.845894623168, 5208.947910520922, 5961.374055724174, 6032.819015429544, 6042.093685947055, 6181.289151747516, 6193.256809182927, 5866.50134738552, 5897.144913987534, 5916.290045194432, 5957.344692083954, 5994.130851026664, 6075.0, 6095.603785753912, 6122.785702500391, 6125.816225513242, 6125.927962606437, 5688.857778555569, 5784.913226301693, 5849.736761845812, 5851.912221316598, 5857.765689372548, 5966.671833049224, 5975.641461512323, 5994.790182343597, 6056.121862330026, 6108.8778224436155, 5741.196232527366, 5808.5353171747, 5810.273715785527, 5835.44563266489, 5861.296644402699, 5606.046972014686, 5756.510696590837, 5773.422657734193, 5865.970670146622, 5867.061270196748, 5704.916065947456, 5715.8571035724435, 5732.0, 5733.0, 5781.132830075522, 5841.007028805198, 5853.560982926212, 5860.179574859609, 5863.0, 5882.911756323573, 5523.447655234444, 5650.63270887391, 5684.147377893349, 5722.685252311163, 5733.254676891977], "value": 5454.011897503684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1632458448372, 624.9531285153614, 646.5021933111507, 646.5409559212959, 660.8182749743822, 36861.447078293844, 42728.504502342425, 42851.78574107125, 43094.13811723768, 43128.56871431289, 42815.14369712604, 43029.7848510757, 43506.7824660877, 43625.127497450034, 43831.0, 8574.528400937947, 8813.206811386974, 8864.556772161399, 8879.51162686052, 8888.644454221823, 8690.130986901291, 8734.912650873473, 8829.911700882973, 8836.42563233391, 8836.46981181128, 8727.60725767342, 8783.429077109968, 8795.164459376349, 8823.338249631272, 8850.955745221265, 8754.124587541195, 8760.12398760122, 8803.515806630632, 8805.867911981326, 8814.515201663906, 8625.309975202032, 8671.21959023691, 8686.739397818075, 8697.869531957025, 8704.608292626785, 39951.40072898909, 40280.798596007124, 40471.79764101161, 40498.190036199405, 40510.18979620391, 3491.17957280039, 3645.890623281279, 3787.280416720814, 4169.145325208325, 4384.188925048876, 30661.0, 31901.680983190105, 32373.190670233198, 32725.18187045343, 33608.15979600505, 4329.805158767863, 4410.404595379615, 4429.003474218307, 4482.6413886889295, 4554.7039442436135, 352770.0, 353458.0, 355388.0, 356391.0, 357373.0, 34471.65528344735, 35069.298614027575, 35124.82437587847, 60406.697966509884, 60423.697881510314, 37272.0, 37830.81084594559, 37912.0, 37933.24133517369, 37940.43089353662, 15538.145402002998, 15844.683106337809, 15852.68294634124, 15853.841461585236, 15917.602059948362, 12246.081543884244, 12351.876481235253, 12391.814122788166, 12407.875921240671, 12415.0, 8361.0, 8447.873281900776, 8458.957705211435, 8501.44740591872, 8533.74398768038, 3232.3696879108347, 3261.2662151015834, 3271.492918597621, 3309.4373956427467, 3314.0720598232533, 944.8582712593029, 1009.8990100989989, 1032.5921261101823, 1057.9947100264449, 1087.1954753482523, 31417.528737068962, 31625.20936976594, 31835.20411989719, 32198.35603287968, 32746.836265818518, 1117.7373317270435, 1180.5513904716154, 1210.8002179640437, 1226.2029680707433, 1229.9385030748426, 16680.916595416944, 16975.575610609834, 16999.150042497826, 17027.0, 17058.0, 629197.0, 640772.0, 641465.0, 642689.0, 646204.0, 41081.0, 42249.36625950613, 58499.41500585025, 58716.412835871946, 58955.705221474476, 1373.979390309146, 1384.5707830572353, 1388.2850332078988, 1400.0, 1405.6485878530368, 29888.55167172451, 30754.692453076077, 31004.379912401175, 31375.84312078425, 31722.20694482564, 51152.0, 51357.743211283705, 51979.74010129925, 51989.0, 52098.73950630374, 487680.0, 490147.0, 491215.0, 493980.0, 495259.0, 25794.61308080343, 28576.85711571512, 28746.281342966595, 28788.280292992844, 28856.99000535055, 48967.21376782789, 49971.25043124429, 50206.748966254934, 50224.0, 50599.241011384125, 40430.59569404386, 41821.0, 42026.0, 42183.578164217965, 42602.57397425986, 39118.413223802236, 41141.382879257435, 41669.79165104276, 41962.0, 42068.78965605152, 36707.44938825973, 40228.19543609053, 40307.395389069774, 40604.39093413542, 40821.18357632771, 35389.46915796317, 38122.23755524818, 38259.80870095632, 38765.41851872168, 39011.0, 28422.289442764097, 28724.0, 28937.276568085967, 28982.0, 29155.0], "value": 19013.892592160635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.95404551453845, 387.9003026420099, 389.56952567413015, 395.7941870227482, 412.8967758060485, 13816.654583635414, 18724.344647937323, 18727.4381768547, 19328.420147395584, 19432.028398580067, 17938.10309484527, 18351.0, 18365.632687346246, 18534.0732963352, 18612.0, 4919.188333924898, 5446.782128714846, 5588.329400471949, 5597.244372009767, 5607.355154157283, 5518.558515318765, 5521.668699878, 5562.443755624426, 5596.58025648076, 5596.58025648076, 5279.604029697769, 5455.509004189622, 5497.422770609089, 5508.7521061552325, 5520.613557051008, 5486.506214440699, 5497.47773961473, 5507.972460137694, 5513.062779327524, 5517.613767036309, 4742.288656701522, 4868.269759536062, 4939.580135688435, 4955.157623204064, 4960.900781984376, 21225.257116000867, 21983.450413739785, 22123.668144977837, 22246.777532224794, 22265.332040038826, 2188.9014994325134, 2350.17743789674, 2543.300592337104, 2653.4162484253434, 2926.75122614578, 13703.588892333146, 14045.71908561823, 14166.0, 14245.0, 14464.132152070804, 1934.1489744512369, 1969.5863868587614, 1979.5644958109192, 1980.5048737815546, 1985.9404217873343, 77948.22051779466, 82529.58735206345, 83160.0, 83574.58212708897, 84194.15805841924, 10066.345687530433, 10161.949190254001, 10197.898021019695, 10261.127804136731, 10601.575936962436, 14251.928740356232, 14316.355763990645, 14325.35535900887, 14422.206778627276, 14429.639259018399, 7628.504147230412, 7769.53382797034, 7821.608919554, 7977.2022797719765, 7987.281144696889, 7547.358474529617, 7614.581198034161, 7646.3882889368715, 7709.614519274014, 7740.187280335484, 6341.365863413714, 6343.714532846033, 6439.967800160969, 6444.162258906312, 6463.15978922737, 1905.3712274949235, 1919.2227148005081, 1928.594995051027, 1965.2040923426036, 1985.057097878496, 919.2554031234588, 962.2061799015839, 1009.5759780892043, 1041.422010784007, 1090.6019302954523, 17890.821091788916, 18632.906835465736, 19032.52418689516, 19080.236790528503, 19093.427197184108, 999.7350702063959, 1054.314695447965, 1067.199600299775, 1070.6948519671855, 1088.9727756806144, 10630.415327157081, 10977.560897564008, 10995.670129896116, 11029.503672334764, 11073.172926467043, 492590.0, 503485.0, 504954.0, 510967.0, 521471.0, 82620.0, 84540.15459845446, 85182.0, 85505.14494854971, 87209.0, 1021.3973755484151, 1062.4369084385135, 1075.7633320669597, 1096.2928910852456, 1101.5098281264761, 16004.599885002968, 16205.837941620433, 16353.591160221089, 16514.917425412797, 16578.668426631157, 39414.80292598519, 41997.580024199364, 42171.7891410541, 43656.12687746164, 46621.0, 57044.0, 57904.0, 59318.0, 61004.0, 62790.0, 11974.22167559106, 12465.62878083392, 12540.749185016066, 12698.682532936751, 12793.552225672056, 13117.278549679477, 13600.319984000958, 13655.453781849012, 13765.38055787472, 13791.241481718602, 11519.136064795006, 11694.181407301407, 11975.341356225492, 11988.46051927648, 12188.634340969431, 11122.777544448903, 11850.0, 11985.28088314704, 12117.69705757363, 12330.876691232972, 11955.462004209658, 11970.521179152736, 11979.04167666602, 11994.700132496757, 12227.327496987751, 12558.246505209716, 12779.680507987374, 12840.935795320964, 12870.356482175666, 12874.935625321814, 11753.47109380097, 11792.76414471723, 11810.0, 11828.23116497425, 11881.0], "value": 9482.46870418952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.1592584264051, 1520.0, 1638.3119089982206, 1762.2950819672137, 1764.664713704397, 7764.456488045825, 8105.554194519299, 8408.57957102144, 8867.201951824334, 8894.421862578936, 8509.744707658765, 8710.60802263898, 8766.912330876688, 8800.735977920673, 8807.603657835396, 2335.100986120339, 2356.7761062699014, 2357.799587035104, 2361.055577768889, 2367.8579285242854, 2310.1452462588863, 2323.314622186459, 2326.1044497868356, 2341.379534423371, 2348.1077190667525, 2293.841609986954, 2307.0541078157958, 2310.27226423676, 2330.7669233076726, 2341.028473183627, 2269.6708977198296, 2285.611446054175, 2290.03818396274, 2302.689136966505, 2314.4792421705065, 2346.9295921122393, 2360.280114565057, 2361.716594008713, 2369.57347677418, 2371.5256948610345, 8755.781105472413, 8811.471311721318, 8821.955890220572, 8872.955635221848, 8879.51162686052, 5115.820946266863, 5225.4513276105845, 5292.788288468457, 5303.761330740126, 5349.812756553541, 3315.8673653053847, 3423.1442139465134, 3454.2055327274866, 3502.124468882779, 3508.28080243552, 1103.7406209540752, 1110.8111621024445, 1115.760111576007, 1136.2671077155271, 1140.5209811878947, 12214.938925305316, 12220.0, 12229.816552751716, 12236.99999999991, 12243.265404075784, 4534.36518887356, 4575.542445755398, 4649.721016739007, 4680.906381872412, 4686.343911852344, 10375.584976600852, 10399.0, 10411.635592754217, 10426.957304269512, 10450.059494645518, 5273.077211487975, 5282.550983166474, 5312.92030619541, 5313.0967735485065, 5325.440828713007, 4022.4368588397647, 4486.573775491323, 4615.0, 4663.347131401607, 4926.187179115406, 3903.2388684206876, 3940.0937784309767, 4011.338129208706, 4020.8994775130855, 4058.918821623551, 1248.2011512631923, 1273.1533530202496, 1273.1724379153625, 1290.7160424706549, 1290.7418516296777, 1025.1747343388645, 1030.5620111452602, 1032.9896701033044, 1037.8131936251395, 1044.3211912257093, 6090.451859332593, 6136.386361363917, 6139.785107521305, 6187.3503282155625, 6272.6236425814595, 457.154264610468, 462.5836746927792, 464.4496271917788, 467.5231264110588, 476.7735325720255, 4136.276151673445, 4169.91660166795, 4248.235317642854, 4264.57354264571, 4326.58897404746, 10629.574817007233, 10833.620823271147, 10890.509927053301, 10983.286086404518, 10998.505067271992, 10597.25819192649, 10614.12040253275, 10747.247692661595, 10768.892311076946, 10824.350538967687, 8090.393220508367, 8215.507069575844, 8254.42219044673, 8284.668613255522, 8319.084900660922, 5878.382769809108, 5986.102084687158, 6029.0, 6064.696090340598, 6127.387261273837, 9661.372010819274, 9910.207183425453, 9963.701088967342, 9979.950100249453, 10006.949965250418, 10017.348872323568, 10143.492825358555, 10155.695329140137, 10187.7453063674, 10476.842847357144, 7214.422846172399, 7435.591042492499, 7645.0, 7991.560464174526, 8162.347012239125, 8444.197801208875, 8532.530710810965, 8537.402381833212, 8568.742937711879, 8619.396642234984, 7472.0, 7732.7680169595005, 7792.6103694816165, 7794.025746781653, 7804.921950780419, 7472.103347598323, 7585.16563178061, 7590.7722768317035, 7629.16079231273, 7785.961070194613, 6616.040674102132, 6620.304867988792, 6664.333566643297, 6684.598924064571, 6718.126643536309, 4847.200211965127, 5056.266841307916, 5075.390953085654, 5157.793688252428, 5167.354080739908, 5087.211482220262, 5195.606319895, 5255.421903590525, 5255.500727430888, 5281.841544753664], "value": 4560.170068782392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.64407084419673, 333.8347517978601, 338.82381161795865, 342.9794212347258, 344.3749594486009, 5626.746796394157, 5667.461591148839, 5671.468703450066, 5689.715514224293, 5697.259356283683, 5548.389677135522, 5600.08795426378, 5614.242077319561, 5617.185508101323, 5634.464725851048, 4156.438880751098, 4163.812628431712, 4274.059706864485, 4314.223439780838, 4329.675274354436, 4293.635041021517, 4319.287317592609, 4324.935125973113, 4328.156009578133, 4348.434703488542, 4314.762688052156, 4324.654027677778, 4324.805383757723, 4333.263345231318, 4339.717918335314, 4049.2711311963835, 4249.6387807036435, 4251.319788833772, 4272.722273052242, 4330.004099057219, 3700.4079347304573, 3724.832382542792, 3728.12389088564, 3749.550053993511, 3756.455313979485, 5324.41431442541, 5369.691032855871, 5382.9730851345885, 5387.892242155174, 5433.755481003364, 4712.481627021025, 4920.926186107211, 4936.950630493721, 4944.0, 4985.376827896513, 5755.165501002373, 5777.653340799566, 5810.709464526757, 5844.298684157886, 5856.76572937082, 4157.667386609094, 4158.750474971512, 4168.083021735213, 4172.436721042651, 4184.602462766033, 5860.0, 6032.547558933097, 6060.636361818261, 6111.51107911366, 6112.755489780404, 4210.452641156691, 4222.59885310895, 4230.302000169999, 4237.851675191354, 4241.300185469363, 4257.531671516131, 4267.25323068468, 4284.742915425085, 4313.97843010783, 4330.588594083557, 4648.140094082605, 4925.852224433273, 4949.589367030379, 4953.612988363264, 4970.428400733962, 5858.677772722541, 5882.705864706748, 5902.760420311697, 5922.555808314393, 5961.940380596138, 1475.9409623614936, 1488.7866388893017, 1492.544773843988, 1497.7678459838742, 1498.9850101499064, 950.6530116507425, 964.6430820596424, 976.7069879036261, 1011.6155860773007, 1019.2915923433291, 5520.309961254843, 5556.833295001156, 5572.916406253909, 5590.0, 5591.524720398812, 5952.422608008881, 6010.025037606413, 6030.33666296707, 6039.124326972565, 6071.150038994544, 5388.91916621251, 5626.521745651666, 5631.633943793722, 5738.426157384228, 5773.364929857712, 3249.3988612106837, 3251.902442926716, 3254.0, 3287.3096649703352, 3304.2069903223532, 6141.232345956755, 6281.371862813773, 6283.842903927439, 6307.148534947723, 6393.712282947278, 6215.228659831926, 6230.376962303733, 6241.875162496724, 6242.250929888442, 6246.718897649616, 6092.51259899207, 6279.780207692709, 6281.277653069956, 6316.757551069396, 6321.3678632137335, 6038.0, 6042.154098426312, 6072.0, 6092.573519853568, 6109.84725381869, 6014.609050411709, 6047.637141771508, 6050.304215015153, 6055.818325450244, 6096.420840020191, 6039.63762174271, 6278.874422511615, 6290.24517057956, 6305.684715764101, 6314.463270622048, 4221.68337374692, 4243.618074373321, 4248.723832950848, 4249.638780703551, 4269.743815371087, 5891.852703682443, 5993.340732519507, 6155.446009858955, 6169.56813023102, 6176.598521096114, 5800.274965629296, 5906.911396328973, 5919.792807251725, 5938.277899409123, 5941.702914854153, 5836.241288632451, 5888.381719919518, 5894.145348924296, 5895.9115613266695, 5900.082473196314, 5547.667139971614, 5762.5389968801555, 5776.335721392094, 5796.101604251347, 5810.389909059657, 5849.899553236792, 5891.882162356815, 5906.734196961061, 5977.505623594101, 6009.819705408845, 5693.0, 5714.685692286964, 5792.8551786204, 5795.536357091507, 5851.356350801493], "value": 4463.603529633698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1386551474444, 735.1105162753068, 802.0230132722837, 802.5906787538361, 808.2402541610884, 15750.92124539377, 16467.423640172598, 16618.086005269735, 16738.83261167388, 16740.49778506645, 14814.851851481482, 15056.924715376408, 15108.320125594348, 15166.090034597932, 15248.847511524882, 667.5894324990132, 784.3137254901961, 796.3350602247131, 805.2068712318362, 808.107041718898, 788.692409960116, 796.5977181523351, 797.5055465611329, 801.5591424716412, 802.33005440457, 854.1970547685156, 856.6230858422306, 856.8372009318209, 857.9613917373701, 858.9785255368603, 848.2577744473585, 849.3078141314809, 852.6759831264142, 852.7527017165046, 855.5209082913526, 614.3917521653575, 617.7837756785134, 618.3383779356091, 620.1256228717486, 623.5603899251017, 15155.242237888062, 15226.46707365237, 15243.771343429857, 15304.693906121927, 15328.616784580363, 13250.933745331211, 13304.73390532184, 13560.186388816604, 15626.374945002186, 15665.21673916311, 12804.295763732991, 12952.611421657366, 13049.238352822342, 13233.272170030645, 13927.094738841943, 4426.535213802536, 4474.6420286377015, 4497.100579884036, 4535.523770004168, 4571.771411429415, 74431.0, 74992.62503687502, 75444.24555754427, 76669.61665191693, 76701.61649191774, 11240.437978101227, 11275.605353812742, 11439.771204575862, 11477.139214558942, 11567.248128871597, 20808.47978800512, 20828.791712082686, 20832.687509687366, 20910.268140615004, 20999.895000525205, 8967.910320896837, 9020.594073266719, 9050.637974481078, 9189.3108016899, 9190.632374704937, 4850.175470170079, 4869.293952376956, 4887.877803054952, 4899.3385892904, 4992.700437973734, 3577.499150118985, 3682.8158592070827, 3691.483192353073, 3708.8331025103935, 3709.3137769512186, 643.8615697625033, 644.3620815392821, 654.6759354119741, 661.632793799446, 663.9468842492686, 667.8163505036154, 671.4863129705778, 741.4402126394646, 750.7297372945735, 778.505648912933, 9481.194098501566, 9483.668071617598, 9855.852162217572, 9872.950635246778, 9960.601575936882, 718.4755128755933, 762.6121451942012, 767.8387538616842, 774.1832366852911, 780.9258120478545, 4196.160767846443, 4211.220924129046, 4247.426597409372, 4281.636060934793, 4319.0, 103721.0, 107674.46162769136, 109676.0, 111317.0, 112987.43506282417, 75310.62344688241, 95823.0, 95844.52077739566, 95998.52000739952, 96292.51853740687, 52038.0, 85565.57217213999, 86320.56839715887, 89245.0, 89627.65558516627, 9169.174774270348, 9179.954100229455, 9249.398789078688, 9300.627974880928, 9311.706782827543, 49988.25017624811, 50068.24897626611, 50591.49408505868, 51664.74167629138, 52576.474235257156, 52362.0, 75640.62179689066, 76340.0, 77351.61324193569, 78273.60863195875, 12331.876681233072, 12579.496820127459, 12673.176243544509, 12872.16330938486, 12953.287569183785, 13609.0, 13621.0, 13968.930155349159, 14104.224267665377, 14118.78821817653, 12656.6835829105, 13051.151675141085, 13317.667058323232, 13517.391717372939, 13555.728885422039, 12381.75236495247, 12407.447057476202, 12548.811767823307, 12796.488140474277, 12873.163244389085, 12124.454399551865, 13020.934895325463, 13273.070885038342, 13298.135621184592, 13312.733745324846, 10653.840192396965, 10929.508172132115, 10945.671629851116, 10947.397893115636, 11286.322820630789, 9637.71086867395, 10265.84601230997, 10531.684049478528, 10687.51906164209, 10773.245872789143], "value": 7526.346548343379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 138.0, 159.0, 173.0, 135.0, 153.0, 169.0, 134.0, 193.0, 128.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 163.0, 162.0, 163.0, 179.0, 163.0, 164.0, 165.0, 162.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 171.0, 76.0, 75.0, 76.0, 76.0, 158.0, 78.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 95.0, 147.0, 85.0, 85.0, 84.0, 151.0, 86.0, 86.0, 146.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 120.0, 117.0, 116.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 149.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 60.0, 58.0, 58.0, 57.0, 56.0, 54.0, 55.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 87.0, 81.0, 82.0, 81.0, 81.0, 82.0, 104.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 131.0, 127.0, 121.0, 132.0, 125.0, 133.0, 132.0, 123.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 159.0, 159.0, 161.0, 163.0, 157.0, 161.0, 169.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 63.0, 71.0, 63.0, 63.0, 64.0, 63.0, 63.0], "value": 64.7, "unit": "score"}]}]} 02:40:26 INFO - Return code: 0 02:40:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:26 ERROR - # TBPL SUCCESS # 02:40:26 INFO - Running post-action listener: _resource_record_post_action 02:40:26 INFO - ##### 02:40:26 INFO - ##### Finished run-tests step (success) 02:40:26 INFO - ##### 02:40:26 INFO - Running post-run listener: _resource_record_post_run 02:40:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547663872; Read time: 12; Write time: 482232 02:40:26 INFO - TinderboxPrint: CPU usage
13.4% 02:40:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:40:26 INFO - TinderboxPrint: I/O write bytes / time
547,663,872 / 482,232 02:40:26 INFO - TinderboxPrint: CPU idle
8,232.4 (86.6%) 02:40:26 INFO - TinderboxPrint: CPU user
1,221.1 (12.8%) 02:40:26 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253812736; Read time: 0; Write time: 294816 02:40:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292589568; Read time: 12; Write time: 187264 02:40:27 INFO - Running post-run listener: _upload_blobber_files 02:40:27 INFO - Blob upload gear active. 02:40:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:27 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:40:27 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:40:27 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:40:27 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:40:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:40:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:28 INFO - (blobuploader) - INFO - Done attempting. 02:40:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:40:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:29 INFO - (blobuploader) - INFO - Done attempting. 02:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:32 INFO - (blobuploader) - INFO - Done attempting. 02:40:32 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:32 INFO - Return code: 0 02:40:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef191384784c5c9344ce876f071f19fca5655c32eadfa51731d05fa98c9a8f7f4285cc034eedfd19befc819a986fc4914d9c66d91494c6ebc9552439e45f9f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a3a699753d4cacc3fdd999d7b7202895bf4f790ec3fe62608eaac86306dc40e476a7378ff146706c3d76375874bc9c6ad4611de8e51d7b9ae3a5c0178110b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98509146949b913ab5530a15097bb081765381bc836d2b7fc4501ba93163cd8ab91dd3e4b98ab7a86fd5a1dc1ec8750d7152a09c81777b0147fdb7ca283391d"} 02:40:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:32 INFO - Contents: 02:40:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef191384784c5c9344ce876f071f19fca5655c32eadfa51731d05fa98c9a8f7f4285cc034eedfd19befc819a986fc4914d9c66d91494c6ebc9552439e45f9f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a3a699753d4cacc3fdd999d7b7202895bf4f790ec3fe62608eaac86306dc40e476a7378ff146706c3d76375874bc9c6ad4611de8e51d7b9ae3a5c0178110b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98509146949b913ab5530a15097bb081765381bc836d2b7fc4501ba93163cd8ab91dd3e4b98ab7a86fd5a1dc1ec8750d7152a09c81777b0147fdb7ca283391d"} 02:40:32 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:32 INFO - Copying logs to upload dir... 02:40:32 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.197711 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 02:40:32.858800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:32.863005) ========= 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-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef191384784c5c9344ce876f071f19fca5655c32eadfa51731d05fa98c9a8f7f4285cc034eedfd19befc819a986fc4914d9c66d91494c6ebc9552439e45f9f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a3a699753d4cacc3fdd999d7b7202895bf4f790ec3fe62608eaac86306dc40e476a7378ff146706c3d76375874bc9c6ad4611de8e51d7b9ae3a5c0178110b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98509146949b913ab5530a15097bb081765381bc836d2b7fc4501ba93163cd8ab91dd3e4b98ab7a86fd5a1dc1ec8750d7152a09c81777b0147fdb7ca283391d"} build_url:https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef191384784c5c9344ce876f071f19fca5655c32eadfa51731d05fa98c9a8f7f4285cc034eedfd19befc819a986fc4914d9c66d91494c6ebc9552439e45f9f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a3a699753d4cacc3fdd999d7b7202895bf4f790ec3fe62608eaac86306dc40e476a7378ff146706c3d76375874bc9c6ad4611de8e51d7b9ae3a5c0178110b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98509146949b913ab5530a15097bb081765381bc836d2b7fc4501ba93163cd8ab91dd3e4b98ab7a86fd5a1dc1ec8750d7152a09c81777b0147fdb7ca283391d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:32.890434) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:32.890775) ========= 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-1465463995.596697-41213578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:32.974568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:40:32.975142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:40:32.975705) ========= ========= Total master_lag: 0.19 =========