builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1465463965.3 results: success (0) buildid: 20160608233033 builduid: 6ed1ef468a554f849a6e001d1fea6907 revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.300392) ========= 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:25.300848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.301127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.329918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.330323) ========= 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=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 02:19:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.1M=0s 2016-06-09 02:19:25 (58.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.450900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.451221) ========= 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=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015043 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:25.501163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:19:25.501526) ========= 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=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 02:19:25,514 truncating revision to first 12 chars 2016-06-09 02:19:25,515 Setting DEBUG logging. 2016-06-09 02:19:25,515 attempt 1/10 2016-06-09 02:19:25,515 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:26,260 unpacking tar archive at: fx-team-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:19:26.583920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:26.584261) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:26.584649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:26.584918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:19:26.595354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 02:19:26.595802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:26 INFO - MultiFileLogger online at 20160609 02:19:26 in /builds/slave/test 02:19:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:19:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:26 INFO - {'append_to_log': False, 02:19:26 INFO - 'base_work_dir': '/builds/slave/test', 02:19:26 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:26 INFO - 'branch': 'Fx-Team', 02:19:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:26 INFO - 'config_files': ('talos/linux_config.py',), 02:19:26 INFO - 'default_actions': ('clobber', 02:19:26 INFO - 'read-buildbot-config', 02:19:26 INFO - 'download-and-extract', 02:19:26 INFO - 'populate-webroot', 02:19:26 INFO - 'create-virtualenv', 02:19:26 INFO - 'install', 02:19:26 INFO - 'run-tests'), 02:19:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:26 INFO - 'download_minidump_stackwalk': True, 02:19:26 INFO - 'download_symbols': 'ondemand', 02:19:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:26 INFO - 'installer_path': 'installer.exe', 02:19:26 INFO - 'log_level': 'info', 02:19:26 INFO - 'log_name': 'talos', 02:19:26 INFO - 'log_to_console': True, 02:19:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:26 INFO - 'opt_config_files': (), 02:19:26 INFO - 'pip_index': False, 02:19:26 INFO - 'sps_profile': False, 02:19:26 INFO - 'sps_profile_interval': 0, 02:19:26 INFO - 'suite': 'dromaeojs', 02:19:26 INFO - 'system_bits': '32', 02:19:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:26 INFO - 'title': 'talos-linux64-ix-008', 02:19:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:26 INFO - 'use_talos_json': True, 02:19:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:26 INFO - 'work_dir': 'build'} 02:19:26 INFO - ##### 02:19:26 INFO - ##### Running clobber step. 02:19:26 INFO - ##### 02:19:26 INFO - Running pre-action listener: _resource_record_pre_action 02:19:26 INFO - Running main action method: clobber 02:19:26 INFO - rmtree: /builds/slave/test/build 02:19:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:27 INFO - Running post-action listener: _resource_record_post_action 02:19:27 INFO - ##### 02:19:27 INFO - ##### Finished clobber step (success) 02:19:27 INFO - ##### 02:19:27 INFO - ##### 02:19:27 INFO - ##### Running read-buildbot-config step. 02:19:27 INFO - ##### 02:19:27 INFO - Running pre-action listener: _resource_record_pre_action 02:19:27 INFO - Running main action method: read_buildbot_config 02:19:27 INFO - Using buildbot properties: 02:19:27 INFO - { 02:19:27 INFO - "project": "", 02:19:27 INFO - "product": "firefox", 02:19:27 INFO - "script_repo_revision": "production", 02:19:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:19:27 INFO - "repository": "", 02:19:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:19:27 INFO - "buildid": "20160608233033", 02:19:27 INFO - "pgo_build": "True", 02:19:27 INFO - "basedir": "/builds/slave/test", 02:19:27 INFO - "buildnumber": 787, 02:19:27 INFO - "slavename": "talos-linux64-ix-008", 02:19:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:19:27 INFO - "platform": "ubuntu64_hw", 02:19:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:19:27 INFO - "branch": "fx-team", 02:19:27 INFO - "repo_path": "integration/fx-team", 02:19:27 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 02:19:27 INFO - "stage_platform": "linux64-pgo", 02:19:27 INFO - "builduid": "6ed1ef468a554f849a6e001d1fea6907", 02:19:27 INFO - "slavebuilddir": "test" 02:19:27 INFO - } 02:19:27 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:27 INFO - Running post-action listener: _resource_record_post_action 02:19:27 INFO - ##### 02:19:27 INFO - ##### Finished read-buildbot-config step (success) 02:19:27 INFO - ##### 02:19:27 INFO - ##### 02:19:27 INFO - ##### Running download-and-extract step. 02:19:27 INFO - ##### 02:19:27 INFO - Running pre-action listener: _resource_record_pre_action 02:19:27 INFO - Running main action method: download_and_extract 02:19:27 INFO - mkdir: /builds/slave/test/build/tests 02:19: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:19:27 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:27 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:27 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:27 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:27 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:19:28 INFO - Downloaded 1361 bytes. 02:19:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:28 INFO - Using the following test package requirements: 02:19:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:19:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:19:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'jsshell-linux-x86_64.zip'], 02:19:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:19:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:19:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:19:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:19:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:19:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:19:28 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:28 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:19:28 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:19:28 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:19:28 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:19:28 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:19:29 INFO - Downloaded 24451237 bytes. 02:19:29 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:19:29 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:19:30 INFO - Return code: 0 02:19:30 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:19: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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:33 INFO - Downloaded 24451237 bytes. 02:19:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:19:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:19:34 INFO - Return code: 0 02:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:34 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:19:34 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:19:34 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:19:34 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:19:34 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:19:35 INFO - Downloaded 10833369 bytes. 02:19:35 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:19:35 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:19:36 INFO - Return code: 0 02:19:36 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:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:37 INFO - Downloaded 59319784 bytes. 02:19:37 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:19:37 INFO - mkdir: /builds/slave/test/properties 02:19:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:37 INFO - Contents: 02:19:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:38 INFO - Running post-action listener: _resource_record_post_action 02:19:38 INFO - Running post-action listener: set_extra_try_arguments 02:19:38 INFO - ##### 02:19:38 INFO - ##### Finished download-and-extract step (success) 02:19:38 INFO - ##### 02:19:38 INFO - ##### 02:19:38 INFO - ##### Running populate-webroot step. 02:19:38 INFO - ##### 02:19:38 INFO - Running pre-action listener: _resource_record_pre_action 02:19:38 INFO - Running main action method: populate_webroot 02:19:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:38 INFO - '--tppagecycles', 02:19:38 INFO - '7'], 02:19:38 INFO - 'tests': ['tsvgm']}}, 02:19:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['damp', 'tps']}, 02:19:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'tests': ['damp', 'tps']}, 02:19:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['dromaeo_dom']}, 02:19:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['a11yr', 02:19:38 INFO - 'ts_paint', 02:19:38 INFO - 'tpaint', 02:19:38 INFO - 'sessionrestore', 02:19:38 INFO - 'sessionrestore_no_auto_restore', 02:19:38 INFO - 'tabpaint']}, 02:19:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['tsvgx', 02:19:38 INFO - 'tsvgr_opacity', 02:19:38 INFO - 'tart', 02:19:38 INFO - 'tscrollx', 02:19:38 INFO - 'cart']}, 02:19:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:38 INFO - 'tsvgr_opacity', 02:19:38 INFO - 'tart', 02:19:38 INFO - 'tscrollx', 02:19:38 INFO - 'cart']}, 02:19:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'talos_options': ['--disable-e10s'], 02:19:38 INFO - 'tests': ['tp5o']}, 02:19:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'tests': ['tp5o']}, 02:19:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'talos_options': ['--disable-e10s', 02:19:38 INFO - '--xperf_path', 02:19:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:38 INFO - 'tests': ['tp5n']}, 02:19:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:38 INFO - 'talos_options': ['--xperf_path', 02:19:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:38 INFO - 'tests': ['tp5n']}}, 02:19:38 INFO - 'talos.zip': {'path': '', 02:19:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:38 INFO - Running post-action listener: _resource_record_post_action 02:19:38 INFO - ##### 02:19:38 INFO - ##### Finished populate-webroot step (success) 02:19:38 INFO - ##### 02:19:38 INFO - ##### 02:19:38 INFO - ##### Running create-virtualenv step. 02:19:38 INFO - ##### 02:19:38 INFO - Running pre-action listener: _resource_record_pre_action 02:19:38 INFO - Running main action method: create_virtualenv 02:19:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:38 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:19:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:38 INFO - Using real prefix '/usr' 02:19:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:40 INFO - Installing pip.................done. 02:19:40 INFO - Return code: 0 02:19:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:40 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:40 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:19:40 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:19:40 INFO - Using env: {'DISPLAY': ':0', 02:19:40 INFO - 'HOME': '/home/cltbld', 02:19:40 INFO - 'LANG': 'en_US.UTF-8', 02:19:40 INFO - 'LANGUAGE': 'en_US:en', 02:19:40 INFO - 'LOGNAME': 'cltbld', 02:19:40 INFO - 'MAIL': '/var/mail/cltbld', 02:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:40 INFO - 'MOZ_NO_REMOTE': '1', 02:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:40 INFO - 'NO_EM_RESTART': '1', 02:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:40 INFO - 'PWD': '/builds/slave/test', 02:19:40 INFO - 'SHELL': '/bin/bash', 02:19:40 INFO - 'SHLVL': '1', 02:19:40 INFO - 'TERM': 'linux', 02:19:40 INFO - 'TMOUT': '86400', 02:19:40 INFO - 'USER': 'cltbld', 02:19:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:40 INFO - '_': '/tools/buildbot/bin/python'} 02:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:41 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:19:41 INFO - Cleaning up... 02:19:41 INFO - Return code: 0 02:19:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:41 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:41 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:19:41 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:19:41 INFO - Using env: {'DISPLAY': ':0', 02:19:41 INFO - 'HOME': '/home/cltbld', 02:19:41 INFO - 'LANG': 'en_US.UTF-8', 02:19:41 INFO - 'LANGUAGE': 'en_US:en', 02:19:41 INFO - 'LOGNAME': 'cltbld', 02:19:41 INFO - 'MAIL': '/var/mail/cltbld', 02:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:41 INFO - 'MOZ_NO_REMOTE': '1', 02:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:41 INFO - 'NO_EM_RESTART': '1', 02:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:41 INFO - 'PWD': '/builds/slave/test', 02:19:41 INFO - 'SHELL': '/bin/bash', 02:19:41 INFO - 'SHLVL': '1', 02:19:41 INFO - 'TERM': 'linux', 02:19:41 INFO - 'TMOUT': '86400', 02:19:41 INFO - 'USER': 'cltbld', 02:19:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:41 INFO - '_': '/tools/buildbot/bin/python'} 02:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:41 INFO - Downloading/unpacking psutil>=3.1.1 02:19:41 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:19:41 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:19:41 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:19:41 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:19:41 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:19:41 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:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:43 INFO - Installing collected packages: psutil 02:19:43 INFO - Running setup.py install for psutil 02:19:43 INFO - building 'psutil._psutil_linux' extension 02:19:43 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:19:43 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:19:43 INFO - building 'psutil._psutil_posix' extension 02:19:43 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:19:43 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:19:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:43 INFO - Successfully installed psutil 02:19:43 INFO - Cleaning up... 02:19:43 INFO - Return code: 0 02:19:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:43 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:43 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:19:43 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:19:43 INFO - Using env: {'DISPLAY': ':0', 02:19:43 INFO - 'HOME': '/home/cltbld', 02:19:43 INFO - 'LANG': 'en_US.UTF-8', 02:19:43 INFO - 'LANGUAGE': 'en_US:en', 02:19:43 INFO - 'LOGNAME': 'cltbld', 02:19:43 INFO - 'MAIL': '/var/mail/cltbld', 02:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:43 INFO - 'MOZ_NO_REMOTE': '1', 02:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:43 INFO - 'NO_EM_RESTART': '1', 02:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:43 INFO - 'PWD': '/builds/slave/test', 02:19:43 INFO - 'SHELL': '/bin/bash', 02:19:43 INFO - 'SHLVL': '1', 02:19:43 INFO - 'TERM': 'linux', 02:19:43 INFO - 'TMOUT': '86400', 02:19:43 INFO - 'USER': 'cltbld', 02:19:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:43 INFO - '_': '/tools/buildbot/bin/python'} 02:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:44 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:19:44 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:19:44 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:19:44 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:19:44 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:19:44 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:19:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:45 INFO - Installing collected packages: mozsystemmonitor 02:19:45 INFO - Running setup.py install for mozsystemmonitor 02:19:46 INFO - Successfully installed mozsystemmonitor 02:19:46 INFO - Cleaning up... 02:19:46 INFO - Return code: 0 02:19:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:19:46 INFO - Using env: {'DISPLAY': ':0', 02:19:46 INFO - 'HOME': '/home/cltbld', 02:19:46 INFO - 'LANG': 'en_US.UTF-8', 02:19:46 INFO - 'LANGUAGE': 'en_US:en', 02:19:46 INFO - 'LOGNAME': 'cltbld', 02:19:46 INFO - 'MAIL': '/var/mail/cltbld', 02:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:46 INFO - 'MOZ_NO_REMOTE': '1', 02:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:46 INFO - 'NO_EM_RESTART': '1', 02:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:46 INFO - 'PWD': '/builds/slave/test', 02:19:46 INFO - 'SHELL': '/bin/bash', 02:19:46 INFO - 'SHLVL': '1', 02:19:46 INFO - 'TERM': 'linux', 02:19:46 INFO - 'TMOUT': '86400', 02:19:46 INFO - 'USER': 'cltbld', 02:19:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:46 INFO - '_': '/tools/buildbot/bin/python'} 02:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:48 INFO - warning: no files found matching '*.txt' 02:19:48 INFO - no previously-included directories found matching 'build' 02:19:48 INFO - no previously-included directories found matching 'dist' 02:19:48 INFO - no previously-included directories found matching '.git*' 02:19:48 INFO - Installing collected packages: jsonschema, functools32 02:19:48 INFO - Running setup.py install for functools32 02:19:48 INFO - warning: no files found matching '*.txt' 02:19:48 INFO - no previously-included directories found matching 'build' 02:19:48 INFO - no previously-included directories found matching 'dist' 02:19:48 INFO - no previously-included directories found matching '.git*' 02:19:48 INFO - Successfully installed jsonschema functools32 02:19:48 INFO - Cleaning up... 02:19:48 INFO - Return code: 0 02:19:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:19:48 INFO - Using env: {'DISPLAY': ':0', 02:19:48 INFO - 'HOME': '/home/cltbld', 02:19:48 INFO - 'LANG': 'en_US.UTF-8', 02:19:48 INFO - 'LANGUAGE': 'en_US:en', 02:19:48 INFO - 'LOGNAME': 'cltbld', 02:19:48 INFO - 'MAIL': '/var/mail/cltbld', 02:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:48 INFO - 'MOZ_NO_REMOTE': '1', 02:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:48 INFO - 'NO_EM_RESTART': '1', 02:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:48 INFO - 'PWD': '/builds/slave/test', 02:19:48 INFO - 'SHELL': '/bin/bash', 02:19:48 INFO - 'SHLVL': '1', 02:19:48 INFO - 'TERM': 'linux', 02:19:48 INFO - 'TMOUT': '86400', 02:19:48 INFO - 'USER': 'cltbld', 02:19:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:48 INFO - '_': '/tools/buildbot/bin/python'} 02:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:51 INFO - Downloading docopt-0.6.1.tar.gz 02:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:51 INFO - Running setup.py install for blobuploader 02:19:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:51 INFO - Running setup.py install for requests 02:19:51 INFO - Running setup.py install for docopt 02:19:52 INFO - Successfully installed blobuploader requests docopt 02:19:52 INFO - Cleaning up... 02:19:52 INFO - Return code: 0 02:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:52 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:19:52 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:19:52 INFO - Using env: {'DISPLAY': ':0', 02:19:52 INFO - 'HOME': '/home/cltbld', 02:19:52 INFO - 'LANG': 'en_US.UTF-8', 02:19:52 INFO - 'LANGUAGE': 'en_US:en', 02:19:52 INFO - 'LOGNAME': 'cltbld', 02:19:52 INFO - 'MAIL': '/var/mail/cltbld', 02:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:52 INFO - 'MOZ_NO_REMOTE': '1', 02:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:52 INFO - 'NO_EM_RESTART': '1', 02:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:52 INFO - 'PWD': '/builds/slave/test', 02:19:52 INFO - 'SHELL': '/bin/bash', 02:19:52 INFO - 'SHLVL': '1', 02:19:52 INFO - 'TERM': 'linux', 02:19:52 INFO - 'TMOUT': '86400', 02:19:52 INFO - 'USER': 'cltbld', 02:19:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:52 INFO - '_': '/tools/buildbot/bin/python'} 02:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:52 INFO - Running setup.py (path:/tmp/pip-rYpPuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:52 INFO - Running setup.py (path:/tmp/pip-U98HXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:52 INFO - Running setup.py (path:/tmp/pip-60czZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:52 INFO - Running setup.py (path:/tmp/pip-Dhoz4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:52 INFO - Running setup.py (path:/tmp/pip-YIOBjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:52 INFO - Running setup.py (path:/tmp/pip-jXOrBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:52 INFO - Running setup.py (path:/tmp/pip-qrlZ6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:52 INFO - Running setup.py (path:/tmp/pip-aMxR3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:52 INFO - Running setup.py (path:/tmp/pip-Slj0uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:53 INFO - Running setup.py (path:/tmp/pip-R73xET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:53 INFO - Running setup.py (path:/tmp/pip-Ck4612-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:53 INFO - Running setup.py (path:/tmp/pip-ElmJ_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:53 INFO - Running setup.py (path:/tmp/pip-3BGmKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:53 INFO - Running setup.py (path:/tmp/pip-hEthzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:53 INFO - Running setup.py (path:/tmp/pip-y0LSxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:53 INFO - Running setup.py (path:/tmp/pip-98obhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:53 INFO - Running setup.py (path:/tmp/pip-lk4nIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:53 INFO - Running setup.py install for manifestparser 02:19:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:53 INFO - Running setup.py install for mozcrash 02:19:53 INFO - Running setup.py install for mozdebug 02:19:53 INFO - Running setup.py install for mozdevice 02:19:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:19:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:53 INFO - Running setup.py install for mozfile 02:19:54 INFO - Running setup.py install for mozhttpd 02:19:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for mozinfo 02:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for mozInstall 02:19:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for mozleak 02:19:54 INFO - Running setup.py install for mozlog 02:19:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for moznetwork 02:19:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for mozprocess 02:19:54 INFO - Running setup.py install for mozprofile 02:19:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:54 INFO - Running setup.py install for mozrunner 02:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:55 INFO - Running setup.py install for mozscreenshot 02:19:55 INFO - Running setup.py install for moztest 02:19:55 INFO - Running setup.py install for mozversion 02:19:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:55 INFO - Cleaning up... 02:19:55 INFO - Return code: 0 02:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:55 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:55 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:19:55 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:19:55 INFO - Using env: {'DISPLAY': ':0', 02:19:55 INFO - 'HOME': '/home/cltbld', 02:19:55 INFO - 'LANG': 'en_US.UTF-8', 02:19:55 INFO - 'LANGUAGE': 'en_US:en', 02:19:55 INFO - 'LOGNAME': 'cltbld', 02:19:55 INFO - 'MAIL': '/var/mail/cltbld', 02:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:55 INFO - 'MOZ_NO_REMOTE': '1', 02:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:55 INFO - 'NO_EM_RESTART': '1', 02:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:55 INFO - 'PWD': '/builds/slave/test', 02:19:55 INFO - 'SHELL': '/bin/bash', 02:19:55 INFO - 'SHLVL': '1', 02:19:55 INFO - 'TERM': 'linux', 02:19:55 INFO - 'TMOUT': '86400', 02:19:55 INFO - 'USER': 'cltbld', 02:19:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:55 INFO - '_': '/tools/buildbot/bin/python'} 02:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:55 INFO - Running setup.py (path:/tmp/pip-9dEczg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:55 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:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:55 INFO - Running setup.py (path:/tmp/pip-vLYd80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:55 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:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:55 INFO - Running setup.py (path:/tmp/pip-G3ogbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:55 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:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:55 INFO - Running setup.py (path:/tmp/pip-2knVMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:55 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:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:55 INFO - Running setup.py (path:/tmp/pip-_sb9cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:55 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:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:55 INFO - Running setup.py (path:/tmp/pip-_kygIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:56 INFO - Running setup.py (path:/tmp/pip-Grf4b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:56 INFO - Running setup.py (path:/tmp/pip-_kNMaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:56 INFO - Running setup.py (path:/tmp/pip-qLok1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:56 INFO - Running setup.py (path:/tmp/pip-26zDQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:56 INFO - Running setup.py (path:/tmp/pip-rYQCIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:56 INFO - Running setup.py (path:/tmp/pip-yJxcVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:56 INFO - Running setup.py (path:/tmp/pip-ylVOLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:56 INFO - Running setup.py (path:/tmp/pip-TpNd86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:56 INFO - Running setup.py (path:/tmp/pip-WfqVPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:56 INFO - Running setup.py (path:/tmp/pip-WLflwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:56 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:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:56 INFO - Running setup.py (path:/tmp/pip-NmGKW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:56 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:19:56 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:19:56 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:19:56 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:19:56 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:19:56 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:19:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:58 INFO - Downloading blessings-1.6.tar.gz 02:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:58 INFO - Installing collected packages: blessings 02:19:58 INFO - Running setup.py install for blessings 02:19:58 INFO - Successfully installed blessings 02:19:58 INFO - Cleaning up... 02:19:58 INFO - Return code: 0 02:19:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:59 INFO - Reading from file tmpfile_stdout 02:19:59 INFO - Current package versions: 02:19:59 INFO - argparse == 1.2.1 02:19:59 INFO - blessings == 1.6 02:19:59 INFO - blobuploader == 1.2.4 02:19:59 INFO - docopt == 0.6.1 02:19:59 INFO - functools32 == 3.2.3-2 02:19:59 INFO - jsonschema == 2.5.1 02:19:59 INFO - manifestparser == 1.1 02:19:59 INFO - mozInstall == 1.12 02:19:59 INFO - mozcrash == 0.17 02:19:59 INFO - mozdebug == 0.1 02:19:59 INFO - mozdevice == 0.48 02:19:59 INFO - mozfile == 1.2 02:19:59 INFO - mozhttpd == 0.7 02:19:59 INFO - mozinfo == 0.9 02:19:59 INFO - mozleak == 0.1 02:19:59 INFO - mozlog == 3.2 02:19:59 INFO - moznetwork == 0.27 02:19:59 INFO - mozprocess == 0.22 02:19:59 INFO - mozprofile == 0.28 02:19:59 INFO - mozrunner == 6.11 02:19:59 INFO - mozscreenshot == 0.1 02:19:59 INFO - mozsystemmonitor == 0.3 02:19:59 INFO - moztest == 0.7 02:19:59 INFO - mozversion == 1.4 02:19:59 INFO - psutil == 3.1.1 02:19:59 INFO - requests == 1.2.3 02:19:59 INFO - wsgiref == 0.1.2 02:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:59 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:19:59 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:19:59 INFO - Using env: {'DISPLAY': ':0', 02:19:59 INFO - 'HOME': '/home/cltbld', 02:19:59 INFO - 'LANG': 'en_US.UTF-8', 02:19:59 INFO - 'LANGUAGE': 'en_US:en', 02:19:59 INFO - 'LOGNAME': 'cltbld', 02:19:59 INFO - 'MAIL': '/var/mail/cltbld', 02:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:59 INFO - 'MOZ_NO_REMOTE': '1', 02:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:59 INFO - 'NO_EM_RESTART': '1', 02:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:59 INFO - 'PWD': '/builds/slave/test', 02:19:59 INFO - 'SHELL': '/bin/bash', 02:19:59 INFO - 'SHLVL': '1', 02:19:59 INFO - 'TERM': 'linux', 02:19:59 INFO - 'TMOUT': '86400', 02:19:59 INFO - 'USER': 'cltbld', 02:19:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:59 INFO - '_': '/tools/buildbot/bin/python'} 02:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 INFO - Cleaning up... 02:19:59 INFO - Return code: 0 02:19:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:59 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:19:59 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:19:59 INFO - Using env: {'DISPLAY': ':0', 02:19:59 INFO - 'HOME': '/home/cltbld', 02:19:59 INFO - 'LANG': 'en_US.UTF-8', 02:19:59 INFO - 'LANGUAGE': 'en_US:en', 02:19:59 INFO - 'LOGNAME': 'cltbld', 02:19:59 INFO - 'MAIL': '/var/mail/cltbld', 02:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:59 INFO - 'MOZ_NO_REMOTE': '1', 02:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:59 INFO - 'NO_EM_RESTART': '1', 02:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:59 INFO - 'PWD': '/builds/slave/test', 02:19:59 INFO - 'SHELL': '/bin/bash', 02:19:59 INFO - 'SHLVL': '1', 02:19:59 INFO - 'TERM': 'linux', 02:19:59 INFO - 'TMOUT': '86400', 02:19:59 INFO - 'USER': 'cltbld', 02:19:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:59 INFO - '_': '/tools/buildbot/bin/python'} 02:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:59 INFO - Cleaning up... 02:19:59 INFO - Return code: 0 02:19:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:19:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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 0x7fe49a9d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2007350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, '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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', '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:19:59 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:19:59 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:19:59 INFO - Using env: {'DISPLAY': ':0', 02:19:59 INFO - 'HOME': '/home/cltbld', 02:19:59 INFO - 'LANG': 'en_US.UTF-8', 02:19:59 INFO - 'LANGUAGE': 'en_US:en', 02:19:59 INFO - 'LOGNAME': 'cltbld', 02:19:59 INFO - 'MAIL': '/var/mail/cltbld', 02:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:59 INFO - 'MOZ_NO_REMOTE': '1', 02:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:59 INFO - 'NO_EM_RESTART': '1', 02:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:59 INFO - 'PWD': '/builds/slave/test', 02:19:59 INFO - 'SHELL': '/bin/bash', 02:19:59 INFO - 'SHLVL': '1', 02:19:59 INFO - 'TERM': 'linux', 02:19:59 INFO - 'TMOUT': '86400', 02:19:59 INFO - 'USER': 'cltbld', 02:19:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:59 INFO - '_': '/tools/buildbot/bin/python'} 02:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:59 INFO - Downloading/unpacking flake8 02:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20:01 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:01 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:01 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:01 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:01 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:01 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:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20:01 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:01 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:01 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:01 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:01 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:01 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:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:02 INFO - no previously-included directories found matching 'docs/_build' 02:20:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:02 INFO - Running setup.py install for pep8 02:20:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:02 INFO - no previously-included directories found matching 'docs/_build' 02:20:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:02 INFO - Cleaning up... 02:20:02 INFO - Return code: 0 02:20:02 INFO - Running post-action listener: _resource_record_post_action 02:20:02 INFO - Running post-action listener: _start_resource_monitoring 02:20:02 INFO - Starting resource monitoring. 02:20:02 INFO - ##### 02:20:02 INFO - ##### Finished create-virtualenv step (success) 02:20:02 INFO - ##### 02:20:02 INFO - ##### 02:20:02 INFO - ##### Running install step. 02:20:02 INFO - ##### 02:20:02 INFO - Running pre-action listener: _resource_record_pre_action 02:20:02 INFO - Running main action method: install 02:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:02 INFO - Reading from file tmpfile_stdout 02:20:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:03 INFO - Reading from file tmpfile_stdout 02:20:03 INFO - Output received: 02:20:03 INFO - Usage: mozinstall [options] installer 02:20:03 INFO - Options: 02:20:03 INFO - -h, --help show this help message and exit 02:20:03 INFO - -d DEST, --destination=DEST 02:20:03 INFO - Directory to install application into. [default: 02:20:03 INFO - "/builds/slave/test"] 02:20:03 INFO - --app=APP Application being installed. [default: firefox] 02:20:03 INFO - mkdir: /builds/slave/test/build/application 02:20:03 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:03 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:19 INFO - Reading from file tmpfile_stdout 02:20:19 INFO - Output received: 02:20:19 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:19 INFO - Running post-action listener: _resource_record_post_action 02:20:19 INFO - ##### 02:20:19 INFO - ##### Finished install step (success) 02:20:19 INFO - ##### 02:20:19 INFO - ##### 02:20:19 INFO - ##### Running run-tests step. 02:20:19 INFO - ##### 02:20:19 INFO - Running pre-action listener: _resource_record_pre_action 02:20:19 INFO - Running main action method: run_tests 02:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:19 INFO - Python 2.7.3 02:20:19 INFO - Return code: 0 02:20:19 INFO - grabbing minidump binary from tooltool 02:20:19 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:19 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 0x20961c0>, '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 0x20970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2097550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:19 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:19 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:19 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:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:19 INFO - Return code: 0 02:20:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:20:20 INFO - Return code: 0 02:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02: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 - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:20 INFO - 'MOZ_NO_REMOTE': '1', 02:20:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 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': '/builds/slave/test/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 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': '32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540', 02:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:20 INFO - '_': '/tools/buildbot/bin/python'} 02:20:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:20:21 INFO - mozversion application_buildid: 20160608233033 02:20:21 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:20:21 INFO - mozversion application_display_name: Nightly 02:20:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:21 INFO - mozversion application_name: Firefox 02:20:21 INFO - mozversion application_remotingname: firefox 02:20:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:21 INFO - mozversion application_vendor: Mozilla 02:20:21 INFO - mozversion application_version: 50.0a1 02:20:21 INFO - mozversion platform_buildid: 20160608233033 02:20:21 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:20:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:21 INFO - mozversion platform_version: 50.0a1 02:20:21 INFO - using testdate: 1465464021 02:20:21 INFO - actual date: 1465464021 02:20:21 INFO - starting webserver on 'localhost:34267' 02:20:21 INFO - SUITE-START | Running 2 tests 02:20:21 INFO - TEST-START | dromaeo_css 02:20:21 INFO - operating with platform_type : linux_ 02:20:21 INFO - Initialising browser for dromaeo_css test... 02:20:21 INFO - TEST-INFO | started process 8063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQNN5P/profile http://localhost:34267/getInfo.html) 02:20:25 INFO - PROCESS | 8063 | __metrics Screen width/height:1600/1200 02:20:25 INFO - PROCESS | 8063 | colorDepth:24 02:20:25 INFO - PROCESS | 8063 | Browser inner width/height: 1024/697 02:20:25 INFO - PROCESS | 8063 | __metrics 02:20:26 ERROR - PROCESS | 8063 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:20:26 INFO - PROCESS | 8063 | console.error: PushService: 02:20:26 INFO - PROCESS | 8063 | stateChangeProcessEnqueue: Error transitioning state 02:20:26 INFO - PROCESS | 8063 | UnknownError 02:20:26 INFO - TEST-INFO | 8063: exit 0 02:20:26 INFO - Browser initialized. 02:20:26 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:26 INFO - TEST-INFO | started process 8146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQNN5P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:38 INFO - PROCESS | 8146 | RSS: Main: 157155328 02:20:38 INFO - PROCESS | 8146 | 02:21:30 INFO - PROCESS | 8146 | 1465464090199 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:23:38 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34267/tests/dromaeo/cssquery-ext.html) 02:23:39 INFO - PROCESS | 8146 | RSS: Main: 291446784 02:23:39 INFO - PROCESS | 8146 | 02:26:42 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-ext.html (next: http://localhost:34267/tests/dromaeo/cssquery-jquery.html) 02:26:42 INFO - PROCESS | 8146 | RSS: Main: 236802048 02:26:42 INFO - PROCESS | 8146 | 02:29:44 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34267/tests/dromaeo/cssquery-mootools.html) 02:29:45 INFO - PROCESS | 8146 | RSS: Main: 250753024 02:29:45 INFO - PROCESS | 8146 | 02:32:47 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34267/tests/dromaeo/cssquery-prototype.html) 02:32:48 INFO - PROCESS | 8146 | RSS: Main: 240914432 02:32:48 INFO - PROCESS | 8146 | 02:35:50 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34267/tests/dromaeo/cssquery-yui.html) 02:35:51 INFO - PROCESS | 8146 | RSS: Main: 205152256 02:35:51 INFO - PROCESS | 8146 | 02:38:53 INFO - PROCESS | 8146 | Cycle 1(1): loaded http://localhost:34267/tests/dromaeo/cssquery-yui.html (next: http://localhost:34267/tests/dromaeo/cssquery-dojo.html) 02:38:54 INFO - PROCESS | 8146 | RSS: Main: 285102080 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | __start_tp_report 02:38:54 INFO - PROCESS | 8146 | _x_x_mozilla_page_load 02:38:54 INFO - PROCESS | 8146 | _x_x_mozilla_page_load_details 02:38:54 INFO - PROCESS | 8146 | |i|pagename|runs| 02:38:54 INFO - PROCESS | 8146 | |0;dojo.html;3171.7145456908875;3180.395724812287;3198;3208.823514706693;3243.935121297574;5358.33020872391;5383.138697808351;5444.537214336781;5477.5070243678065;5489.231507588941;5497;5521.1442226454865;5541.833744987647;5593.216949627055;5604.215409842615;4852.514748525155;4885.340479035338;4890;4980.701157930518;4985.052839960414;5054.7472626368535;5122.641415100945;5129.9230511542355;5141.228815677641;5171.793128274883;4860.756962151878;4914.410270767531;5054.873628159307;5056.949430505703;5076.46697096805;4988.900221995576;4988.925166122511;5002.124628190052;5006;5061.392632884041;4964.826231081931;5001.724905130216;5012.448630650625;5016.573591244749;5052;5259.2899958505495;5352.652077614943;5436.238926550286;5436.565074794046;5482.588805839578;5927.673977931212;5954.732037058343;5957.7319020643745;5981.58128930975;5983.940160598382;5964.373740757202;6008.519318454513;6022.819315420545;6024.397560243984;6030.427109424598;5388.73056347185;5450.781968721286;5501.284832971688;5627.774889004476;5638.830835074954;6037.909431358533;6053.969730151321;6075.574709770273;6075.787347442818;6079;5818.389069147764;5818.854528636818;5819.243498345188;5832.912506312408;5835.299764028344;5740.339860916049;5785.739641716133;5827.562932780059;5839.970800145972;5898.8820223595285;5792.507636850831;5827.708614569255;5846.0646296593195;5847.035239185572;5848.152017957373;5807.274090738658;5856.707164641751;5865.266841644794;5873.618214816023;5892.823215303548;4331.675124365685;4413.095315460323;4448.221561226773;4459.197344478025;4475.261581839025;3963.0290578808376;3972.106276087915;3977;4009.799510024487;4016.3172260715746;5319.388270348882;5494.5054945055135;5504.559635229172;5504.779808807683;5505.119180931032;5769.8557536061935;5787.305523337142;5835.620684655484;5856.238688970492;5938.109283607493;5448.645838020516;5456.154296084113;5457.345118585795;5460.071787796084;5464.371597266286;4993.101241776442;5058.46886076964;5069.138246498104;5071.06185355703;5118.436971933084;6012.398760123952;6048.758049678052;6056.06131049688;6103.511719062464;6105.145279660851;5922.763089476372;5932.377100404568;5935.851603709942;5936.406359364202;5938.940610594012;5836.153757705024;5980.671063091571;6091.086337049301;6102.725377358119;6109.816705498843;5781.103928891029;5804.593678442468;5811.099279611667;5829.183914252093;5851.795187168429;5801.8549536261935;5851.268591426072;5882.647041177543;5901.852453688693;5902.970485147718;5585.944140558705;5648.15277708347;5703.144528320619;5730.3410107838135;5745.626534275259;5722.828315150386;5724.084146536701;5725.34158571753;5733.913991290217;5760.366359700346;5633.690147041952;5634.070378387521;5642.943570564242;5645.689487078086;5646.040173170653;5605.467480589337;5632.408597097246;5689.061304884648;5716.628419152742;5766.625169363978;5539.169124631338;5603.523700485504;5621.4659607337235;5636.351819540805;5643.52030077448 02:38:54 INFO - PROCESS | 8146 | |1;ext.html;592.2123575644393;627.1001113402268;638.1576319258579;638.8850006998741;649.1042361541073;31258.687413125863;43082.35376469355;44148.33777493332;44226.55773442265;44263;45661.31508027374;46329;46385.53614463854;46393.76803115988;46411;7673;8854.513001784882;9022.188003079722;10405.063544281013;10681.198910081735;10592.25854190207;10688.091512221432;10689.412082335468;10690.78618427631;10700.197485188603;10753;10798.946005270001;10799.460026998659;10804.459777011158;10806.78386432271;8016.879746803774;10385.68842934717;10582.947085264525;10627.41549214793;11035.117190624811;10489.947550262199;10501;10503.10723588496;10579.788404231873;10584.206184536191;42019;42372.364414533804;42553.57446425527;42571.36142957858;42601.573984260074;3609.657082577151;3683.318586061587;3716.201016781405;3834.118152824838;4063.6545893599077;33093;33123;33135.834320828486;33418;34773.30453390943;4316.460442444694;4321.416608757809;4356.869293921156;4473.843415480475;4491.438570178728;346916;356063;357929;495863;504062.19533535134;60405;60723.392766072655;60844;60913;60960.39039609547;37989.81005094957;38819.6118038816;38917.61082389196;39011.2197756049;39026.804865975486;14788.778168327484;17138.14309284531;17313.653726925644;17382.130893455276;17389.130543472776;12922.224666520038;13119.278439685719;13128.474861005643;13423.194608323336;13464.865351346361;20008.099635516435;20100.195992160443;20112.09495572703;20112.49718757043;20172;7151.713931442684;7174.856502869913;7282.235365286569;7397.778066658009;7423.888641670379;919.1130559010587;1018.2821111116644;1018.6638409324905;1076.7577295108538;1164.9981016325953;29992.70007299943;32159.196020099684;32241.193970150463;32243;32783;1149.988500114988;1165.3008195083053;1192.5885569478517;1196.2045239915533;1289.239348784203;16933.576660583338;16967.236474358684;16975.74536381955;17065.91467042657;17092.2308496118;611225;616978;618392;620264;622081;58307.16928307135;59786.40213597808;59787;59787.701061494416;59846.40153598495;1269.8412698412699;1385.2658091211674;1392.484780631173;1423.8362588302477;1424.0387738276622;30508.694913050585;32519.674803252612;32574.511382329758;32640.673593264713;33067.17332066718;51096;51520.74239628928;51585.48414515957;51680;51716.224256635425;463260;464586;467187;471341;471902;24993.375165621004;27225.183244502696;27902.16293511198;28309.009184678438;29334.26664333409;48117.75941120272;49061.75469122775;49668;50177;50182;39707.40438893361;40262.39606405965;40625;40991.590084098774;41806;39773.801130995314;40727;40821;40999.38500922429;41357.1728565433;37219.44170837385;37453.81273093617;42020.1595968085;42075.57924420717;42088.78955605203;34201;36658;37412.625873740915;37433.25133497369;37871.05322366963;27547.31131721723;28112.71887281101;28193.859030704716;28226.85886570554;28231 02:38:54 INFO - PROCESS | 8146 | |2;jquery.html;371.53001453161744;385.2083967446897;387.7847794474068;398.45809698809614;411.87231958092974;17776.20007099682;18916.243350266006;19259.903700481515;19272.3254686086;19273.229070837166;18893.811061889377;18912.71630925537;18934.621307573874;18967.90516047418;19199.520011999673;5530.806421775239;5697.03150464422;5751.56863235257;5764.5964782465035;5789.739461724233;5410.810621628244;5612.130119831412;5622.606417550773;5644.238027866227;5646.717664116798;5580.107182850745;5598.608097433182;5600.831975040755;5601.943980560183;5682.488576028157;5470.370907345647;5527.613067085305;5574.358948720908;5586.41342659021;5677.261955945722;4907.4356449008465;4957.6033917286895;4960.826371077031;4962.379702537183;5035.79856805731;22596.548069038527;22716.091356345725;22761.54476910469;23189.884050579807;23196.884015579984;2366.562185995579;2381.2380038387723;2387.236084452976;2398.78410943016;2487.328421326232;13534.25561594112;13690.52083177084;13804.792928106086;14013.019088663797;14164.858351416457;1895.3555791031115;1919.808019198069;1934.7775005874364;1982.7025946108056;2126.957460850774;80381.59809200917;83792.16207837965;83917;85986.57006714989;86377;10575.735606609742;10744.293218839488;10909.727256818484;11095.72260693489;11158;15619.297131629104;15669.216539173223;15709.371625135094;15738.449154279546;15741.606459838367;8197.565426050418;8448.239658430648;8505.65977360911;8569.914300857037;8603;8071.860956846441;8075.555844428495;8148.185181481805;8256.752297431087;8276.172382761675;4702.482726900038;4732.432108146975;4810.494898035726;4833.178359678863;4838.854834354975;1895.876618187611;1916.036063035372;1956.9315073972343;1985.8382846034942;1987.837115287544;886.3131073418024;986.3736527305213;1009.7929924365487;1030.3766221435924;1055.5250137438184;18215;18796.718049229272;19114.904425477784;19151.32970346059;19201.32795352156;980.54404701814;990.8860481044628;1004.2468148888333;1006.4514839412537;1029.3463650581934;10364.326318789255;10860.402677852793;10903.781924361469;10919.181061420426;10947.124230061576;449771;454433;477748;479012;483148;90767;95364;96122.51938740262;96144;96562;963.1379914976058;974.5565767575736;996.3573495095623;999.7650552120245;1012.1700205831295;16405;16574.58563535873;16676.10503412717;16780.412685555948;16909.323627055273;39191.804040979616;39340.60659393369;40293.1941361177;40853.79573102116;41906;50952;52393;56962.715186423804;57199;57214.42785572091;8249.876251856107;8352.582370881553;8385.203405676451;8450.830983380176;8544.91455085466;9195.816083678423;12464.314462704275;12737.426815793497;12775.48898044105;12816.102872799187;10953;10984;11147.609833655782;11180.72048198769;11398.487068082122;10954.342739435659;11083.833742494031;11384.487698053774;11397.601083962021;11449.59926402572;11076.723081923017;11327;11347.886521134684;11461.885381146081;11468.545395703088;8179.509229446252;8337.583120844054;8404;8482.066972632882;8741;10967.83548246761;10967.890321096687;11059;11074.612388566362;11117.944410277896 02:38:54 INFO - PROCESS | 8146 | |3;mootools.html;1339.2098661789541;1500.677354368811;1522.02590342181;1677.1111311005163;1825.525363405515;8366.790830229247;8803.427777194478;8812.60343284553;9023.323250756186;9035.593398297076;8716.564171791417;8934.374593778439;8952;8955.776105597364;8957.596908139132;1998.9200431982704;2204.2836078274627;2284.6344584866424;2288.622377307742;2314.7685231476885;2372.78644921957;2374.6912901322803;2378.464845409778;2380.2621187431864;2382.4996750682376;2272.9545409091807;2277.555876604063;2298.4598619324447;2302.689136966513;2305.158617104753;1944.9124789384512;2163.8593491423167;2243.05791567542;2247.4718441166315;2294.369048511656;2281.6805647209403;2287.245209081016;2294.9196778112687;2302.700648915647;2304.331743794298;8929;8960.372773905829;8992.280617550581;8997.640094396216;8999.955000225022;5081.695098294077;5210.478952104797;5214.217867319894;5215.6609820361555;5217.113090774539;3323.252268239651;3442.862285508577;3506.2636846262317;3509.94735078974;3551.271989242199;1169.2692067457838;1187.51311962096;1191.3923898811581;1201.7656556971394;1205.2226314027403;12519.248845069325;12520.81218781719;12522.499100035988;12525.123241373016;12538.059645526622;4508.481524624644;4615.930761038587;4724.598409135193;4725.692829966041;4735.147673418817;10435.94782026085;10466.52900619474;10475.895241047645;10477.580896764044;10481.842772358421;5296.973515132399;5301.231321458444;5310.362756469249;5348.3849357323625;5357.678539287655;4132.173565286955;4712.410948631421;4842.346283251716;4861.854144375674;4933.210686290176;3890.0469385000856;3948.624880636335;4008.699347548887;4045.635892769606;4054.412110243998;1197.0782497476894;1210.5157936825165;1219.969500762488;1224.6509744722712;1225.1668865171769;834.6536187482127;984.3011461862015;985.3742873275521;990.321629683669;1000.4347543637822;5654.321481422256;5656.462636049569;5723.198752174699;5838.2702162229725;6099.451049405486;438.2221556736754;440.90520538083825;447.1057884231537;456.9588737013685;458.95410458954507;4086.101057767346;4101;4121.690873184523;4132.462779838662;4139.544650088488;10566.098102341652;10920.781584368267;10993.450327483593;11009.064229540418;11020.063294620048;10752.569897204181;10794.56821727122;10905.400202988752;10912.345259284468;10918.399488028235;8107.067687216046;8160.591970401456;8250.504969701837;8256.669733210605;8272.255497005299;5622.718864056699;5706.514946229451;5736.856578585569;5826.504747096545;5946.524278057658;9445.574949127444;10045.899541004497;10048.69853904384;10054.296199266273;10159.136473399843;9795.265355098254;9952.353097048668;9976.650817221362;9979.151772099453;10052.396856188652;7207.531510451804;7686.846263074819;7953.244441778022;7980.840383192188;8160.26557609818;8828.161324674145;8843.248323892283;8911.688090916787;8916.15296546827;8923.910760892568;7623.237676232332;7700.807479813049;7845.293923546908;7951.960240198762;8033.758987230392;7639.197884222077;7742.264484873928;7767.495112817649;7877.724279650185;8015.158408367038;7189.604571748395;7252.129744430702;7306.050213472215;7317.19510853795;7321.194668586345;5088.389393272831;5182.792688292577;5207.635465517377;5261.894762104813;5356.982173387044;5099.56653684441;5279.683219006872;5327.227552005015;5336.706481143575;5369.741506610201 02:38:54 INFO - PROCESS | 8146 | |4;prototype.html;320.6617019044908;329.6176435335011;337.9188994641287;337.93748156591033;340.7733856985105;5418.431064738204;5459.290292262005;5471.316085489314;5478.643888147268;5495.697736624484;5116.820911268106;5167;5273.8945221095655;5350.5184533391985;5419.187121931712;4172.415861779354;4204.885705288086;4207.137536804948;4231.809568569422;4238.9152216955645;4230.132822771325;4242.681798865097;4242.830286788525;4252.107057517925;4270.914581708364;3980.800959952005;3989.5611482736876;4163.084121493282;4190.2248084104385;4210.726302790325;4157.97921010396;4166.395872598457;4179.017930786263;4187.581241875819;4208.810603522848;3714.4985426967282;3742.9438558421643;3743.737938344317;3761.8307176177136;3783.735138540276;5138.640295179339;5146.897062058775;5163.612729045299;5205.947940520622;5284;4775.474697783241;4799.112164249625;4800.1839687252905;4813.855584332476;4825.831095911626;5618.775248990036;5626.846496468214;5649.898269837383;5650.74571644277;5668.489835914746;3871.457995880579;4082.408050832613;4084.9795751021056;4112.773797441139;4114.341705327163;5835.570285280133;5841.007028805071;5857.589968702235;5888.4700376966275;5896.616719913192;4153.501579810442;4158.812853421543;4163.854939891494;4166.562510936369;4167.666586673119;4112.547619761824;4179.101493178981;4186.22085613613;4195.748255104703;4224.218519573888;4750.809967601257;4757.666963312604;4766.118268120409;4782.784774685148;4784.425868895755;5515.420880807537;5557.360903496069;5621.5221706155435;5642.661440313512;5677.716114194356;1420.88632909367;1436.1239643817264;1442.6321288071474;1452.165005122059;1455;916.6012784438791;917.6191880369705;920.0477505781485;921.7188757428914;931.1154403316876;4869.488703686133;4888.902221955541;4888.926666100011;4923.621386011922;4977.427595826454;5249.895002099936;5261.473852614785;5262.789488420421;5275.944811037808;5303.681779093266;4767.928481072787;4811.927821082687;4840.709557426566;4922.852314430573;5121.769520371592;3093.8917137900517;3131.9843400783307;3136.7490600751885;3151.448496513101;3151.637561680436;5954.422078149294;5974.910376344358;6032.909506357408;6033.487153591994;6043.153958445821;5616.241807355955;5878.2358293421585;5881.5000724938;5925.525957923356;5933.406659334032;6027.246594175728;6060.636361818305;6061.2422397505115;6081.543884208702;6099.420555047263;5605.355384130877;5794.797182098607;5819.76720931175;5909.113632955091;5922.703864806828;5801.82594522165;5811.302643682785;5824.417558244142;5832.24180856486;5844.327902291291;6007.279126504847;6042.667653279112;6050.273967123973;6061.36355682647;6061.424164704346;3922.1763429680086;3969.8412063517135;4067.491563554556;4095.32427149517;4161.97919010403;5818.069108942549;5829.737661805144;5830.300363956352;5834.329052159056;5836.241288632451;5647.6893770843;5656.85857853557;5666.773329066791;5671.432856714296;5673.156224227225;5426.2674538936735;5670.489655930986;5674.602777805514;5678.432156784454;5704.201411802268;5519.779208831602;5524;5539.9169012464035;5540.196671482532;5553;5451.454854514517;5673.319201695823;5693.28833895763;5725.8568535786935;5733.971330143323;5536.640118392453;5544.7227638618715;5556.666600004012;5557.36090349615;5586.329640443173 02:38:54 INFO - PROCESS | 8146 | |5;yui.html;728.5737843361634;801.1427772283655;823.201494550286;825.9174082591737;849.8512760266951;13363.933180334108;13382.66543336417;13384.732305353898;13557.7966330505;15344.462943796969;14484.637884052903;15325;16144.273507692153;16231;17015.91492042538;664.5381459885382;812.597764106768;818.8157664525494;819.7212947597816;820.2781552234026;797.6211299632686;824.4435006370705;829.9709510167145;830.244477525452;831.7005877883987;862.9180227878373;867.2584939876409;867.6963062927988;867.9045305016443;868.288003836854;713.9393151582121;840.306746933782;860.3676297921023;862.7411776467067;863.3783675753448;631.8136149835809;633.9302676705558;634.4987459906669;634.7746549974738;634.9238091429012;16351.91824040884;16452.095134767584;16453.177341133014;16457.09485978271;16458.75311870323;13134.60596182116;13788.724225515434;13963.58109256724;13970.441182352795;14146.575602731935;12684.556040538537;13001.544945926942;13210.73578528424;13222.140560863512;13344.199348039148;4383.627391671712;4395.516493185747;4415.337699345092;4476.1271552047365;4543.091381723635;81308;82733.58633206795;82735.586322068;84618.57690711507;84645;10468.319559228627;10754.677359679223;10756.677299681021;10874.075703565128;11148.721281967853;21245.043973021253;21281.255156069463;21347.573048539252;21348.573028539344;21352.14591416357;8345.248927596545;8377.246047855722;8555.743327700178;8818.33862460318;8833.779155521164;4551.908961820811;4710.52894710533;4850.53919877611;4870.878228044327;4873.878153046131;3402.659734026627;3513.718902487795;3517.9648203517636;3522.559680039995;3522.735794815399;614.1678026274334;636.5639536917226;638.1448858529593;646.5894157210205;657.0144782825762;561.4609974424517;594.3729365519418;626.467502622767;652.6899722631712;663.0220424873273;9202.401843880127;9203.447793132433;9525.857112143323;9590.280728945358;9624.37441566296;558.430400990995;660.2802944790202;710.1407297170379;716.5163514627606;719.0723966083693;4754.809807607726;4795.424549054136;4808.3027960945465;4860.343853579792;4885.120678277873;123716.00981896951;125570.37214814051;126519;127890.36054819667;128746;85638;85710;88968;106597;108680.4565977165;90814.27557173163;91225.54387228022;91834.54082729544;93262.53368733113;94632;9519.714408567754;9775.21798256152;9806.313558051153;10019.899801001897;10074.89925100769;48046;48133.518664814306;49309.2603610939;51711.48288517067;52031.73984130055;73855.63072184604;75354;75548.62225688837;76269.23730762622;76481.23518764964;12747.678675784013;13116.475340986253;13172.868271317164;13222.6777322267;13541.1198272112;14510.274486275855;14616.531753275645;15319.310631021408;15350.923245383701;15586.06483610987;8230.640801399344;13494.52769153075;13909.149135829392;14465.710685786436;14535.055221410574;13041.804372934603;13101.215381549882;13574.728505430034;14577.489787857374;14765.852341476448;14249.833973305887;14314.141151530941;14568.92715536458;14872.925635371754;14878.330475128429;11720.941395292968;11944;11981.520739170335;12032.75934481323;12060.879391206327;10354.534045968101;10741.301815381976;11187.16096292765;11361.659150225507;11414.543418263509 02:38:54 INFO - PROCESS | 8146 | __end_tp_report 02:38:54 INFO - PROCESS | 8146 | __start_cc_report 02:38:54 INFO - PROCESS | 8146 | _x_x_mozilla_cycle_collect,1117 02:38:54 INFO - PROCESS | 8146 | __end_cc_report 02:38:54 INFO - PROCESS | 8146 | __startTimestamp1465465134230__endTimestamp 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | ------- Summary: start ------- 02:38:54 INFO - PROCESS | 8146 | Number of tests: 6 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#0] dojo.html Cycles:165 Average:5448.84 Median:5636.35 stddev:621.56 (11.0%) stddev-sans-first:597.25 02:38:54 INFO - PROCESS | 8146 | Values: 3171.7 3180.4 3198.0 3208.8 3243.9 5358.3 5383.1 5444.5 5477.5 5489.2 5497.0 5521.1 5541.8 5593.2 5604.2 4852.5 4885.3 4890.0 4980.7 4985.1 5054.7 5122.6 5129.9 5141.2 5171.8 4860.8 4914.4 5054.9 5056.9 5076.5 4988.9 4988.9 5002.1 5006.0 5061.4 4964.8 5001.7 5012.4 5016.6 5052.0 5259.3 5352.7 5436.2 5436.6 5482.6 5927.7 5954.7 5957.7 5981.6 5983.9 5964.4 6008.5 6022.8 6024.4 6030.4 5388.7 5450.8 5501.3 5627.8 5638.8 6037.9 6054.0 6075.6 6075.8 6079.0 5818.4 5818.9 5819.2 5832.9 5835.3 5740.3 5785.7 5827.6 5840.0 5898.9 5792.5 5827.7 5846.1 5847.0 5848.2 5807.3 5856.7 5865.3 5873.6 5892.8 4331.7 4413.1 4448.2 4459.2 4475.3 3963.0 3972.1 3977.0 4009.8 4016.3 5319.4 5494.5 5504.6 5504.8 5505.1 5769.9 5787.3 5835.6 5856.2 5938.1 5448.6 5456.2 5457.3 5460.1 5464.4 4993.1 5058.5 5069.1 5071.1 5118.4 6012.4 6048.8 6056.1 6103.5 6105.1 5922.8 5932.4 5935.9 5936.4 5938.9 5836.2 5980.7 6091.1 6102.7 6109.8 5781.1 5804.6 5811.1 5829.2 5851.8 5801.9 5851.3 5882.6 5901.9 5903.0 5585.9 5648.2 5703.1 5730.3 5745.6 5722.8 5724.1 5725.3 5733.9 5760.4 5633.7 5634.1 5642.9 5645.7 5646.0 5605.5 5632.4 5689.1 5716.6 5766.6 5539.2 5603.5 5621.5 5636.4 5643.5 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#1] ext.html Cycles:180 Average:64930.64 Median:37422.94 stddev:135361.90 (361.7%) stddev-sans-first:135655.43 02:38:54 INFO - PROCESS | 8146 | Values: 592.2 627.1 638.2 638.9 649.1 31258.7 43082.4 44148.3 44226.6 44263.0 45661.3 46329.0 46385.5 46393.8 46411.0 7673.0 8854.5 9022.2 10405.1 10681.2 10592.3 10688.1 10689.4 10690.8 10700.2 10753.0 10798.9 10799.5 10804.5 10806.8 8016.9 10385.7 10582.9 10627.4 11035.1 10489.9 10501.0 10503.1 10579.8 10584.2 42019.0 42372.4 42553.6 42571.4 42601.6 3609.7 3683.3 3716.2 3834.1 4063.7 33093.0 33123.0 33135.8 33418.0 34773.3 4316.5 4321.4 4356.9 4473.8 4491.4 346916.0 356063.0 357929.0 495863.0 504062.2 60405.0 60723.4 60844.0 60913.0 60960.4 37989.8 38819.6 38917.6 39011.2 39026.8 14788.8 17138.1 17313.7 17382.1 17389.1 12922.2 13119.3 13128.5 13423.2 13464.9 20008.1 20100.2 20112.1 20112.5 20172.0 7151.7 7174.9 7282.2 7397.8 7423.9 919.1 1018.3 1018.7 1076.8 1165.0 29992.7 32159.2 32241.2 32243.0 32783.0 1150.0 1165.3 1192.6 1196.2 1289.2 16933.6 16967.2 16975.7 17065.9 17092.2 611225.0 616978.0 618392.0 620264.0 622081.0 58307.2 59786.4 59787.0 59787.7 59846.4 1269.8 1385.3 1392.5 1423.8 1424.0 30508.7 32519.7 32574.5 32640.7 33067.2 51096.0 51520.7 51585.5 51680.0 51716.2 463260.0 464586.0 467187.0 471341.0 471902.0 24993.4 27225.2 27902.2 28309.0 29334.3 48117.8 49061.8 49668.0 50177.0 50182.0 39707.4 40262.4 40625.0 40991.6 41806.0 39773.8 40727.0 40821.0 40999.4 41357.2 37219.4 37453.8 42020.2 42075.6 42088.8 34201.0 36658.0 37412.6 37433.3 37871.1 27547.3 28112.7 28193.9 28226.9 28231.0 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#2] jquery.html Cycles:180 Average:28413.20 Median:1429.43 stddev:77558.31 (5425.8%) stddev-sans-first:77747.30 02:38:54 INFO - PROCESS | 8146 | Values: 371.5 385.2 387.8 398.5 411.9 17776.2 18916.2 19259.9 19272.3 19273.2 18893.8 18912.7 18934.6 18967.9 19199.5 5530.8 5697.0 5751.6 5764.6 5789.7 5410.8 5612.1 5622.6 5644.2 5646.7 5580.1 5598.6 5600.8 5601.9 5682.5 5470.4 5527.6 5574.4 5586.4 5677.3 4907.4 4957.6 4960.8 4962.4 5035.8 22596.5 22716.1 22761.5 23189.9 23196.9 2366.6 2381.2 2387.2 2398.8 2487.3 13534.3 13690.5 13804.8 14013.0 14164.9 1895.4 1919.8 1934.8 1982.7 2127.0 80381.6 83792.2 83917.0 85986.6 86377.0 10575.7 10744.3 10909.7 11095.7 11158.0 15619.3 15669.2 15709.4 15738.4 15741.6 8197.6 8448.2 8505.7 8569.9 8603.0 8071.9 8075.6 8148.2 8256.8 8276.2 4702.5 4732.4 4810.5 4833.2 4838.9 1895.9 1916.0 1956.9 1985.8 1987.8 886.3 986.4 1009.8 1030.4 1055.5 18215.0 18796.7 19114.9 19151.3 19201.3 980.5 990.9 1004.2 1006.5 1029.3 10364.3 10860.4 10903.8 10919.2 10947.1 449771.0 454433.0 477748.0 479012.0 483148.0 90767.0 95364.0 96122.5 96144.0 96562.0 963.1 974.6 996.4 999.8 1012.2 16405.0 16574.6 16676.1 16780.4 16909.3 39191.8 39340.6 40293.2 40853.8 41906.0 50952.0 52393.0 56962.7 57199.0 57214.4 8249.9 8352.6 8385.2 8450.8 8544.9 9195.8 12464.3 12737.4 12775.5 12816.1 10953.0 10984.0 11147.6 11180.7 11398.5 10954.3 11083.8 11384.5 11397.6 11449.6 11076.7 11327.0 11347.9 11461.9 11468.5 8179.5 8337.6 8404.0 8482.1 8741.0 10967.8 10967.9 11059.0 11074.6 11117.9 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#3] mootools.html Cycles:180 Average:5816.72 Median:4725.15 stddev:3350.05 (70.9%) stddev-sans-first:3342.55 02:38:54 INFO - PROCESS | 8146 | Values: 1339.2 1500.7 1522.0 1677.1 1825.5 8366.8 8803.4 8812.6 9023.3 9035.6 8716.6 8934.4 8952.0 8955.8 8957.6 1998.9 2204.3 2284.6 2288.6 2314.8 2372.8 2374.7 2378.5 2380.3 2382.5 2273.0 2277.6 2298.5 2302.7 2305.2 1944.9 2163.9 2243.1 2247.5 2294.4 2281.7 2287.2 2294.9 2302.7 2304.3 8929.0 8960.4 8992.3 8997.6 9000.0 5081.7 5210.5 5214.2 5215.7 5217.1 3323.3 3442.9 3506.3 3509.9 3551.3 1169.3 1187.5 1191.4 1201.8 1205.2 12519.2 12520.8 12522.5 12525.1 12538.1 4508.5 4615.9 4724.6 4725.7 4735.1 10435.9 10466.5 10475.9 10477.6 10481.8 5297.0 5301.2 5310.4 5348.4 5357.7 4132.2 4712.4 4842.3 4861.9 4933.2 3890.0 3948.6 4008.7 4045.6 4054.4 1197.1 1210.5 1220.0 1224.7 1225.2 834.7 984.3 985.4 990.3 1000.4 5654.3 5656.5 5723.2 5838.3 6099.5 438.2 440.9 447.1 457.0 459.0 4086.1 4101.0 4121.7 4132.5 4139.5 10566.1 10920.8 10993.5 11009.1 11020.1 10752.6 10794.6 10905.4 10912.3 10918.4 8107.1 8160.6 8250.5 8256.7 8272.3 5622.7 5706.5 5736.9 5826.5 5946.5 9445.6 10045.9 10048.7 10054.3 10159.1 9795.3 9952.4 9976.7 9979.2 10052.4 7207.5 7686.8 7953.2 7980.8 8160.3 8828.2 8843.2 8911.7 8916.2 8923.9 7623.2 7700.8 7845.3 7952.0 8033.8 7639.2 7742.3 7767.5 7877.7 8015.2 7189.6 7252.1 7306.1 7317.2 7321.2 5088.4 5182.8 5207.6 5261.9 5357.0 5099.6 5279.7 5327.2 5336.7 5369.7 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#4] prototype.html Cycles:180 Average:4719.57 Median:5279.97 stddev:1389.66 (26.3%) stddev-sans-first:1353.77 02:38:54 INFO - PROCESS | 8146 | Values: 320.7 329.6 337.9 337.9 340.8 5418.4 5459.3 5471.3 5478.6 5495.7 5116.8 5167.0 5273.9 5350.5 5419.2 4172.4 4204.9 4207.1 4231.8 4238.9 4230.1 4242.7 4242.8 4252.1 4270.9 3980.8 3989.6 4163.1 4190.2 4210.7 4158.0 4166.4 4179.0 4187.6 4208.8 3714.5 3742.9 3743.7 3761.8 3783.7 5138.6 5146.9 5163.6 5205.9 5284.0 4775.5 4799.1 4800.2 4813.9 4825.8 5618.8 5626.8 5649.9 5650.7 5668.5 3871.5 4082.4 4085.0 4112.8 4114.3 5835.6 5841.0 5857.6 5888.5 5896.6 4153.5 4158.8 4163.9 4166.6 4167.7 4112.5 4179.1 4186.2 4195.7 4224.2 4750.8 4757.7 4766.1 4782.8 4784.4 5515.4 5557.4 5621.5 5642.7 5677.7 1420.9 1436.1 1442.6 1452.2 1455.0 916.6 917.6 920.0 921.7 931.1 4869.5 4888.9 4888.9 4923.6 4977.4 5249.9 5261.5 5262.8 5275.9 5303.7 4767.9 4811.9 4840.7 4922.9 5121.8 3093.9 3132.0 3136.7 3151.4 3151.6 5954.4 5974.9 6032.9 6033.5 6043.2 5616.2 5878.2 5881.5 5925.5 5933.4 6027.2 6060.6 6061.2 6081.5 6099.4 5605.4 5794.8 5819.8 5909.1 5922.7 5801.8 5811.3 5824.4 5832.2 5844.3 6007.3 6042.7 6050.3 6061.4 6061.4 3922.2 3969.8 4067.5 4095.3 4162.0 5818.1 5829.7 5830.3 5834.3 5836.2 5647.7 5656.9 5666.8 5671.4 5673.2 5426.3 5670.5 5674.6 5678.4 5704.2 5519.8 5524.0 5539.9 5540.2 5553.0 5451.5 5673.3 5693.3 5725.9 5734.0 5536.6 5544.7 5556.7 5557.4 5586.3 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - PROCESS | 8146 | [#5] yui.html Cycles:180 Average:21449.48 Median:4775.12 stddev:31476.29 (659.2%) stddev-sans-first:31526.14 02:38:54 INFO - PROCESS | 8146 | Values: 728.6 801.1 823.2 825.9 849.9 13363.9 13382.7 13384.7 13557.8 15344.5 14484.6 15325.0 16144.3 16231.0 17015.9 664.5 812.6 818.8 819.7 820.3 797.6 824.4 830.0 830.2 831.7 862.9 867.3 867.7 867.9 868.3 713.9 840.3 860.4 862.7 863.4 631.8 633.9 634.5 634.8 634.9 16351.9 16452.1 16453.2 16457.1 16458.8 13134.6 13788.7 13963.6 13970.4 14146.6 12684.6 13001.5 13210.7 13222.1 13344.2 4383.6 4395.5 4415.3 4476.1 4543.1 81308.0 82733.6 82735.6 84618.6 84645.0 10468.3 10754.7 10756.7 10874.1 11148.7 21245.0 21281.3 21347.6 21348.6 21352.1 8345.2 8377.2 8555.7 8818.3 8833.8 4551.9 4710.5 4850.5 4870.9 4873.9 3402.7 3513.7 3518.0 3522.6 3522.7 614.2 636.6 638.1 646.6 657.0 561.5 594.4 626.5 652.7 663.0 9202.4 9203.4 9525.9 9590.3 9624.4 558.4 660.3 710.1 716.5 719.1 4754.8 4795.4 4808.3 4860.3 4885.1 123716.0 125570.4 126519.0 127890.4 128746.0 85638.0 85710.0 88968.0 106597.0 108680.5 90814.3 91225.5 91834.5 93262.5 94632.0 9519.7 9775.2 9806.3 10019.9 10074.9 48046.0 48133.5 49309.3 51711.5 52031.7 73855.6 75354.0 75548.6 76269.2 76481.2 12747.7 13116.5 13172.9 13222.7 13541.1 14510.3 14616.5 15319.3 15350.9 15586.1 8230.6 13494.5 13909.1 14465.7 14535.1 13041.8 13101.2 13574.7 14577.5 14765.9 14249.8 14314.1 14568.9 14872.9 14878.3 11720.9 11944.0 11981.5 12032.8 12060.9 10354.5 10741.3 11187.2 11361.7 11414.5 02:38:54 INFO - PROCESS | 8146 | -------- Summary: end -------- 02:38:54 INFO - PROCESS | 8146 | 02:38:54 INFO - TEST-INFO | 8146: exit 0 02:38:54 INFO - TEST-OK | dromaeo_css | took 1113888ms 02:38:54 INFO - TEST-START | kraken 02:38:54 INFO - operating with platform_type : linux_ 02:38:54 INFO - Initialising browser for kraken test... 02:38:54 INFO - TEST-INFO | started process 8322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2EM7av/profile http://localhost:34267/getInfo.html) 02:38:58 INFO - PROCESS | 8322 | __metrics Screen width/height:1600/1200 02:38:58 INFO - PROCESS | 8322 | colorDepth:24 02:38:58 INFO - PROCESS | 8322 | Browser inner width/height: 1024/697 02:38:58 INFO - PROCESS | 8322 | __metrics 02:38:59 ERROR - PROCESS | 8322 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:38:59 INFO - PROCESS | 8322 | console.error: PushService: 02:38:59 INFO - PROCESS | 8322 | stateChangeProcessEnqueue: Error transitioning state 02:38:59 INFO - PROCESS | 8322 | UnknownError 02:39:00 INFO - TEST-INFO | 8322: exit 0 02:39:00 INFO - Browser initialized. 02:39:00 INFO - Running cycle 1/1 for kraken test... 02:39:00 INFO - TEST-INFO | started process 8405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2EM7av/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:12 INFO - PROCESS | 8405 | RSS: Main: 156454912 02:39:12 INFO - PROCESS | 8405 | 02:39:14 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34267/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:15 INFO - PROCESS | 8405 | RSS: Main: 214347776 02:39:15 INFO - PROCESS | 8405 | 02:39:18 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34267/tests/kraken/driver.html?testName=audio-dft) 02:39:18 INFO - PROCESS | 8405 | RSS: Main: 202731520 02:39:18 INFO - PROCESS | 8405 | 02:39:22 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34267/tests/kraken/driver.html?testName=audio-fft) 02:39:22 INFO - PROCESS | 8405 | RSS: Main: 268464128 02:39:22 INFO - PROCESS | 8405 | 02:39:24 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34267/tests/kraken/driver.html?testName=audio-oscillator) 02:39:25 INFO - PROCESS | 8405 | RSS: Main: 179052544 02:39:25 INFO - PROCESS | 8405 | 02:39:27 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:28 INFO - PROCESS | 8405 | RSS: Main: 183595008 02:39:28 INFO - PROCESS | 8405 | 02:39:31 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34267/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:31 INFO - PROCESS | 8405 | RSS: Main: 217915392 02:39:31 INFO - PROCESS | 8405 | 02:39:35 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34267/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:35 INFO - PROCESS | 8405 | RSS: Main: 219717632 02:39:35 INFO - PROCESS | 8405 | 02:39:38 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34267/tests/kraken/driver.html?testName=json-parse-financial) 02:39:39 INFO - PROCESS | 8405 | RSS: Main: 220479488 02:39:39 INFO - PROCESS | 8405 | 02:39:40 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:41 INFO - PROCESS | 8405 | RSS: Main: 204816384 02:39:41 INFO - PROCESS | 8405 | 02:39:42 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:43 INFO - PROCESS | 8405 | RSS: Main: 209948672 02:39:43 INFO - PROCESS | 8405 | 02:39:45 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:46 INFO - PROCESS | 8405 | RSS: Main: 217337856 02:39:46 INFO - PROCESS | 8405 | 02:39:48 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:49 INFO - PROCESS | 8405 | RSS: Main: 222863360 02:39:49 INFO - PROCESS | 8405 | 02:39:52 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:52 INFO - PROCESS | 8405 | RSS: Main: 224104448 02:39:52 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | Cycle 1(1): loaded http://localhost:34267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34267/tests/kraken/driver.html?testName=ai-astar) 02:39:54 INFO - PROCESS | 8405 | RSS: Main: 267067392 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | __start_tp_report 02:39:54 INFO - PROCESS | 8405 | _x_x_mozilla_page_load 02:39:54 INFO - PROCESS | 8405 | _x_x_mozilla_page_load_details 02:39:54 INFO - PROCESS | 8405 | |i|pagename|runs| 02:39:54 INFO - PROCESS | 8405 | |0;ai-astar;110;105;111;110;110;111;109;109;109;109 02:39:54 INFO - PROCESS | 8405 | |1;audio-beat-detection;146;124;128;181;129;125;154;125;161;124 02:39:54 INFO - PROCESS | 8405 | |2;audio-dft;159;160;159;160;158;160;160;162;160;161 02:39:54 INFO - PROCESS | 8405 | |3;audio-fft;73;75;75;126;75;75;74;75;96;74 02:39:54 INFO - PROCESS | 8405 | |4;audio-oscillator;84;84;113;85;84;86;118;85;86;137 02:39:54 INFO - PROCESS | 8405 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;117;116;117 02:39:54 INFO - PROCESS | 8405 | |6;imaging-darkroom;147;146;145;146;146;146;146;146;146;148 02:39:54 INFO - PROCESS | 8405 | |7;imaging-desaturate;96;95;95;95;95;95;94;95;94;95 02:39:54 INFO - PROCESS | 8405 | |8;json-parse-financial;54;54;54;56;56;54;55;54;55;55 02:39:54 INFO - PROCESS | 8405 | |9;json-stringify-tinderbox;61;62;61;61;61;62;62;62;61;61 02:39:54 INFO - PROCESS | 8405 | |10;stanford-crypto-aes;79;79;78;79;80;79;80;81;116;80 02:39:54 INFO - PROCESS | 8405 | |11;stanford-crypto-ccm;129;127;121;119;128;119;118;124;135;121 02:39:54 INFO - PROCESS | 8405 | |12;stanford-crypto-pbkdf2;159;160;157;160;161;161;159;162;159;161 02:39:54 INFO - PROCESS | 8405 | |13;stanford-crypto-sha256-iterative;63;63;64;63;62;62;61;66;61;61 02:39:54 INFO - PROCESS | 8405 | __end_tp_report 02:39:54 INFO - PROCESS | 8405 | __start_cc_report 02:39:54 INFO - PROCESS | 8405 | _x_x_mozilla_cycle_collect,1634 02:39:54 INFO - PROCESS | 8405 | __end_cc_report 02:39:54 INFO - PROCESS | 8405 | __startTimestamp1465465194610__endTimestamp 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | ------- Summary: start ------- 02:39:54 INFO - PROCESS | 8405 | Number of tests: 14 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 02:39:54 INFO - PROCESS | 8405 | Values: 110.0 105.0 111.0 110.0 110.0 111.0 109.0 109.0 109.0 109.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:137.50 stddev:19.94 (14.5%) stddev-sans-first:21.02 02:39:54 INFO - PROCESS | 8405 | Values: 146.0 124.0 128.0 181.0 129.0 125.0 154.0 125.0 161.0 124.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 02:39:54 INFO - PROCESS | 8405 | Values: 159.0 160.0 159.0 160.0 158.0 160.0 160.0 162.0 160.0 161.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:16.95 (22.6%) stddev-sans-first:17.68 02:39:54 INFO - PROCESS | 8405 | Values: 73.0 75.0 75.0 126.0 75.0 75.0 74.0 75.0 96.0 74.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.50 stddev:19.23 (22.8%) stddev-sans-first:19.88 02:39:54 INFO - PROCESS | 8405 | Values: 84.0 84.0 113.0 85.0 84.0 86.0 118.0 85.0 86.0 137.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:39:54 INFO - PROCESS | 8405 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 02:39:54 INFO - PROCESS | 8405 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 148.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 02:39:54 INFO - PROCESS | 8405 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 02:39:54 INFO - PROCESS | 8405 | Values: 54.0 54.0 54.0 56.0 56.0 54.0 55.0 54.0 55.0 55.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:39:54 INFO - PROCESS | 8405 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:79.50 stddev:11.59 (14.6%) stddev-sans-first:12.20 02:39:54 INFO - PROCESS | 8405 | Values: 79.0 79.0 78.0 79.0 80.0 79.0 80.0 81.0 116.0 80.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:5.53 (4.4%) stddev-sans-first:5.57 02:39:54 INFO - PROCESS | 8405 | Values: 129.0 127.0 121.0 119.0 128.0 119.0 118.0 124.0 135.0 121.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:1.45 (0.9%) stddev-sans-first:1.50 02:39:54 INFO - PROCESS | 8405 | Values: 159.0 160.0 157.0 160.0 161.0 161.0 159.0 162.0 159.0 161.0 02:39:54 INFO - PROCESS | 8405 | 02:39:54 INFO - PROCESS | 8405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 02:39:54 INFO - PROCESS | 8405 | Values: 63.0 63.0 64.0 63.0 62.0 62.0 61.0 66.0 61.0 61.0 02:39:54 INFO - PROCESS | 8405 | -------- Summary: end -------- 02:39:54 INFO - PROCESS | 8405 | 02:39:55 INFO - TEST-INFO | 8405: exit 0 02:39:55 INFO - TEST-OK | kraken | took 60660ms 02:39:55 INFO - SUITE-END | took 1174s 02:39:55 INFO - Completed test suite (00:19:34) 02:39:55 INFO - javascript benchmark 02:39:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3171.7145456908875, 3180.395724812287, 3198.0, 3208.823514706693, 3243.935121297574, 5358.33020872391, 5383.138697808351, 5444.537214336781, 5477.5070243678065, 5489.231507588941, 5497.0, 5521.1442226454865, 5541.833744987647, 5593.216949627055, 5604.215409842615, 4852.514748525155, 4885.340479035338, 4890.0, 4980.701157930518, 4985.052839960414, 5054.7472626368535, 5122.641415100945, 5129.9230511542355, 5141.228815677641, 5171.793128274883, 4860.756962151878, 4914.410270767531, 5054.873628159307, 5056.949430505703, 5076.46697096805, 4988.900221995576, 4988.925166122511, 5002.124628190052, 5006.0, 5061.392632884041, 4964.826231081931, 5001.724905130216, 5012.448630650625, 5016.573591244749, 5052.0, 5259.2899958505495, 5352.652077614943, 5436.238926550286, 5436.565074794046, 5482.588805839578, 5927.673977931212, 5954.732037058343, 5957.7319020643745, 5981.58128930975, 5983.940160598382, 5964.373740757202, 6008.519318454513, 6022.819315420545, 6024.397560243984, 6030.427109424598, 5388.73056347185, 5450.781968721286, 5501.284832971688, 5627.774889004476, 5638.830835074954, 6037.909431358533, 6053.969730151321, 6075.574709770273, 6075.787347442818, 6079.0, 5818.389069147764, 5818.854528636818, 5819.243498345188, 5832.912506312408, 5835.299764028344, 5740.339860916049, 5785.739641716133, 5827.562932780059, 5839.970800145972, 5898.8820223595285, 5792.507636850831, 5827.708614569255, 5846.0646296593195, 5847.035239185572, 5848.152017957373, 5807.274090738658, 5856.707164641751, 5865.266841644794, 5873.618214816023, 5892.823215303548, 4331.675124365685, 4413.095315460323, 4448.221561226773, 4459.197344478025, 4475.261581839025, 3963.0290578808376, 3972.106276087915, 3977.0, 4009.799510024487, 4016.3172260715746, 5319.388270348882, 5494.5054945055135, 5504.559635229172, 5504.779808807683, 5505.119180931032, 5769.8557536061935, 5787.305523337142, 5835.620684655484, 5856.238688970492, 5938.109283607493, 5448.645838020516, 5456.154296084113, 5457.345118585795, 5460.071787796084, 5464.371597266286, 4993.101241776442, 5058.46886076964, 5069.138246498104, 5071.06185355703, 5118.436971933084, 6012.398760123952, 6048.758049678052, 6056.06131049688, 6103.511719062464, 6105.145279660851, 5922.763089476372, 5932.377100404568, 5935.851603709942, 5936.406359364202, 5938.940610594012, 5836.153757705024, 5980.671063091571, 6091.086337049301, 6102.725377358119, 6109.816705498843, 5781.103928891029, 5804.593678442468, 5811.099279611667, 5829.183914252093, 5851.795187168429, 5801.8549536261935, 5851.268591426072, 5882.647041177543, 5901.852453688693, 5902.970485147718, 5585.944140558705, 5648.15277708347, 5703.144528320619, 5730.3410107838135, 5745.626534275259, 5722.828315150386, 5724.084146536701, 5725.34158571753, 5733.913991290217, 5760.366359700346, 5633.690147041952, 5634.070378387521, 5642.943570564242, 5645.689487078086, 5646.040173170653, 5605.467480589337, 5632.408597097246, 5689.061304884648, 5716.628419152742, 5766.625169363978, 5539.169124631338, 5603.523700485504, 5621.4659607337235, 5636.351819540805, 5643.52030077448], "value": 5406.8678421381355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2123575644393, 627.1001113402268, 638.1576319258579, 638.8850006998741, 649.1042361541073, 31258.687413125863, 43082.35376469355, 44148.33777493332, 44226.55773442265, 44263.0, 45661.31508027374, 46329.0, 46385.53614463854, 46393.76803115988, 46411.0, 7673.0, 8854.513001784882, 9022.188003079722, 10405.063544281013, 10681.198910081735, 10592.25854190207, 10688.091512221432, 10689.412082335468, 10690.78618427631, 10700.197485188603, 10753.0, 10798.946005270001, 10799.460026998659, 10804.459777011158, 10806.78386432271, 8016.879746803774, 10385.68842934717, 10582.947085264525, 10627.41549214793, 11035.117190624811, 10489.947550262199, 10501.0, 10503.10723588496, 10579.788404231873, 10584.206184536191, 42019.0, 42372.364414533804, 42553.57446425527, 42571.36142957858, 42601.573984260074, 3609.657082577151, 3683.318586061587, 3716.201016781405, 3834.118152824838, 4063.6545893599077, 33093.0, 33123.0, 33135.834320828486, 33418.0, 34773.30453390943, 4316.460442444694, 4321.416608757809, 4356.869293921156, 4473.843415480475, 4491.438570178728, 346916.0, 356063.0, 357929.0, 495863.0, 504062.19533535134, 60405.0, 60723.392766072655, 60844.0, 60913.0, 60960.39039609547, 37989.81005094957, 38819.6118038816, 38917.61082389196, 39011.2197756049, 39026.804865975486, 14788.778168327484, 17138.14309284531, 17313.653726925644, 17382.130893455276, 17389.130543472776, 12922.224666520038, 13119.278439685719, 13128.474861005643, 13423.194608323336, 13464.865351346361, 20008.099635516435, 20100.195992160443, 20112.09495572703, 20112.49718757043, 20172.0, 7151.713931442684, 7174.856502869913, 7282.235365286569, 7397.778066658009, 7423.888641670379, 919.1130559010587, 1018.2821111116644, 1018.6638409324905, 1076.7577295108538, 1164.9981016325953, 29992.70007299943, 32159.196020099684, 32241.193970150463, 32243.0, 32783.0, 1149.988500114988, 1165.3008195083053, 1192.5885569478517, 1196.2045239915533, 1289.239348784203, 16933.576660583338, 16967.236474358684, 16975.74536381955, 17065.91467042657, 17092.2308496118, 611225.0, 616978.0, 618392.0, 620264.0, 622081.0, 58307.16928307135, 59786.40213597808, 59787.0, 59787.701061494416, 59846.40153598495, 1269.8412698412699, 1385.2658091211674, 1392.484780631173, 1423.8362588302477, 1424.0387738276622, 30508.694913050585, 32519.674803252612, 32574.511382329758, 32640.673593264713, 33067.17332066718, 51096.0, 51520.74239628928, 51585.48414515957, 51680.0, 51716.224256635425, 463260.0, 464586.0, 467187.0, 471341.0, 471902.0, 24993.375165621004, 27225.183244502696, 27902.16293511198, 28309.009184678438, 29334.26664333409, 48117.75941120272, 49061.75469122775, 49668.0, 50177.0, 50182.0, 39707.40438893361, 40262.39606405965, 40625.0, 40991.590084098774, 41806.0, 39773.801130995314, 40727.0, 40821.0, 40999.38500922429, 41357.1728565433, 37219.44170837385, 37453.81273093617, 42020.1595968085, 42075.57924420717, 42088.78955605203, 34201.0, 36658.0, 37412.625873740915, 37433.25133497369, 37871.05322366963, 27547.31131721723, 28112.71887281101, 28193.859030704716, 28226.85886570554, 28231.0], "value": 20746.01379108574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.53001453161744, 385.2083967446897, 387.7847794474068, 398.45809698809614, 411.87231958092974, 17776.20007099682, 18916.243350266006, 19259.903700481515, 19272.3254686086, 19273.229070837166, 18893.811061889377, 18912.71630925537, 18934.621307573874, 18967.90516047418, 19199.520011999673, 5530.806421775239, 5697.03150464422, 5751.56863235257, 5764.5964782465035, 5789.739461724233, 5410.810621628244, 5612.130119831412, 5622.606417550773, 5644.238027866227, 5646.717664116798, 5580.107182850745, 5598.608097433182, 5600.831975040755, 5601.943980560183, 5682.488576028157, 5470.370907345647, 5527.613067085305, 5574.358948720908, 5586.41342659021, 5677.261955945722, 4907.4356449008465, 4957.6033917286895, 4960.826371077031, 4962.379702537183, 5035.79856805731, 22596.548069038527, 22716.091356345725, 22761.54476910469, 23189.884050579807, 23196.884015579984, 2366.562185995579, 2381.2380038387723, 2387.236084452976, 2398.78410943016, 2487.328421326232, 13534.25561594112, 13690.52083177084, 13804.792928106086, 14013.019088663797, 14164.858351416457, 1895.3555791031115, 1919.808019198069, 1934.7775005874364, 1982.7025946108056, 2126.957460850774, 80381.59809200917, 83792.16207837965, 83917.0, 85986.57006714989, 86377.0, 10575.735606609742, 10744.293218839488, 10909.727256818484, 11095.72260693489, 11158.0, 15619.297131629104, 15669.216539173223, 15709.371625135094, 15738.449154279546, 15741.606459838367, 8197.565426050418, 8448.239658430648, 8505.65977360911, 8569.914300857037, 8603.0, 8071.860956846441, 8075.555844428495, 8148.185181481805, 8256.752297431087, 8276.172382761675, 4702.482726900038, 4732.432108146975, 4810.494898035726, 4833.178359678863, 4838.854834354975, 1895.876618187611, 1916.036063035372, 1956.9315073972343, 1985.8382846034942, 1987.837115287544, 886.3131073418024, 986.3736527305213, 1009.7929924365487, 1030.3766221435924, 1055.5250137438184, 18215.0, 18796.718049229272, 19114.904425477784, 19151.32970346059, 19201.32795352156, 980.54404701814, 990.8860481044628, 1004.2468148888333, 1006.4514839412537, 1029.3463650581934, 10364.326318789255, 10860.402677852793, 10903.781924361469, 10919.181061420426, 10947.124230061576, 449771.0, 454433.0, 477748.0, 479012.0, 483148.0, 90767.0, 95364.0, 96122.51938740262, 96144.0, 96562.0, 963.1379914976058, 974.5565767575736, 996.3573495095623, 999.7650552120245, 1012.1700205831295, 16405.0, 16574.58563535873, 16676.10503412717, 16780.412685555948, 16909.323627055273, 39191.804040979616, 39340.60659393369, 40293.1941361177, 40853.79573102116, 41906.0, 50952.0, 52393.0, 56962.715186423804, 57199.0, 57214.42785572091, 8249.876251856107, 8352.582370881553, 8385.203405676451, 8450.830983380176, 8544.91455085466, 9195.816083678423, 12464.314462704275, 12737.426815793497, 12775.48898044105, 12816.102872799187, 10953.0, 10984.0, 11147.609833655782, 11180.72048198769, 11398.487068082122, 10954.342739435659, 11083.833742494031, 11384.487698053774, 11397.601083962021, 11449.59926402572, 11076.723081923017, 11327.0, 11347.886521134684, 11461.885381146081, 11468.545395703088, 8179.509229446252, 8337.583120844054, 8404.0, 8482.066972632882, 8741.0, 10967.83548246761, 10967.890321096687, 11059.0, 11074.612388566362, 11117.944410277896], "value": 9161.55080077652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.2098661789541, 1500.677354368811, 1522.02590342181, 1677.1111311005163, 1825.525363405515, 8366.790830229247, 8803.427777194478, 8812.60343284553, 9023.323250756186, 9035.593398297076, 8716.564171791417, 8934.374593778439, 8952.0, 8955.776105597364, 8957.596908139132, 1998.9200431982704, 2204.2836078274627, 2284.6344584866424, 2288.622377307742, 2314.7685231476885, 2372.78644921957, 2374.6912901322803, 2378.464845409778, 2380.2621187431864, 2382.4996750682376, 2272.9545409091807, 2277.555876604063, 2298.4598619324447, 2302.689136966513, 2305.158617104753, 1944.9124789384512, 2163.8593491423167, 2243.05791567542, 2247.4718441166315, 2294.369048511656, 2281.6805647209403, 2287.245209081016, 2294.9196778112687, 2302.700648915647, 2304.331743794298, 8929.0, 8960.372773905829, 8992.280617550581, 8997.640094396216, 8999.955000225022, 5081.695098294077, 5210.478952104797, 5214.217867319894, 5215.6609820361555, 5217.113090774539, 3323.252268239651, 3442.862285508577, 3506.2636846262317, 3509.94735078974, 3551.271989242199, 1169.2692067457838, 1187.51311962096, 1191.3923898811581, 1201.7656556971394, 1205.2226314027403, 12519.248845069325, 12520.81218781719, 12522.499100035988, 12525.123241373016, 12538.059645526622, 4508.481524624644, 4615.930761038587, 4724.598409135193, 4725.692829966041, 4735.147673418817, 10435.94782026085, 10466.52900619474, 10475.895241047645, 10477.580896764044, 10481.842772358421, 5296.973515132399, 5301.231321458444, 5310.362756469249, 5348.3849357323625, 5357.678539287655, 4132.173565286955, 4712.410948631421, 4842.346283251716, 4861.854144375674, 4933.210686290176, 3890.0469385000856, 3948.624880636335, 4008.699347548887, 4045.635892769606, 4054.412110243998, 1197.0782497476894, 1210.5157936825165, 1219.969500762488, 1224.6509744722712, 1225.1668865171769, 834.6536187482127, 984.3011461862015, 985.3742873275521, 990.321629683669, 1000.4347543637822, 5654.321481422256, 5656.462636049569, 5723.198752174699, 5838.2702162229725, 6099.451049405486, 438.2221556736754, 440.90520538083825, 447.1057884231537, 456.9588737013685, 458.95410458954507, 4086.101057767346, 4101.0, 4121.690873184523, 4132.462779838662, 4139.544650088488, 10566.098102341652, 10920.781584368267, 10993.450327483593, 11009.064229540418, 11020.063294620048, 10752.569897204181, 10794.56821727122, 10905.400202988752, 10912.345259284468, 10918.399488028235, 8107.067687216046, 8160.591970401456, 8250.504969701837, 8256.669733210605, 8272.255497005299, 5622.718864056699, 5706.514946229451, 5736.856578585569, 5826.504747096545, 5946.524278057658, 9445.574949127444, 10045.899541004497, 10048.69853904384, 10054.296199266273, 10159.136473399843, 9795.265355098254, 9952.353097048668, 9976.650817221362, 9979.151772099453, 10052.396856188652, 7207.531510451804, 7686.846263074819, 7953.244441778022, 7980.840383192188, 8160.26557609818, 8828.161324674145, 8843.248323892283, 8911.688090916787, 8916.15296546827, 8923.910760892568, 7623.237676232332, 7700.807479813049, 7845.293923546908, 7951.960240198762, 8033.758987230392, 7639.197884222077, 7742.264484873928, 7767.495112817649, 7877.724279650185, 8015.158408367038, 7189.604571748395, 7252.129744430702, 7306.050213472215, 7317.19510853795, 7321.194668586345, 5088.389393272831, 5182.792688292577, 5207.635465517377, 5261.894762104813, 5356.982173387044, 5099.56653684441, 5279.683219006872, 5327.227552005015, 5336.706481143575, 5369.741506610201], "value": 4556.955838155094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6617019044908, 329.6176435335011, 337.9188994641287, 337.93748156591033, 340.7733856985105, 5418.431064738204, 5459.290292262005, 5471.316085489314, 5478.643888147268, 5495.697736624484, 5116.820911268106, 5167.0, 5273.8945221095655, 5350.5184533391985, 5419.187121931712, 4172.415861779354, 4204.885705288086, 4207.137536804948, 4231.809568569422, 4238.9152216955645, 4230.132822771325, 4242.681798865097, 4242.830286788525, 4252.107057517925, 4270.914581708364, 3980.800959952005, 3989.5611482736876, 4163.084121493282, 4190.2248084104385, 4210.726302790325, 4157.97921010396, 4166.395872598457, 4179.017930786263, 4187.581241875819, 4208.810603522848, 3714.4985426967282, 3742.9438558421643, 3743.737938344317, 3761.8307176177136, 3783.735138540276, 5138.640295179339, 5146.897062058775, 5163.612729045299, 5205.947940520622, 5284.0, 4775.474697783241, 4799.112164249625, 4800.1839687252905, 4813.855584332476, 4825.831095911626, 5618.775248990036, 5626.846496468214, 5649.898269837383, 5650.74571644277, 5668.489835914746, 3871.457995880579, 4082.408050832613, 4084.9795751021056, 4112.773797441139, 4114.341705327163, 5835.570285280133, 5841.007028805071, 5857.589968702235, 5888.4700376966275, 5896.616719913192, 4153.501579810442, 4158.812853421543, 4163.854939891494, 4166.562510936369, 4167.666586673119, 4112.547619761824, 4179.101493178981, 4186.22085613613, 4195.748255104703, 4224.218519573888, 4750.809967601257, 4757.666963312604, 4766.118268120409, 4782.784774685148, 4784.425868895755, 5515.420880807537, 5557.360903496069, 5621.5221706155435, 5642.661440313512, 5677.716114194356, 1420.88632909367, 1436.1239643817264, 1442.6321288071474, 1452.165005122059, 1455.0, 916.6012784438791, 917.6191880369705, 920.0477505781485, 921.7188757428914, 931.1154403316876, 4869.488703686133, 4888.902221955541, 4888.926666100011, 4923.621386011922, 4977.427595826454, 5249.895002099936, 5261.473852614785, 5262.789488420421, 5275.944811037808, 5303.681779093266, 4767.928481072787, 4811.927821082687, 4840.709557426566, 4922.852314430573, 5121.769520371592, 3093.8917137900517, 3131.9843400783307, 3136.7490600751885, 3151.448496513101, 3151.637561680436, 5954.422078149294, 5974.910376344358, 6032.909506357408, 6033.487153591994, 6043.153958445821, 5616.241807355955, 5878.2358293421585, 5881.5000724938, 5925.525957923356, 5933.406659334032, 6027.246594175728, 6060.636361818305, 6061.2422397505115, 6081.543884208702, 6099.420555047263, 5605.355384130877, 5794.797182098607, 5819.76720931175, 5909.113632955091, 5922.703864806828, 5801.82594522165, 5811.302643682785, 5824.417558244142, 5832.24180856486, 5844.327902291291, 6007.279126504847, 6042.667653279112, 6050.273967123973, 6061.36355682647, 6061.424164704346, 3922.1763429680086, 3969.8412063517135, 4067.491563554556, 4095.32427149517, 4161.97919010403, 5818.069108942549, 5829.737661805144, 5830.300363956352, 5834.329052159056, 5836.241288632451, 5647.6893770843, 5656.85857853557, 5666.773329066791, 5671.432856714296, 5673.156224227225, 5426.2674538936735, 5670.489655930986, 5674.602777805514, 5678.432156784454, 5704.201411802268, 5519.779208831602, 5524.0, 5539.9169012464035, 5540.196671482532, 5553.0, 5451.454854514517, 5673.319201695823, 5693.28833895763, 5725.8568535786935, 5733.971330143323, 5536.640118392453, 5544.7227638618715, 5556.666600004012, 5557.36090349615, 5586.329640443173], "value": 4274.824479919488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5737843361634, 801.1427772283655, 823.201494550286, 825.9174082591737, 849.8512760266951, 13363.933180334108, 13382.66543336417, 13384.732305353898, 13557.7966330505, 15344.462943796969, 14484.637884052903, 15325.0, 16144.273507692153, 16231.0, 17015.91492042538, 664.5381459885382, 812.597764106768, 818.8157664525494, 819.7212947597816, 820.2781552234026, 797.6211299632686, 824.4435006370705, 829.9709510167145, 830.244477525452, 831.7005877883987, 862.9180227878373, 867.2584939876409, 867.6963062927988, 867.9045305016443, 868.288003836854, 713.9393151582121, 840.306746933782, 860.3676297921023, 862.7411776467067, 863.3783675753448, 631.8136149835809, 633.9302676705558, 634.4987459906669, 634.7746549974738, 634.9238091429012, 16351.91824040884, 16452.095134767584, 16453.177341133014, 16457.09485978271, 16458.75311870323, 13134.60596182116, 13788.724225515434, 13963.58109256724, 13970.441182352795, 14146.575602731935, 12684.556040538537, 13001.544945926942, 13210.73578528424, 13222.140560863512, 13344.199348039148, 4383.627391671712, 4395.516493185747, 4415.337699345092, 4476.1271552047365, 4543.091381723635, 81308.0, 82733.58633206795, 82735.586322068, 84618.57690711507, 84645.0, 10468.319559228627, 10754.677359679223, 10756.677299681021, 10874.075703565128, 11148.721281967853, 21245.043973021253, 21281.255156069463, 21347.573048539252, 21348.573028539344, 21352.14591416357, 8345.248927596545, 8377.246047855722, 8555.743327700178, 8818.33862460318, 8833.779155521164, 4551.908961820811, 4710.52894710533, 4850.53919877611, 4870.878228044327, 4873.878153046131, 3402.659734026627, 3513.718902487795, 3517.9648203517636, 3522.559680039995, 3522.735794815399, 614.1678026274334, 636.5639536917226, 638.1448858529593, 646.5894157210205, 657.0144782825762, 561.4609974424517, 594.3729365519418, 626.467502622767, 652.6899722631712, 663.0220424873273, 9202.401843880127, 9203.447793132433, 9525.857112143323, 9590.280728945358, 9624.37441566296, 558.430400990995, 660.2802944790202, 710.1407297170379, 716.5163514627606, 719.0723966083693, 4754.809807607726, 4795.424549054136, 4808.3027960945465, 4860.343853579792, 4885.120678277873, 123716.00981896951, 125570.37214814051, 126519.0, 127890.36054819667, 128746.0, 85638.0, 85710.0, 88968.0, 106597.0, 108680.4565977165, 90814.27557173163, 91225.54387228022, 91834.54082729544, 93262.53368733113, 94632.0, 9519.714408567754, 9775.21798256152, 9806.313558051153, 10019.899801001897, 10074.89925100769, 48046.0, 48133.518664814306, 49309.2603610939, 51711.48288517067, 52031.73984130055, 73855.63072184604, 75354.0, 75548.62225688837, 76269.23730762622, 76481.23518764964, 12747.678675784013, 13116.475340986253, 13172.868271317164, 13222.6777322267, 13541.1198272112, 14510.274486275855, 14616.531753275645, 15319.310631021408, 15350.923245383701, 15586.06483610987, 8230.640801399344, 13494.52769153075, 13909.149135829392, 14465.710685786436, 14535.055221410574, 13041.804372934603, 13101.215381549882, 13574.728505430034, 14577.489787857374, 14765.852341476448, 14249.833973305887, 14314.141151530941, 14568.92715536458, 14872.925635371754, 14878.330475128429, 11720.941395292968, 11944.0, 11981.520739170335, 12032.75934481323, 12060.879391206327, 10354.534045968101, 10741.301815381976, 11187.16096292765, 11361.659150225507, 11414.543418263509], "value": 7648.030706572475, "unit": "score"}], "name": "dromaeo_css", "value": 7314.304492829225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 110.0, 111.0, 109.0, 109.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 128.0, 181.0, 129.0, 125.0, 154.0, 125.0, 161.0, 124.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 160.0, 158.0, 160.0, 160.0, 162.0, 160.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 126.0, 75.0, 75.0, 74.0, 75.0, 96.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 85.0, 84.0, 86.0, 118.0, 85.0, 86.0, 137.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 56.0, 56.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 80.0, 79.0, 80.0, 81.0, 116.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 121.0, 119.0, 128.0, 119.0, 118.0, 124.0, 135.0, 121.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 157.0, 160.0, 161.0, 161.0, 159.0, 162.0, 159.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 62.0, 62.0, 61.0, 66.0, 61.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1490.3999999999999, "alertThreshold": 2.0}]} 02:39:55 INFO - Return code: 0 02:39:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:55 ERROR - # TBPL SUCCESS # 02:39:55 INFO - Running post-action listener: _resource_record_post_action 02:39:55 INFO - ##### 02:39:55 INFO - ##### Finished run-tests step (success) 02:39:55 INFO - ##### 02:39:55 INFO - Running post-run listener: _resource_record_post_run 02:39:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 77824; Write bytes: 544690176; Read time: 36; Write time: 450364 02:39:55 INFO - TinderboxPrint: CPU usage
13.1% 02:39:55 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 36 02:39:55 INFO - TinderboxPrint: I/O write bytes / time
544,690,176 / 450,364 02:39:55 INFO - TinderboxPrint: CPU idle
8,271.6 (86.9%) 02:39:55 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 02:39:55 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248655872; Read time: 0; Write time: 272652 02:39:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 77824; Write bytes: 296034304; Read time: 36; Write time: 177712 02:39:56 INFO - Running post-run listener: _upload_blobber_files 02:39:56 INFO - Blob upload gear active. 02:39:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:56 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:39:56 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:39:56 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:39:56 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:00 INFO - (blobuploader) - INFO - Done attempting. 02:40:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:01 INFO - (blobuploader) - INFO - Done attempting. 02:40:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:02 INFO - (blobuploader) - INFO - Done attempting. 02:40:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:02 INFO - Return code: 0 02:40:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6306f9e5ee92986874bb4ca9a26862cb5307d8e9bc565daec2235bb9844bd3ca79f4d590a4e28b72f158085b5e5792f234cb6a0b293ebd253f3a0e6f10dfea5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1fbe66e9c626cea83df2a9a96145e2109f7b865a0e5bbfa60d69f7862b6fbe86a453477711887cfac6af4baa52427c8510e43510944bd199b7b54d93fffe2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2490d7e0ae0906a3b9e0ab007014fcbb73fcb5b6fea9e596fb5f4258ef1703c1ea567e92ee02266b0bfe08dbad0ae30f9b458c2b2d32121b213fcce771059f67"} 02:40:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:02 INFO - Contents: 02:40:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6306f9e5ee92986874bb4ca9a26862cb5307d8e9bc565daec2235bb9844bd3ca79f4d590a4e28b72f158085b5e5792f234cb6a0b293ebd253f3a0e6f10dfea5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1fbe66e9c626cea83df2a9a96145e2109f7b865a0e5bbfa60d69f7862b6fbe86a453477711887cfac6af4baa52427c8510e43510944bd199b7b54d93fffe2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2490d7e0ae0906a3b9e0ab007014fcbb73fcb5b6fea9e596fb5f4258ef1703c1ea567e92ee02266b0bfe08dbad0ae30f9b458c2b2d32121b213fcce771059f67"} 02:40:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:02 INFO - Copying logs to upload dir... 02:40:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.872402 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 02:40:02.481239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:02.484871) ========= 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=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6306f9e5ee92986874bb4ca9a26862cb5307d8e9bc565daec2235bb9844bd3ca79f4d590a4e28b72f158085b5e5792f234cb6a0b293ebd253f3a0e6f10dfea5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1fbe66e9c626cea83df2a9a96145e2109f7b865a0e5bbfa60d69f7862b6fbe86a453477711887cfac6af4baa52427c8510e43510944bd199b7b54d93fffe2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2490d7e0ae0906a3b9e0ab007014fcbb73fcb5b6fea9e596fb5f4258ef1703c1ea567e92ee02266b0bfe08dbad0ae30f9b458c2b2d32121b213fcce771059f67"} 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.011382 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6306f9e5ee92986874bb4ca9a26862cb5307d8e9bc565daec2235bb9844bd3ca79f4d590a4e28b72f158085b5e5792f234cb6a0b293ebd253f3a0e6f10dfea5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1fbe66e9c626cea83df2a9a96145e2109f7b865a0e5bbfa60d69f7862b6fbe86a453477711887cfac6af4baa52427c8510e43510944bd199b7b54d93fffe2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2490d7e0ae0906a3b9e0ab007014fcbb73fcb5b6fea9e596fb5f4258ef1703c1ea567e92ee02266b0bfe08dbad0ae30f9b458c2b2d32121b213fcce771059f67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:02.511532) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:02.511970) ========= 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=32c5991c409366f7fec8a718000001d2-1465463964.364893-1954505540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:40:02.595908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:40:02.596369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:40:02.596743) ========= ========= Total master_lag: 0.17 =========