builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1466674660.37 results: success (0) buildid: 20160622233407 builduid: 7adcbaeb1ce34cd6a5336eff7b5c26c8 revision: fd26cef5ff88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.371660) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.372144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.372460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.388108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.388404) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:37:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-23 02:37:42 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.566823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.567188) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017105 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.617142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:40.617526) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fd26cef5ff88 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fd26cef5ff88 --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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 02:37:42,416 Setting DEBUG logging. 2016-06-23 02:37:42,416 attempt 1/10 2016-06-23 02:37:42,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fd26cef5ff88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 02:37:42,728 unpacking tar archive at: mozilla-inbound-fd26cef5ff88/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665555 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:41.322156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:41.322647) ========= script_repo_revision: fd26cef5ff88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:41.323282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:41.323599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:37:41.334485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-23 02:37:41.335097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:43 INFO - MultiFileLogger online at 20160623 02:37:43 in /builds/slave/test 02:37:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:37:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:43 INFO - {'append_to_log': False, 02:37:43 INFO - 'base_work_dir': '/builds/slave/test', 02:37:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:37:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:43 INFO - 'branch': 'Mozilla-Inbound', 02:37:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:43 INFO - 'config_files': ('talos/linux_config.py',), 02:37:43 INFO - 'default_actions': ('clobber', 02:37:43 INFO - 'read-buildbot-config', 02:37:43 INFO - 'download-and-extract', 02:37:43 INFO - 'populate-webroot', 02:37:43 INFO - 'create-virtualenv', 02:37:43 INFO - 'install', 02:37:43 INFO - 'run-tests'), 02:37:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:43 INFO - 'download_minidump_stackwalk': True, 02:37:43 INFO - 'download_symbols': 'ondemand', 02:37:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:43 INFO - 'installer_path': 'installer.exe', 02:37:43 INFO - 'log_level': 'info', 02:37:43 INFO - 'log_name': 'talos', 02:37:43 INFO - 'log_to_console': True, 02:37:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:43 INFO - 'opt_config_files': (), 02:37:43 INFO - 'pip_index': False, 02:37:43 INFO - 'sps_profile': False, 02:37:43 INFO - 'sps_profile_interval': 0, 02:37:43 INFO - 'suite': 'dromaeojs-e10s', 02:37:43 INFO - 'system_bits': '32', 02:37:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:43 INFO - 'title': 'talos-linux64-ix-067', 02:37:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:43 INFO - 'use_talos_json': True, 02:37:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:43 INFO - 'work_dir': 'build'} 02:37:43 INFO - ##### 02:37:43 INFO - ##### Running clobber step. 02:37:43 INFO - ##### 02:37:43 INFO - Running pre-action listener: _resource_record_pre_action 02:37:43 INFO - Running main action method: clobber 02:37:43 INFO - rmtree: /builds/slave/test/build 02:37:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:43 INFO - Running post-action listener: _resource_record_post_action 02:37:43 INFO - ##### 02:37:43 INFO - ##### Finished clobber step (success) 02:37:43 INFO - ##### 02:37:43 INFO - ##### 02:37:43 INFO - ##### Running read-buildbot-config step. 02:37:43 INFO - ##### 02:37:43 INFO - Running pre-action listener: _resource_record_pre_action 02:37:43 INFO - Running main action method: read_buildbot_config 02:37:43 INFO - Using buildbot properties: 02:37:43 INFO - { 02:37:43 INFO - "project": "", 02:37:43 INFO - "product": "firefox", 02:37:43 INFO - "script_repo_revision": "production", 02:37:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:37:43 INFO - "repository": "", 02:37:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:37:43 INFO - "buildid": "20160622233407", 02:37:43 INFO - "pgo_build": "True", 02:37:43 INFO - "basedir": "/builds/slave/test", 02:37:43 INFO - "buildnumber": 1196, 02:37:43 INFO - "slavename": "talos-linux64-ix-067", 02:37:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:37:43 INFO - "platform": "ubuntu64_hw", 02:37:43 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:37:43 INFO - "branch": "mozilla-inbound", 02:37:43 INFO - "repo_path": "integration/mozilla-inbound", 02:37:43 INFO - "revision": "fd26cef5ff88", 02:37:43 INFO - "stage_platform": "linux64-pgo", 02:37:43 INFO - "builduid": "7adcbaeb1ce34cd6a5336eff7b5c26c8", 02:37:43 INFO - "slavebuilddir": "test" 02:37:43 INFO - } 02:37:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:37:43 INFO - Running post-action listener: _resource_record_post_action 02:37:43 INFO - ##### 02:37:43 INFO - ##### Finished read-buildbot-config step (success) 02:37:43 INFO - ##### 02:37:43 INFO - ##### 02:37:43 INFO - ##### Running download-and-extract step. 02:37:43 INFO - ##### 02:37:43 INFO - Running pre-action listener: _resource_record_pre_action 02:37:43 INFO - Running main action method: download_and_extract 02:37:43 INFO - mkdir: /builds/slave/test/build/tests 02:37: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:37:43 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:44 INFO - Downloaded 1361 bytes. 02:37:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:37:44 INFO - Using the following test package requirements: 02:37:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:37:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:37:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:37:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'jsshell-linux-x86_64.zip'], 02:37:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:37:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:37:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:37:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:37:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:37:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:37:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:44 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:47 INFO - Downloaded 24269771 bytes. 02:37:47 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:37:47 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:37:49 INFO - Return code: 0 02:37:49 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:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:49 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:53 INFO - Downloaded 24269771 bytes. 02:37:53 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:37:53 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:37:55 INFO - Return code: 0 02:37: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:37:55 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:57 INFO - Downloaded 14405384 bytes. 02:37:57 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:37:57 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:37:58 INFO - Return code: 0 02:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:58 INFO - https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:37:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:37:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:37:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYKd82rPRPKERYtBRcIjrw/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:38:07 INFO - Downloaded 60163812 bytes. 02:38:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:07 INFO - mkdir: /builds/slave/test/properties 02:38:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:07 INFO - Contents: 02:38:07 INFO - build_url:https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:08 INFO - Running post-action listener: _resource_record_post_action 02:38:08 INFO - Running post-action listener: set_extra_try_arguments 02:38:08 INFO - ##### 02:38:08 INFO - ##### Finished download-and-extract step (success) 02:38:08 INFO - ##### 02:38:08 INFO - ##### 02:38:08 INFO - ##### Running populate-webroot step. 02:38:08 INFO - ##### 02:38:08 INFO - Running pre-action listener: _resource_record_pre_action 02:38:08 INFO - Running main action method: populate_webroot 02:38:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:08 INFO - '--tppagecycles', 02:38:08 INFO - '7'], 02:38:08 INFO - 'tests': ['tsvgm']}}, 02:38:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['damp', 'tps']}, 02:38:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'tests': ['damp', 'tps']}, 02:38:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['dromaeo_dom']}, 02:38:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['basic_compositor_video']}, 02:38:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:38:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['a11yr', 02:38:08 INFO - 'ts_paint', 02:38:08 INFO - 'tpaint', 02:38:08 INFO - 'sessionrestore', 02:38:08 INFO - 'sessionrestore_no_auto_restore', 02:38:08 INFO - 'tabpaint']}, 02:38:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['tsvgx', 02:38:08 INFO - 'tsvgr_opacity', 02:38:08 INFO - 'tart', 02:38:08 INFO - 'tscrollx', 02:38:08 INFO - 'cart']}, 02:38:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:08 INFO - 'tsvgr_opacity', 02:38:08 INFO - 'tart', 02:38:08 INFO - 'tscrollx', 02:38:08 INFO - 'cart']}, 02:38:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'talos_options': ['--disable-e10s'], 02:38:08 INFO - 'tests': ['tp5o']}, 02:38:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'tests': ['tp5o']}, 02:38:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'talos_options': ['--disable-e10s', 02:38:08 INFO - '--xperf_path', 02:38:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:08 INFO - 'tests': ['tp5n']}, 02:38:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:08 INFO - 'talos_options': ['--xperf_path', 02:38:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:08 INFO - 'tests': ['tp5n']}}, 02:38:08 INFO - 'talos.zip': {'path': '', 02:38:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:08 INFO - Running post-action listener: _resource_record_post_action 02:38:08 INFO - ##### 02:38:08 INFO - ##### Finished populate-webroot step (success) 02:38:08 INFO - ##### 02:38:08 INFO - ##### 02:38:08 INFO - ##### Running create-virtualenv step. 02:38:08 INFO - ##### 02:38:08 INFO - Running pre-action listener: _resource_record_pre_action 02:38:08 INFO - Running main action method: create_virtualenv 02:38:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:08 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:38:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:08 INFO - Using real prefix '/usr' 02:38:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:11 INFO - Installing pip.................done. 02:38:11 INFO - Return code: 0 02:38:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:11 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:11 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:38:11 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:38:11 INFO - Using env: {'DISPLAY': ':0', 02:38:11 INFO - 'HOME': '/home/cltbld', 02:38:11 INFO - 'LANG': 'en_US.UTF-8', 02:38:11 INFO - 'LANGUAGE': 'en_US:en', 02:38:11 INFO - 'LOGNAME': 'cltbld', 02:38:11 INFO - 'MAIL': '/var/mail/cltbld', 02:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:11 INFO - 'MOZ_NO_REMOTE': '1', 02:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:11 INFO - 'NO_EM_RESTART': '1', 02:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:11 INFO - 'PWD': '/builds/slave/test', 02:38:11 INFO - 'SHELL': '/bin/bash', 02:38:11 INFO - 'SHLVL': '1', 02:38:11 INFO - 'TERM': 'linux', 02:38:11 INFO - 'TMOUT': '86400', 02:38:11 INFO - 'USER': 'cltbld', 02:38:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:11 INFO - '_': '/tools/buildbot/bin/python'} 02:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:11 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:38:11 INFO - Cleaning up... 02:38:11 INFO - Return code: 0 02:38:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:11 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:11 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:38:11 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:38:11 INFO - Using env: {'DISPLAY': ':0', 02:38:11 INFO - 'HOME': '/home/cltbld', 02:38:11 INFO - 'LANG': 'en_US.UTF-8', 02:38:11 INFO - 'LANGUAGE': 'en_US:en', 02:38:11 INFO - 'LOGNAME': 'cltbld', 02:38:11 INFO - 'MAIL': '/var/mail/cltbld', 02:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:11 INFO - 'MOZ_NO_REMOTE': '1', 02:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:11 INFO - 'NO_EM_RESTART': '1', 02:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:11 INFO - 'PWD': '/builds/slave/test', 02:38:11 INFO - 'SHELL': '/bin/bash', 02:38:11 INFO - 'SHLVL': '1', 02:38:11 INFO - 'TERM': 'linux', 02:38:11 INFO - 'TMOUT': '86400', 02:38:11 INFO - 'USER': 'cltbld', 02:38:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:11 INFO - '_': '/tools/buildbot/bin/python'} 02:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:11 INFO - Downloading/unpacking psutil>=3.1.1 02:38:11 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:38:11 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:38:11 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:38:11 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:38:11 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:38:11 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:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:13 INFO - Installing collected packages: psutil 02:38:13 INFO - Running setup.py install for psutil 02:38:13 INFO - building 'psutil._psutil_linux' extension 02:38:13 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:38:13 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:38:13 INFO - building 'psutil._psutil_posix' extension 02:38:13 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:38:14 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:38:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:14 INFO - Successfully installed psutil 02:38:14 INFO - Cleaning up... 02:38:14 INFO - Return code: 0 02:38:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:38:14 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:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:14 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:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:14 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:14 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:38:14 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:38:14 INFO - Using env: {'DISPLAY': ':0', 02:38:14 INFO - 'HOME': '/home/cltbld', 02:38:14 INFO - 'LANG': 'en_US.UTF-8', 02:38:14 INFO - 'LANGUAGE': 'en_US:en', 02:38:14 INFO - 'LOGNAME': 'cltbld', 02:38:14 INFO - 'MAIL': '/var/mail/cltbld', 02:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:14 INFO - 'MOZ_NO_REMOTE': '1', 02:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:14 INFO - 'NO_EM_RESTART': '1', 02:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:14 INFO - 'PWD': '/builds/slave/test', 02:38:14 INFO - 'SHELL': '/bin/bash', 02:38:14 INFO - 'SHLVL': '1', 02:38:14 INFO - 'TERM': 'linux', 02:38:14 INFO - 'TMOUT': '86400', 02:38:14 INFO - 'USER': 'cltbld', 02:38:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:14 INFO - '_': '/tools/buildbot/bin/python'} 02:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:38:16 INFO - Installing collected packages: mozsystemmonitor 02:38:16 INFO - Running setup.py install for mozsystemmonitor 02:38:16 INFO - Successfully installed mozsystemmonitor 02:38:16 INFO - Cleaning up... 02:38:16 INFO - Return code: 0 02:38:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:38:16 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:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:16 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:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:16 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:16 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:38:16 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:38:16 INFO - Using env: {'DISPLAY': ':0', 02:38:16 INFO - 'HOME': '/home/cltbld', 02:38:16 INFO - 'LANG': 'en_US.UTF-8', 02:38:16 INFO - 'LANGUAGE': 'en_US:en', 02:38:16 INFO - 'LOGNAME': 'cltbld', 02:38:16 INFO - 'MAIL': '/var/mail/cltbld', 02:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:16 INFO - 'MOZ_NO_REMOTE': '1', 02:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:16 INFO - 'NO_EM_RESTART': '1', 02:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:16 INFO - 'PWD': '/builds/slave/test', 02:38:16 INFO - 'SHELL': '/bin/bash', 02:38:16 INFO - 'SHLVL': '1', 02:38:16 INFO - 'TERM': 'linux', 02:38:16 INFO - 'TMOUT': '86400', 02:38:16 INFO - 'USER': 'cltbld', 02:38:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:16 INFO - '_': '/tools/buildbot/bin/python'} 02:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:16 INFO - Downloading/unpacking jsonschema==2.5.1 02:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:18 INFO - warning: no files found matching '*.txt' 02:38:18 INFO - no previously-included directories found matching 'build' 02:38:18 INFO - no previously-included directories found matching 'dist' 02:38:18 INFO - no previously-included directories found matching '.git*' 02:38:18 INFO - Installing collected packages: jsonschema, functools32 02:38:19 INFO - Running setup.py install for functools32 02:38:19 INFO - warning: no files found matching '*.txt' 02:38:19 INFO - no previously-included directories found matching 'build' 02:38:19 INFO - no previously-included directories found matching 'dist' 02:38:19 INFO - no previously-included directories found matching '.git*' 02:38:19 INFO - Successfully installed jsonschema functools32 02:38:19 INFO - Cleaning up... 02:38:19 INFO - Return code: 0 02:38:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38: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:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:19 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:19 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:38:19 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:38:19 INFO - Using env: {'DISPLAY': ':0', 02:38:19 INFO - 'HOME': '/home/cltbld', 02:38:19 INFO - 'LANG': 'en_US.UTF-8', 02:38:19 INFO - 'LANGUAGE': 'en_US:en', 02:38:19 INFO - 'LOGNAME': 'cltbld', 02:38:19 INFO - 'MAIL': '/var/mail/cltbld', 02:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:19 INFO - 'MOZ_NO_REMOTE': '1', 02:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:19 INFO - 'NO_EM_RESTART': '1', 02:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:19 INFO - 'PWD': '/builds/slave/test', 02:38:19 INFO - 'SHELL': '/bin/bash', 02:38:19 INFO - 'SHLVL': '1', 02:38:19 INFO - 'TERM': 'linux', 02:38:19 INFO - 'TMOUT': '86400', 02:38:19 INFO - 'USER': 'cltbld', 02:38:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:19 INFO - '_': '/tools/buildbot/bin/python'} 02:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:19 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:21 INFO - Downloading docopt-0.6.1.tar.gz 02:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:22 INFO - Running setup.py install for blobuploader 02:38:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:22 INFO - Running setup.py install for requests 02:38:22 INFO - Running setup.py install for docopt 02:38:22 INFO - Successfully installed blobuploader requests docopt 02:38:22 INFO - Cleaning up... 02:38:22 INFO - Return code: 0 02:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:22 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:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:22 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:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:22 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:22 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:38:22 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:38:22 INFO - Using env: {'DISPLAY': ':0', 02:38:22 INFO - 'HOME': '/home/cltbld', 02:38:22 INFO - 'LANG': 'en_US.UTF-8', 02:38:22 INFO - 'LANGUAGE': 'en_US:en', 02:38:22 INFO - 'LOGNAME': 'cltbld', 02:38:22 INFO - 'MAIL': '/var/mail/cltbld', 02:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:22 INFO - 'MOZ_NO_REMOTE': '1', 02:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:22 INFO - 'NO_EM_RESTART': '1', 02:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:22 INFO - 'PWD': '/builds/slave/test', 02:38:22 INFO - 'SHELL': '/bin/bash', 02:38:22 INFO - 'SHLVL': '1', 02:38:22 INFO - 'TERM': 'linux', 02:38:22 INFO - 'TMOUT': '86400', 02:38:22 INFO - 'USER': 'cltbld', 02:38:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:22 INFO - '_': '/tools/buildbot/bin/python'} 02:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:22 INFO - Running setup.py (path:/tmp/pip-bYb0E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:22 INFO - Running setup.py (path:/tmp/pip-VsknF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:23 INFO - Running setup.py (path:/tmp/pip-DQfbyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:23 INFO - Running setup.py (path:/tmp/pip-swP88F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:23 INFO - Running setup.py (path:/tmp/pip-Hen5GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:23 INFO - Running setup.py (path:/tmp/pip-dbo0ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:23 INFO - Running setup.py (path:/tmp/pip-BFtQxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:23 INFO - Running setup.py (path:/tmp/pip-n8fdA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:23 INFO - Running setup.py (path:/tmp/pip-gbKv7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:23 INFO - Running setup.py (path:/tmp/pip-G5ueXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:23 INFO - Running setup.py (path:/tmp/pip-jPOiSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:23 INFO - Running setup.py (path:/tmp/pip-mnOSNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:23 INFO - Running setup.py (path:/tmp/pip-Snit08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:23 INFO - Running setup.py (path:/tmp/pip-QNIIMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:23 INFO - Running setup.py (path:/tmp/pip-cBNG_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:23 INFO - Running setup.py (path:/tmp/pip-AUc4Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:24 INFO - Running setup.py (path:/tmp/pip-HFCyJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:24 INFO - Running setup.py install for manifestparser 02:38:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Running setup.py install for mozcrash 02:38:24 INFO - Running setup.py install for mozdebug 02:38:24 INFO - Running setup.py install for mozdevice 02:38:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Running setup.py install for mozfile 02:38:24 INFO - Running setup.py install for mozhttpd 02:38:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Running setup.py install for mozinfo 02:38:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Running setup.py install for mozInstall 02:38:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:24 INFO - Running setup.py install for mozleak 02:38:25 INFO - Running setup.py install for mozlog 02:38:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Running setup.py install for moznetwork 02:38:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Running setup.py install for mozprocess 02:38:25 INFO - Running setup.py install for mozprofile 02:38:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Running setup.py install for mozrunner 02:38:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Running setup.py install for mozscreenshot 02:38:25 INFO - Running setup.py install for moztest 02:38:25 INFO - Running setup.py install for mozversion 02:38:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:25 INFO - Cleaning up... 02:38:25 INFO - Return code: 0 02:38:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:25 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:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:25 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:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:25 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:25 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:38:25 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:38:25 INFO - Using env: {'DISPLAY': ':0', 02:38:25 INFO - 'HOME': '/home/cltbld', 02:38:25 INFO - 'LANG': 'en_US.UTF-8', 02:38:25 INFO - 'LANGUAGE': 'en_US:en', 02:38:25 INFO - 'LOGNAME': 'cltbld', 02:38:25 INFO - 'MAIL': '/var/mail/cltbld', 02:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:25 INFO - 'MOZ_NO_REMOTE': '1', 02:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:25 INFO - 'NO_EM_RESTART': '1', 02:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:25 INFO - 'PWD': '/builds/slave/test', 02:38:25 INFO - 'SHELL': '/bin/bash', 02:38:25 INFO - 'SHLVL': '1', 02:38:25 INFO - 'TERM': 'linux', 02:38:25 INFO - 'TMOUT': '86400', 02:38:25 INFO - 'USER': 'cltbld', 02:38:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:25 INFO - '_': '/tools/buildbot/bin/python'} 02:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:26 INFO - Running setup.py (path:/tmp/pip-2qT421-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:26 INFO - Running setup.py (path:/tmp/pip-dUjZFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:26 INFO - Running setup.py (path:/tmp/pip-FACau8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:26 INFO - Running setup.py (path:/tmp/pip-Um9wlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:26 INFO - Running setup.py (path:/tmp/pip-abU8qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:26 INFO - Running setup.py (path:/tmp/pip-yBD6g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:26 INFO - Running setup.py (path:/tmp/pip-RNIxtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:26 INFO - Running setup.py (path:/tmp/pip-1WYLop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:26 INFO - Running setup.py (path:/tmp/pip-f2CZhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:26 INFO - Running setup.py (path:/tmp/pip-J1slDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:26 INFO - Running setup.py (path:/tmp/pip-TRswtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:26 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:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:26 INFO - Running setup.py (path:/tmp/pip-VFGUYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:27 INFO - Running setup.py (path:/tmp/pip-XemFpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:27 INFO - Running setup.py (path:/tmp/pip-DZREDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:27 INFO - Running setup.py (path:/tmp/pip-8Nb91T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:27 INFO - Running setup.py (path:/tmp/pip-C_ldVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:27 INFO - Running setup.py (path:/tmp/pip-XiEpzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:29 INFO - Downloading blessings-1.6.tar.gz 02:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:29 INFO - Installing collected packages: blessings 02:38:29 INFO - Running setup.py install for blessings 02:38:29 INFO - Successfully installed blessings 02:38:29 INFO - Cleaning up... 02:38:30 INFO - Return code: 0 02:38:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:30 INFO - Reading from file tmpfile_stdout 02:38:30 INFO - Current package versions: 02:38:30 INFO - argparse == 1.2.1 02:38:30 INFO - blessings == 1.6 02:38:30 INFO - blobuploader == 1.2.4 02:38:30 INFO - docopt == 0.6.1 02:38:30 INFO - functools32 == 3.2.3-2 02:38:30 INFO - jsonschema == 2.5.1 02:38:30 INFO - manifestparser == 1.1 02:38:30 INFO - mozInstall == 1.12 02:38:30 INFO - mozcrash == 0.17 02:38:30 INFO - mozdebug == 0.1 02:38:30 INFO - mozdevice == 0.48 02:38:30 INFO - mozfile == 1.2 02:38:30 INFO - mozhttpd == 0.7 02:38:30 INFO - mozinfo == 0.9 02:38:30 INFO - mozleak == 0.1 02:38:30 INFO - mozlog == 3.2 02:38:30 INFO - moznetwork == 0.27 02:38:30 INFO - mozprocess == 0.22 02:38:30 INFO - mozprofile == 0.28 02:38:30 INFO - mozrunner == 6.11 02:38:30 INFO - mozscreenshot == 0.1 02:38:30 INFO - mozsystemmonitor == 0.3 02:38:30 INFO - moztest == 0.7 02:38:30 INFO - mozversion == 1.4 02:38:30 INFO - psutil == 3.1.1 02:38:30 INFO - requests == 1.2.3 02:38:30 INFO - wsgiref == 0.1.2 02:38:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38: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:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:30 INFO - Using env: {'DISPLAY': ':0', 02:38:30 INFO - 'HOME': '/home/cltbld', 02:38:30 INFO - 'LANG': 'en_US.UTF-8', 02:38:30 INFO - 'LANGUAGE': 'en_US:en', 02:38:30 INFO - 'LOGNAME': 'cltbld', 02:38:30 INFO - 'MAIL': '/var/mail/cltbld', 02:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:30 INFO - 'MOZ_NO_REMOTE': '1', 02:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:30 INFO - 'NO_EM_RESTART': '1', 02:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:30 INFO - 'PWD': '/builds/slave/test', 02:38:30 INFO - 'SHELL': '/bin/bash', 02:38:30 INFO - 'SHLVL': '1', 02:38:30 INFO - 'TERM': 'linux', 02:38:30 INFO - 'TMOUT': '86400', 02:38:30 INFO - 'USER': 'cltbld', 02:38:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:30 INFO - '_': '/tools/buildbot/bin/python'} 02:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 INFO - Cleaning up... 02:38:30 INFO - Return code: 0 02:38:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38: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:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:30 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:30 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:38:30 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:38:30 INFO - Using env: {'DISPLAY': ':0', 02:38:30 INFO - 'HOME': '/home/cltbld', 02:38:30 INFO - 'LANG': 'en_US.UTF-8', 02:38:30 INFO - 'LANGUAGE': 'en_US:en', 02:38:30 INFO - 'LOGNAME': 'cltbld', 02:38:30 INFO - 'MAIL': '/var/mail/cltbld', 02:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:30 INFO - 'MOZ_NO_REMOTE': '1', 02:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:30 INFO - 'NO_EM_RESTART': '1', 02:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:30 INFO - 'PWD': '/builds/slave/test', 02:38:30 INFO - 'SHELL': '/bin/bash', 02:38:30 INFO - 'SHLVL': '1', 02:38:30 INFO - 'TERM': 'linux', 02:38:30 INFO - 'TMOUT': '86400', 02:38:30 INFO - 'USER': 'cltbld', 02:38:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:30 INFO - '_': '/tools/buildbot/bin/python'} 02:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:30 INFO - Cleaning up... 02:38:30 INFO - Return code: 0 02:38:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:38: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:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:30 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 0x7f7716bf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', '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:38:30 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:38:30 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:38:30 INFO - Using env: {'DISPLAY': ':0', 02:38:30 INFO - 'HOME': '/home/cltbld', 02:38:30 INFO - 'LANG': 'en_US.UTF-8', 02:38:30 INFO - 'LANGUAGE': 'en_US:en', 02:38:30 INFO - 'LOGNAME': 'cltbld', 02:38:30 INFO - 'MAIL': '/var/mail/cltbld', 02:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:30 INFO - 'MOZ_NO_REMOTE': '1', 02:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:30 INFO - 'NO_EM_RESTART': '1', 02:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:30 INFO - 'PWD': '/builds/slave/test', 02:38:30 INFO - 'SHELL': '/bin/bash', 02:38:30 INFO - 'SHLVL': '1', 02:38:30 INFO - 'TERM': 'linux', 02:38:30 INFO - 'TMOUT': '86400', 02:38:30 INFO - 'USER': 'cltbld', 02:38:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:30 INFO - '_': '/tools/buildbot/bin/python'} 02:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:31 INFO - Downloading/unpacking flake8 02:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:38:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:38:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:33 INFO - no previously-included directories found matching 'docs/_build' 02:38:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:38:33 INFO - Running setup.py install for pep8 02:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:33 INFO - no previously-included directories found matching 'docs/_build' 02:38:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:38:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:38:33 INFO - Cleaning up... 02:38:33 INFO - Return code: 0 02:38:33 INFO - Running post-action listener: _resource_record_post_action 02:38:33 INFO - Running post-action listener: _start_resource_monitoring 02:38:33 INFO - Starting resource monitoring. 02:38:33 INFO - ##### 02:38:33 INFO - ##### Finished create-virtualenv step (success) 02:38:33 INFO - ##### 02:38:33 INFO - ##### 02:38:33 INFO - ##### Running install step. 02:38:33 INFO - ##### 02:38:33 INFO - Running pre-action listener: _resource_record_pre_action 02:38:33 INFO - Running main action method: install 02:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:34 INFO - Reading from file tmpfile_stdout 02:38:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:34 INFO - Reading from file tmpfile_stdout 02:38:34 INFO - Output received: 02:38:34 INFO - Usage: mozinstall [options] installer 02:38:34 INFO - Options: 02:38:34 INFO - -h, --help show this help message and exit 02:38:34 INFO - -d DEST, --destination=DEST 02:38:34 INFO - Directory to install application into. [default: 02:38:34 INFO - "/builds/slave/test"] 02:38:34 INFO - --app=APP Application being installed. [default: firefox] 02:38:34 INFO - mkdir: /builds/slave/test/build/application 02:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:38:51 INFO - Reading from file tmpfile_stdout 02:38:51 INFO - Output received: 02:38:51 INFO - /builds/slave/test/build/application/firefox/firefox 02:38:51 INFO - Running post-action listener: _resource_record_post_action 02:38:51 INFO - ##### 02:38:51 INFO - ##### Finished install step (success) 02:38:51 INFO - ##### 02:38:51 INFO - ##### 02:38:51 INFO - ##### Running run-tests step. 02:38:51 INFO - ##### 02:38:51 INFO - Running pre-action listener: _resource_record_pre_action 02:38:51 INFO - Running main action method: run_tests 02:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:51 INFO - Python 2.7.3 02:38:51 INFO - Return code: 0 02:38:51 INFO - grabbing minidump binary from tooltool 02:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b162e0>, '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 0x2a82140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a825d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:38:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:38:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:38:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:51 INFO - Return code: 0 02:38:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:38:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:38:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:38:52 INFO - Return code: 0 02:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:38:52 INFO - Using env: {'DISPLAY': ':0', 02:38:52 INFO - 'HOME': '/home/cltbld', 02:38:52 INFO - 'LANG': 'en_US.UTF-8', 02:38:52 INFO - 'LANGUAGE': 'en_US:en', 02:38:52 INFO - 'LOGNAME': 'cltbld', 02:38:52 INFO - 'MAIL': '/var/mail/cltbld', 02:38:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:52 INFO - 'MOZ_NO_REMOTE': '1', 02:38:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:52 INFO - 'NO_EM_RESTART': '1', 02:38:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:52 INFO - 'PWD': '/builds/slave/test', 02:38:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:52 INFO - 'SHELL': '/bin/bash', 02:38:52 INFO - 'SHLVL': '1', 02:38:52 INFO - 'TERM': 'linux', 02:38:52 INFO - 'TMOUT': '86400', 02:38:52 INFO - 'USER': 'cltbld', 02:38:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123', 02:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:52 INFO - '_': '/tools/buildbot/bin/python'} 02:38:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:38:52 INFO - mozversion application_buildid: 20160622233407 02:38:52 INFO - mozversion application_changeset: fd26cef5ff88205d6cb3896996c45f36ec305d8b 02:38:52 INFO - mozversion application_display_name: Nightly 02:38:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:52 INFO - mozversion application_name: Firefox 02:38:52 INFO - mozversion application_remotingname: firefox 02:38:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:38:52 INFO - mozversion application_vendor: Mozilla 02:38:52 INFO - mozversion application_version: 50.0a1 02:38:52 INFO - mozversion platform_buildid: 20160622233407 02:38:52 INFO - mozversion platform_changeset: fd26cef5ff88205d6cb3896996c45f36ec305d8b 02:38:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:38:52 INFO - mozversion platform_version: 50.0a1 02:38:52 INFO - using testdate: 1466674732 02:38:52 INFO - actual date: 1466674732 02:38:52 INFO - starting webserver on 'localhost:55769' 02:38:52 INFO - SUITE-START | Running 2 tests 02:38:52 INFO - TEST-START | dromaeo_css 02:38:52 INFO - operating with platform_type : linux_ 02:38:52 INFO - Initialising browser for dromaeo_css test... 02:38:52 INFO - TEST-INFO | started process 23308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2LI8_s/profile http://localhost:55769/getInfo.html) 02:38:56 INFO - PROCESS | 23308 | __metrics Screen width/height:1600/1200 02:38:56 INFO - PROCESS | 23308 | colorDepth:24 02:38:56 INFO - PROCESS | 23308 | Browser inner width/height: 1024/697 02:38:56 INFO - PROCESS | 23308 | __metrics 02:38:57 ERROR - PROCESS | 23308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:38:58 INFO - TEST-INFO | 23308: exit 0 02:38:58 INFO - Browser initialized. 02:38:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:58 INFO - TEST-INFO | started process 23427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2LI8_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:10 INFO - PROCESS | 23427 | RSS: Main: 184524800 02:39:10 INFO - PROCESS | 23427 | 02:39:59 INFO - PROCESS | 23427 | 1466674799670 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:42:07 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55769/tests/dromaeo/cssquery-ext.html) 02:42:08 INFO - PROCESS | 23427 | RSS: Main: 189333504 02:42:08 INFO - PROCESS | 23427 | 02:45:10 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-ext.html (next: http://localhost:55769/tests/dromaeo/cssquery-jquery.html) 02:45:11 INFO - PROCESS | 23427 | RSS: Main: 187883520 02:45:11 INFO - PROCESS | 23427 | 02:48:13 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55769/tests/dromaeo/cssquery-mootools.html) 02:48:13 INFO - PROCESS | 23427 | RSS: Main: 189497344 02:48:13 INFO - PROCESS | 23427 | 02:51:15 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55769/tests/dromaeo/cssquery-prototype.html) 02:51:16 INFO - PROCESS | 23427 | RSS: Main: 186798080 02:51:16 INFO - PROCESS | 23427 | 02:54:18 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55769/tests/dromaeo/cssquery-yui.html) 02:54:19 INFO - PROCESS | 23427 | RSS: Main: 188719104 02:54:19 INFO - PROCESS | 23427 | 02:57:21 INFO - PROCESS | 23427 | Cycle 1(1): loaded http://localhost:55769/tests/dromaeo/cssquery-yui.html (next: http://localhost:55769/tests/dromaeo/cssquery-dojo.html) 02:57:22 INFO - PROCESS | 23427 | RSS: Main: 190136320 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | __start_tp_report 02:57:22 INFO - PROCESS | 23427 | _x_x_mozilla_page_load 02:57:22 INFO - PROCESS | 23427 | _x_x_mozilla_page_load_details 02:57:22 INFO - PROCESS | 23427 | |i|pagename|runs| 02:57:22 INFO - PROCESS | 23427 | |0;dojo.html;3066.953995690065;3092.366064956684;3117.3453574749296;3141.6230052393717;3148.433282009239;5244.632875698698;5330.520253177213;5371.5165635092835;5429.239906413105;5439.646422982503;5281.815136470224;5413.998410294089;5419.647722898009;5474.91787623186;5491.066518691822;4865.756712164386;4964.255361695738;5009.549140577347;5053.140966035764;5095.6178286628465;4905.2642103684375;5077.187649976005;5113.386393632751;5120.590352771788;5126;4882.780274887638;4935.062338155739;4970.6520543561965;4993.800247990094;5038.420581633122;4986.800527978877;4990.076835785391;4992.450830408652;4997.50024997501;5055.963527476858;4934.580560652349;4970.6520543561965;4975.651704380694;4986.52628000343;5023.070731914571;5235.816746413857;5285.233641122054;5301;5353.38436079848;5361.892762144775;5710.685912274823;5726.914096288559;5729.369769325371;5741;5742.626729262584;5677.630953987978;5788.479036886701;5798.420157984167;5801.390853960358;5804.65172089676;5358.490943360374;5392.865178370533;5419;5436.945630543683;5448;5865;5901.232839730807;5902;5921.171036054956;5922.7927022554;5519.227308176858;5615.719214039282;5657.632253903483;5659.122835960433;5667.1499275108235;5726.055200891807;5756.3380211276235;5756.366799652035;5758.798442054592;5798.072308430631;5527.309086364205;5571.415001424792;5677.148427735872;5699.860027994418;5715.599908006399;5504.779808807602;5702.429757024347;5730.541556675456;5739.684317362502;5740.253767010262;4365.519792822787;4423.071155057474;4425.402570652985;4453.265211240174;4494.033782736662;3930.665893399036;3956.4658771066115;3960.4257382679352;3967.5238971323624;4025.8590949316635;5304.443033481429;5305.965336759372;5446.2647542582035;5538;5597.944020559742;5695.629784064023;5730.169125476783;5756.136579513107;5781.248437703071;5813.709314534256;5388.7305634718105;5460.672359658433;5489.972550137224;5490.0941344677685;5491.780328786884;4825.252085926687;4873.049755297683;4915.65590408668;4929.112759703288;4996.325496057985;5899;5929.377415371324;5934.673592952429;5962.195103661037;5968.880622387528;5766.0197766379815;5781.248437703071;5793.1020691791155;5794.0439827428;5803.622764520293;5814.854628634318;5956.583039187389;6006.579539432198;6016.608920420159;6062.090686397076;5752.769889204553;5756.222909907109;5759.280089988752;5765.365809761007;5771.249737534094;5627.212190293444;5807.157962095557;5871.823845284648;5881.588288819913;5886.175935369138;5447.455254474521;5623.381428042994;5671.262735844479;5679.659220446786;5700.030994730989;5611.831645050655;5619.662820230799;5658.801941932013;5669.036263835241;5710.885782284248;5572.4706152915405;5573.693446860299;5579.944200557942;5582.692951887685;5588.944110558842;5481.479259470503;5644.181593668977;5676.290463692038;5732.254806875079;5759.596828221985;5561.694106824163;5621.269234999424;5631.746571404378;5645.209670646031;5648.096304591246 02:57:22 INFO - PROCESS | 23427 | |1;ext.html;555.4584280326679;599.6012651586695;608.3308360803117;613.435639211925;618.0173524096685;31847.52228716571;34993.475097873554;35109.82445087774;35143;35217.29565408696;35449;35860.641393586055;35926.46110308347;35938.460923086175;35980.460293095624;8409.78975525612;8433.072362040171;8466.365022623297;8470.534120623362;8474.618642161087;8446.57767111645;8554;8562.443441176334;8582.141785821399;8584.656613735444;8500.489970601753;8528.488290702546;8565.143485651448;8583.098774628668;8591.05498395176;8519.148085191462;8542.060373358925;8569.528675922822;8586.656533738644;8589;8439.493630382136;8446.028706698748;8462.15378462155;8477.915220847774;8518.020427650838;32841.83579082113;33172.336553269044;33360.33279334424;33434.49848252278;33477.83261083703;2582.2253324002722;2778.3887544740123;2861.9427611447863;2933.1640482462394;3137.654857965622;26634.200973970812;27144;27340.45319093607;27346;27550.724492755016;3880.8835734927998;3936.5276166859876;3976.264391087629;4030.9395359069636;4083.8570650027104;266693;267305;267494;267712.6614366935;267952;27310.5903411449;28587.57118643222;29242.707572924424;29320.413591728047;29582.260443489085;30840.228994274872;30960.380792384476;31022.22444438862;31024.22439439032;31033.379332413224;13346.866531334757;13381.598552043455;13513.52702655422;13539.59381218565;13572.524961626295;11316;11392.715182120348;11452.656420307405;11491.253068550517;11714.23857449263;7255.56466612005;7270.054892864;7275.4179665626625;7317.743878964211;7368.1526624438875;2893.942121157565;2958.497055500527;2983.7165469280385;2985.5372417275357;2997.520396736512;855.9957200213959;936.8454205056225;941.7268991992246;1079.63292480557;1092.0608276881876;27921.860390697915;28212.576811347848;28325.264380768072;28599.28501787472;28623.71376286252;1002.9899701003043;1011.544804837826;1051.3954476176077;1087.977301336741;1099.8020356335937;14469.638259043608;14685.632859178393;14936.25318734059;15035.699286014218;15054.774178387333;503368;507934;509748;510854;511136;47035.76482117636;47261;47265.76367118143;47363;47462;1192.5366512439748;1196.6350263169816;1214.9453274602663;1219.2989031307034;1220.9926810381294;26409.33976650522;27709.58435623427;28027;28080;28220.576691349237;41421.1715765677;41423.37864932089;41611.7919410401;41869;41873.581264188186;438726;439679;440873;441753;442966;24769.1330803421;24837;25109.497810044064;25212.24363269105;25519;39923.80038099791;40344;40582;40584.59415405808;40973;35186.64813351936;35929.28141437209;36419.089522762144;36494.27011459809;36856.631433686394;34447.4832877512;34931.12672183114;34948.65051349556;35208.64791352156;35246.823765881;35305.646943530235;35662.28675426425;35695;36332.27335453223;36459.45310820287;31301.8434907824;31910.62904556075;31932.5210121853;32193.51709724403;32588.51117233196;25140;25378.61932071057;25439;25639.230823075337;25907.22278331653 02:57:22 INFO - PROCESS | 23427 | |2;jquery.html;349.38333840771037;350.70190338212524;359.53081228996166;364.4515004917599;369.77443759306817;16676.91661541692;18081.367152149676;18352.357667481625;18535.814641853576;18746.156422960965;14480.565583032527;15847.445339413123;16687.582810429747;16694.332226710947;16703.49889503314;5387.946120538793;5587.636803607773;5635.8591035224035;5637.577181711388;5642.351129620085;4040.2323558523785;5497.972510137443;5913.615614985034;6266.5300102492265;6268.404501572343;6229.408206220424;6254.530910181755;6271.310155882849;6288.245410550718;6309.9369006310035;6130.141780150782;6230.8442288942915;6254.843628909268;6298.401651843067;6305.4009869062365;5397.676139431646;5424.321959755031;5464.726763661801;5491.148871924858;5505.834824955257;21187.258445954318;21711.891440542855;21743.13027478899;21885.452863678536;21914.89042554793;2054.6301665700166;2339.7309309429465;2347.1784875293683;2347.718273807137;2349.048635302688;9339.813203735956;9373.1564159226;9524.952375238148;9635.421874687541;10818.296810707358;1689.628281778019;1845.418693111679;1907.761529808774;1964.1063316191098;1972.9506762330914;80633.19366806374;81747.5912620439;82917.58541207315;83258.99999999939;83625.16374836235;9855.507224638739;9918.454485003394;9990.600375985025;10062.943390943992;10089.495525223709;13386.933065334611;13485.325733713471;13524.459021639024;13567.118137321042;13580.253086080163;7185.748498802622;7223.349898509159;7362.300581444754;7447.962760186165;7508.62456877154;7082.079329687211;7128.261085209862;7235.89146162808;7261.89107163393;7308.1230252369;4078.7144899857317;4150.294449943517;4229.175310814362;4309.892252693645;4320.762358070274;1492.156931333793;1554.759012353087;1590.157216675164;1596.4093285484446;1600.5038438084232;872.5768002518773;880.3881302494705;898.7303808857316;916.5279880861361;925.5557332480313;17481;17848.46454606364;18031.278748849898;18149.183286752126;18226.27094916215;899.5592159841631;904.5386852705036;907.7186072317603;909.663424532927;913.7715571107224;7503.662335194929;10106.444145571917;10151.593936242616;10181.236407269484;10254.230932680079;419493;422313;422339;423676;475915;83717.58141209255;89420;91343;91655.5417222923;93848.53075734578;412.67604930129704;425.46604011964786;427.1393142817226;430.85350980666726;433.02137169995405;9142.588583513625;9855.753606159617;9897;10889.673309800719;10895.128389728961;41023.38464923088;41274.1745165101;41377.37933930933;42584.57415425806;48524;42068.78965605152;53660.73169634127;61170.16489505322;62052;62507.37492625016;8166.836663266583;8227.177282271725;8294.37792165578;8403.94950631171;8575.785605359915;12012.459439325427;13294.268815215257;14129.929350353183;14142.717145657234;14397.496087636882;11534.077273818242;12069.939650302043;12150.513979441077;12159.452824622736;12419.565315213924;11682.299062056303;12014.879851201726;12028.15802893789;12201.450934708137;12248.571300004458;11994.820077699016;12236.082293828176;12304.26174429537;12322.075844311534;12425.689357766129;8273.83452330938;8285.295749861329;8372.706955256781;8461.61922713467;8562.52906090171;11621.418929053345;11698.181127321346;12071.275723456269;12179.330136842558;12258.632241032783 02:57:22 INFO - PROCESS | 23427 | |3;mootools.html;1323.947042118315;1329.6609364612025;1364.9658758531036;1517.1124891938216;1554.4481708993308;7694.499857509272;7812.765617031491;8321.66713331466;8384.496930184194;8534.317254619631;8620.310375169987;8689.782755431117;8702;8713.912860871389;8737.21365077143;2303.9424014399606;2339.1695947938492;2346.4603141277516;2348.154664320843;2350.6944097267415;2295.540891821634;2306.4003359126664;2342.5197834443984;2350.4476448034698;2369.1471070414636;2273.783990520898;2303.2284184798114;2319.211468100845;2331.8600883946933;2373.299876536426;2191.0906973605934;2200.3179014505395;2203.5152266501423;2214.446388402899;2223.321886824518;2165.9241926532495;2177.0965049504593;2181.465540942479;2182.1380554680973;2200.922967696123;8559.871601925975;8608.913910860874;8658.78353041179;8691.782705432352;8717.69488067921;4968.453470118284;5122.052420302219;5128.307678463434;5128.435872054071;5160.56135228506;3127.3588914272746;3207.6471588125287;3316.403047451458;3378.611459682119;3384.8307584620916;1105.9059979901638;1113.7549739057395;1118.8937050980144;1131.0555686002199;1137.562038615139;11360.886391136148;11504.137189710722;11558.133140014448;11573.016293615054;11613.070954323633;4448.799804008828;4474.888127796766;4475.172093162775;4560.703554268962;4575.473820510684;9491.38306010107;9528.714138575853;9547.809043819223;9559.617615295449;9572.186364158984;5057.721825299644;5076.537879128619;5104.2343648453025;5116.590672746172;5143.5113664201845;4177.770222637723;4506.752128632957;4585.495595484494;4665.6967297125575;4692.882677933079;3610.1696609779374;3612.5664920209742;3729.6829769469355;3782.167923056978;3795.4686343911876;1213.9696507587205;1216.7748966441236;1233.3278363292027;1240.64021433785;1244.6390546741525;842.6839935024366;859.8022454835298;865.8051938313829;880.6521424037597;888.05865782271;5742.196092547047;5746.339170995306;5778.988676981511;5814.127880817911;5850.736716847752;412.5750477008686;414.0621492319898;418.4852631263563;420.17226064652584;420.88425682937435;3905.1994341159993;3962.841486340514;3967.563568007517;3985.1830374773103;3993.6006399360413;10414.114800241912;10570.10154136907;10632.78734425307;10783.083437907866;10809.243352965374;10577.31247468912;10637.893621063691;10746.355218686904;10783.191260655482;10858.457077146111;8068.031836179696;8095.109537950821;8275.751727448187;8283.544405057659;8287.709930152416;5595.972020139873;5679.488846003879;5762.337331206965;5829.417058294137;5857.092150716646;10014.449205293779;10022.799544009225;10027.498625068863;10080.092791648787;10176.643817466353;9808.9019109808;10124.544395502073;10292.536835842555;10301.433421161908;10309.48452577383;6792.898106528505;7006.773814582326;7281.235470275757;7287.1984081752025;7341.155767086853;8357.582120894052;8369.539675317916;8430.114837942174;8451.830963380575;8452.32381409498;6874.931250687429;6997.195322537973;7091.751788687371;7182.784516464514;7189.820254493679;7154.570725756263;7212.4230061596;7233;7267.164276108315;7282.089738782653;6574.276829548841;6680.03139544773;6682;6688.063671086149;6703.631300278336;4786.712797232177;4870.586000189882;4878.097551952758;4913.63147763912;4934.407871055496;4992.400911890596;5006.123928312603;5022.121128802518;5054.368203974504;5089.440161582297 02:57:22 INFO - PROCESS | 23427 | |4;prototype.html;305.38922155688624;306.03598664207743;306.13669452144944;321.0897106702498;321.12333330009074;5581.0512212923795;5588.776448942038;5643.435656434354;5656.331382242238;5660.5471562275025;5588.329400471939;5589.217509548656;5590.524805391537;5591.720413979295;5623.915641265385;4129.876103716886;4235.830566777326;4346.543612920629;4356.3465480178065;4377.934330985022;4320.913581728363;4351.108022855323;4357.169988604778;4360.80376383062;4366.97816510917;4192.0777428965575;4278.780547543935;4305.203537345586;4316.287812510932;4322.762248076355;4204.432401625772;4240.639545638609;4302.806373713191;4306.2894622387585;4315.25981002066;3772.4907137536356;3773.9622603773887;3782.5082739244;3789.4315852622326;3798.126430920876;5388.568914486832;5435.945640543623;5447.536959358459;5496.31296087989;5502.202180683818;4892.902141957176;4897.579701886449;4917.262410638397;4921.286413470027;4968.87577810554;5778.451047150514;5781.508571771405;5793.971030144822;5816.836632673482;5859.326177489558;4103.835846566134;4117.649999750025;4159.7920103994675;4161.52142503613;4166.708330416872;5883.676397798119;6098.908516372214;6110.342001229435;6138.0792881067755;6139.754409823557;4266.807993640294;4268.295731204378;4288.849890253826;4323.724501272132;4326.221280169537;4340.589308474759;4363.2800587903275;4367.694261401735;4371.213181627274;4404.1411924674385;4819.192802698988;4821.493743156988;4828.913494463788;4848.418189817174;5011.473795251446;5790.739416726257;5808.186853840466;5853.824385268449;5918.644881307136;5924.526037916957;1502;1504.2704288420107;1513.3038802151134;1516.1200111861212;1524.9466268680765;926.5645146781002;928.3687092776977;952.1240458777941;956.990430095704;957.4638202606562;5031.823886163967;5120.308758317654;5141.71720555373;5147.922781158286;5174.379074511083;5268.631195816256;5311.547494128848;5370.838874833683;5380.578739567132;5413.593980451403;5043.5460808527405;5073.365829271341;5269.473052694777;5773.336066352424;5784.623999440023;3223.5325877747596;3226.38698647261;3236.7086962173516;3246.318273162662;3250.2037000934924;6242;6364.363563643598;6368.5860419072615;6386.84032899172;6411.653552753974;6175.2589689237575;6175.783847565313;6189.45263684079;6240.906386404207;6248.5313601479165;6301.369863013662;6346.238451385863;6349.174607301114;6366.522510811707;6373.426391624684;5942;6155.491904483251;6165.876682466415;6187;6200.875982480235;6090.984962443619;6094.2077529920825;6111.524832442868;6114.694265286629;6142.78500252489;6136.509079273558;6206.658633775186;6304.89664308735;6312.84217894538;6420.903686444801;4210.59999300066;4213.283741763847;4224.1340525191645;4244.8514301999285;4268.509121450948;5846.795362162304;5911.349751527243;6161.784337548164;6180.013891040344;6198.256209254918;5879.353271140257;5899.587028908107;5909.6158749681135;5913.763449461973;5924.229850119457;5808.680522571299;5894.440028197314;5903.321118071477;5903.557233207441;5906.2026626406605;5549.862278232872;5725.51333136688;5751.683657398883;5767.221425107725;5780.826575202751;5878.911816322673;5912.970435147797;5925.614835035709;5952.672603006876;5969.70151492415;5658.830235092953;5713.9142912855505;5773.509251713652;5815.273090863642;5829.3386384880105 02:57:22 INFO - PROCESS | 23427 | |5;yui.html;619.4517851701246;629.1569297141834;639.8592309691868;648.743746220243;679.721314261153;12825.48698052078;12886.80669789954;13265.933670331648;13281.800772988412;13385.99605029623;11527.596534121307;11655.825162622568;11679.416029198548;11684.24052436591;11689.357085360301;662.4667142949924;767.15995984397;769.465221670939;784.7175016993906;790.9406794490408;752.431913905001;753.909530856298;758.0524344569288;759.1421693486353;763.0195199169069;810.4084018666377;811.7970507373157;812.4962523235603;812.5815205169342;818.7461886815106;801.6552882260596;808.5229714468462;808.6724876425028;810.833779075294;814.0841553252591;587.0694948506622;587.8736071744595;588.2323567744135;588.5115354255958;591.8816236752667;12652.557160499338;12770.106092573524;12839.871601283961;12911.935440322739;12957.028222883322;13524.797128043087;13904.374303156383;13940.442382304796;13976.301184940814;14199;11640.185187036826;11656.30062196271;11732.35472049037;11758.143241358684;11824.586139485164;3740.2706472237924;3768.9057773555605;3770.755650635284;3774.1130834253927;3916.74541154824;72247.27752722458;72457;75428.62285688591;75557.62221188915;75873;10713.277989812355;10831.458427078614;11031.172662050218;11198.720031999103;11222;20575.279865204648;20585.69121463179;20663.8966805165;20697;20747.170113195603;8094;8104.675812967415;8157.629031300104;8214.671413143527;8359.498430094214;4712.64655150865;4783.449903261169;4812;4840.782164802592;4965.652404331662;3443.896683099511;3527.8588856445967;3536.8585256589963;3551.662592053751;3561.3589553880033;568.3009897825698;607.8055022392792;616.950643948483;620.6679426506797;632.4624069540854;565.7906574567354;587.2453896742666;596.9344719675358;630.1335663462738;649.9837504062436;8199.754007379788;8456.746297611082;8562.700305489403;8586.656533738706;8847.336449766293;541.2071315522778;624.8437890527368;648.3386945315846;649.6394501051961;663.9834004149935;4121;4336.132773445261;4371.278739008028;4557.840475583339;4571.657125715585;68266.65866670635;99794;111488.44255778831;118214.4089279548;118493;96783.51608241914;100051;100261;100608;101629;53623.19565206525;85916.57041714876;86439;87268.56365718131;87980.56009719911;8295.58522073906;8484.533350665773;8592.441491303045;8624.284900567076;8728.956355218183;45114.548854511035;45705.31442028306;50713.74643126761;51266;52226.477735222164;48556.27165592448;49286;59386.10920836104;75338.62330688312;76918.2308176911;12590.307533085768;12593.748125037264;13000.67498312512;13011.414486348327;13354.732905342033;13733.587992360246;13894.096883702527;13976.881849451816;14522.49171279;14838.480653177086;12497.18768280059;12505.93747031259;12632.305223212812;12717.236965782082;12898.548550800677;13142.40859161321;13246.536371226961;13484;13658.795118073038;14118.78821817653;11128.332300062022;12090.697732556404;12245;12303.507859685513;12452.626421207378;9376.484293363657;9545.90454095478;9582.329236953346;9706.5146742664;9715.611375544899;9480.85778713306;9521.952390238004;9791.314607977372;10380.169586433218;10380.740481488023 02:57:22 INFO - PROCESS | 23427 | __end_tp_report 02:57:22 INFO - PROCESS | 23427 | __start_cc_report 02:57:22 INFO - PROCESS | 23427 | _x_x_mozilla_cycle_collect,363 02:57:22 INFO - PROCESS | 23427 | __end_cc_report 02:57:22 INFO - PROCESS | 23427 | __startTimestamp1466675842076__endTimestamp 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | ------- Summary: start ------- 02:57:22 INFO - PROCESS | 23427 | Number of tests: 6 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#0] dojo.html Cycles:165 Average:5367.09 Median:5573.69 stddev:595.31 (10.7%) stddev-sans-first:569.13 02:57:22 INFO - PROCESS | 23427 | Values: 3067.0 3092.4 3117.3 3141.6 3148.4 5244.6 5330.5 5371.5 5429.2 5439.6 5281.8 5414.0 5419.6 5474.9 5491.1 4865.8 4964.3 5009.5 5053.1 5095.6 4905.3 5077.2 5113.4 5120.6 5126.0 4882.8 4935.1 4970.7 4993.8 5038.4 4986.8 4990.1 4992.5 4997.5 5056.0 4934.6 4970.7 4975.7 4986.5 5023.1 5235.8 5285.2 5301.0 5353.4 5361.9 5710.7 5726.9 5729.4 5741.0 5742.6 5677.6 5788.5 5798.4 5801.4 5804.7 5358.5 5392.9 5419.0 5436.9 5448.0 5865.0 5901.2 5902.0 5921.2 5922.8 5519.2 5615.7 5657.6 5659.1 5667.1 5726.1 5756.3 5756.4 5758.8 5798.1 5527.3 5571.4 5677.1 5699.9 5715.6 5504.8 5702.4 5730.5 5739.7 5740.3 4365.5 4423.1 4425.4 4453.3 4494.0 3930.7 3956.5 3960.4 3967.5 4025.9 5304.4 5306.0 5446.3 5538.0 5597.9 5695.6 5730.2 5756.1 5781.2 5813.7 5388.7 5460.7 5490.0 5490.1 5491.8 4825.3 4873.0 4915.7 4929.1 4996.3 5899.0 5929.4 5934.7 5962.2 5968.9 5766.0 5781.2 5793.1 5794.0 5803.6 5814.9 5956.6 6006.6 6016.6 6062.1 5752.8 5756.2 5759.3 5765.4 5771.2 5627.2 5807.2 5871.8 5881.6 5886.2 5447.5 5623.4 5671.3 5679.7 5700.0 5611.8 5619.7 5658.8 5669.0 5710.9 5572.5 5573.7 5579.9 5582.7 5588.9 5481.5 5644.2 5676.3 5732.3 5759.6 5561.7 5621.3 5631.7 5645.2 5648.1 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#1] ext.html Cycles:180 Average:52380.68 Median:34971.06 stddev:111633.14 (319.2%) stddev-sans-first:111878.49 02:57:22 INFO - PROCESS | 23427 | Values: 555.5 599.6 608.3 613.4 618.0 31847.5 34993.5 35109.8 35143.0 35217.3 35449.0 35860.6 35926.5 35938.5 35980.5 8409.8 8433.1 8466.4 8470.5 8474.6 8446.6 8554.0 8562.4 8582.1 8584.7 8500.5 8528.5 8565.1 8583.1 8591.1 8519.1 8542.1 8569.5 8586.7 8589.0 8439.5 8446.0 8462.2 8477.9 8518.0 32841.8 33172.3 33360.3 33434.5 33477.8 2582.2 2778.4 2861.9 2933.2 3137.7 26634.2 27144.0 27340.5 27346.0 27550.7 3880.9 3936.5 3976.3 4030.9 4083.9 266693.0 267305.0 267494.0 267712.7 267952.0 27310.6 28587.6 29242.7 29320.4 29582.3 30840.2 30960.4 31022.2 31024.2 31033.4 13346.9 13381.6 13513.5 13539.6 13572.5 11316.0 11392.7 11452.7 11491.3 11714.2 7255.6 7270.1 7275.4 7317.7 7368.2 2893.9 2958.5 2983.7 2985.5 2997.5 856.0 936.8 941.7 1079.6 1092.1 27921.9 28212.6 28325.3 28599.3 28623.7 1003.0 1011.5 1051.4 1088.0 1099.8 14469.6 14685.6 14936.3 15035.7 15054.8 503368.0 507934.0 509748.0 510854.0 511136.0 47035.8 47261.0 47265.8 47363.0 47462.0 1192.5 1196.6 1214.9 1219.3 1221.0 26409.3 27709.6 28027.0 28080.0 28220.6 41421.2 41423.4 41611.8 41869.0 41873.6 438726.0 439679.0 440873.0 441753.0 442966.0 24769.1 24837.0 25109.5 25212.2 25519.0 39923.8 40344.0 40582.0 40584.6 40973.0 35186.6 35929.3 36419.1 36494.3 36856.6 34447.5 34931.1 34948.7 35208.6 35246.8 35305.6 35662.3 35695.0 36332.3 36459.5 31301.8 31910.6 31932.5 32193.5 32588.5 25140.0 25378.6 25439.0 25639.2 25907.2 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#2] jquery.html Cycles:180 Average:26836.41 Median:213952.59 stddev:71880.92 (33.6%) stddev-sans-first:72055.05 02:57:22 INFO - PROCESS | 23427 | Values: 349.4 350.7 359.5 364.5 369.8 16676.9 18081.4 18352.4 18535.8 18746.2 14480.6 15847.4 16687.6 16694.3 16703.5 5387.9 5587.6 5635.9 5637.6 5642.4 4040.2 5498.0 5913.6 6266.5 6268.4 6229.4 6254.5 6271.3 6288.2 6309.9 6130.1 6230.8 6254.8 6298.4 6305.4 5397.7 5424.3 5464.7 5491.1 5505.8 21187.3 21711.9 21743.1 21885.5 21914.9 2054.6 2339.7 2347.2 2347.7 2349.0 9339.8 9373.2 9525.0 9635.4 10818.3 1689.6 1845.4 1907.8 1964.1 1973.0 80633.2 81747.6 82917.6 83259.0 83625.2 9855.5 9918.5 9990.6 10062.9 10089.5 13386.9 13485.3 13524.5 13567.1 13580.3 7185.7 7223.3 7362.3 7448.0 7508.6 7082.1 7128.3 7235.9 7261.9 7308.1 4078.7 4150.3 4229.2 4309.9 4320.8 1492.2 1554.8 1590.2 1596.4 1600.5 872.6 880.4 898.7 916.5 925.6 17481.0 17848.5 18031.3 18149.2 18226.3 899.6 904.5 907.7 909.7 913.8 7503.7 10106.4 10151.6 10181.2 10254.2 419493.0 422313.0 422339.0 423676.0 475915.0 83717.6 89420.0 91343.0 91655.5 93848.5 412.7 425.5 427.1 430.9 433.0 9142.6 9855.8 9897.0 10889.7 10895.1 41023.4 41274.2 41377.4 42584.6 48524.0 42068.8 53660.7 61170.2 62052.0 62507.4 8166.8 8227.2 8294.4 8403.9 8575.8 12012.5 13294.3 14129.9 14142.7 14397.5 11534.1 12069.9 12150.5 12159.5 12419.6 11682.3 12014.9 12028.2 12201.5 12248.6 11994.8 12236.1 12304.3 12322.1 12425.7 8273.8 8285.3 8372.7 8461.6 8562.5 11621.4 11698.2 12071.3 12179.3 12258.6 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#3] mootools.html Cycles:180 Average:5581.22 Median:4580.48 stddev:3207.37 (70.0%) stddev-sans-first:3200.41 02:57:22 INFO - PROCESS | 23427 | Values: 1323.9 1329.7 1365.0 1517.1 1554.4 7694.5 7812.8 8321.7 8384.5 8534.3 8620.3 8689.8 8702.0 8713.9 8737.2 2303.9 2339.2 2346.5 2348.2 2350.7 2295.5 2306.4 2342.5 2350.4 2369.1 2273.8 2303.2 2319.2 2331.9 2373.3 2191.1 2200.3 2203.5 2214.4 2223.3 2165.9 2177.1 2181.5 2182.1 2200.9 8559.9 8608.9 8658.8 8691.8 8717.7 4968.5 5122.1 5128.3 5128.4 5160.6 3127.4 3207.6 3316.4 3378.6 3384.8 1105.9 1113.8 1118.9 1131.1 1137.6 11360.9 11504.1 11558.1 11573.0 11613.1 4448.8 4474.9 4475.2 4560.7 4575.5 9491.4 9528.7 9547.8 9559.6 9572.2 5057.7 5076.5 5104.2 5116.6 5143.5 4177.8 4506.8 4585.5 4665.7 4692.9 3610.2 3612.6 3729.7 3782.2 3795.5 1214.0 1216.8 1233.3 1240.6 1244.6 842.7 859.8 865.8 880.7 888.1 5742.2 5746.3 5779.0 5814.1 5850.7 412.6 414.1 418.5 420.2 420.9 3905.2 3962.8 3967.6 3985.2 3993.6 10414.1 10570.1 10632.8 10783.1 10809.2 10577.3 10637.9 10746.4 10783.2 10858.5 8068.0 8095.1 8275.8 8283.5 8287.7 5596.0 5679.5 5762.3 5829.4 5857.1 10014.4 10022.8 10027.5 10080.1 10176.6 9808.9 10124.5 10292.5 10301.4 10309.5 6792.9 7006.8 7281.2 7287.2 7341.2 8357.6 8369.5 8430.1 8451.8 8452.3 6874.9 6997.2 7091.8 7182.8 7189.8 7154.6 7212.4 7233.0 7267.2 7282.1 6574.3 6680.0 6682.0 6688.1 6703.6 4786.7 4870.6 4878.1 4913.6 4934.4 4992.4 5006.1 5022.1 5054.4 5089.4 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#4] prototype.html Cycles:180 Average:4910.05 Median:5588.55 stddev:1466.70 (26.2%) stddev-sans-first:1429.51 02:57:22 INFO - PROCESS | 23427 | Values: 305.4 306.0 306.1 321.1 321.1 5581.1 5588.8 5643.4 5656.3 5660.5 5588.3 5589.2 5590.5 5591.7 5623.9 4129.9 4235.8 4346.5 4356.3 4377.9 4320.9 4351.1 4357.2 4360.8 4367.0 4192.1 4278.8 4305.2 4316.3 4322.8 4204.4 4240.6 4302.8 4306.3 4315.3 3772.5 3774.0 3782.5 3789.4 3798.1 5388.6 5435.9 5447.5 5496.3 5502.2 4892.9 4897.6 4917.3 4921.3 4968.9 5778.5 5781.5 5794.0 5816.8 5859.3 4103.8 4117.6 4159.8 4161.5 4166.7 5883.7 6098.9 6110.3 6138.1 6139.8 4266.8 4268.3 4288.8 4323.7 4326.2 4340.6 4363.3 4367.7 4371.2 4404.1 4819.2 4821.5 4828.9 4848.4 5011.5 5790.7 5808.2 5853.8 5918.6 5924.5 1502.0 1504.3 1513.3 1516.1 1524.9 926.6 928.4 952.1 957.0 957.5 5031.8 5120.3 5141.7 5147.9 5174.4 5268.6 5311.5 5370.8 5380.6 5413.6 5043.5 5073.4 5269.5 5773.3 5784.6 3223.5 3226.4 3236.7 3246.3 3250.2 6242.0 6364.4 6368.6 6386.8 6411.7 6175.3 6175.8 6189.5 6240.9 6248.5 6301.4 6346.2 6349.2 6366.5 6373.4 5942.0 6155.5 6165.9 6187.0 6200.9 6091.0 6094.2 6111.5 6114.7 6142.8 6136.5 6206.7 6304.9 6312.8 6420.9 4210.6 4213.3 4224.1 4244.9 4268.5 5846.8 5911.3 6161.8 6180.0 6198.3 5879.4 5899.6 5909.6 5913.8 5924.2 5808.7 5894.4 5903.3 5903.6 5906.2 5549.9 5725.5 5751.7 5767.2 5780.8 5878.9 5913.0 5925.6 5952.7 5969.7 5658.8 5713.9 5773.5 5815.3 5829.3 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - PROCESS | 23427 | [#5] yui.html Cycles:180 Average:19341.44 Median:48921.14 stddev:28333.64 (57.9%) stddev-sans-first:28378.25 02:57:22 INFO - PROCESS | 23427 | Values: 619.5 629.2 639.9 648.7 679.7 12825.5 12886.8 13265.9 13281.8 13386.0 11527.6 11655.8 11679.4 11684.2 11689.4 662.5 767.2 769.5 784.7 790.9 752.4 753.9 758.1 759.1 763.0 810.4 811.8 812.5 812.6 818.7 801.7 808.5 808.7 810.8 814.1 587.1 587.9 588.2 588.5 591.9 12652.6 12770.1 12839.9 12911.9 12957.0 13524.8 13904.4 13940.4 13976.3 14199.0 11640.2 11656.3 11732.4 11758.1 11824.6 3740.3 3768.9 3770.8 3774.1 3916.7 72247.3 72457.0 75428.6 75557.6 75873.0 10713.3 10831.5 11031.2 11198.7 11222.0 20575.3 20585.7 20663.9 20697.0 20747.2 8094.0 8104.7 8157.6 8214.7 8359.5 4712.6 4783.4 4812.0 4840.8 4965.7 3443.9 3527.9 3536.9 3551.7 3561.4 568.3 607.8 617.0 620.7 632.5 565.8 587.2 596.9 630.1 650.0 8199.8 8456.7 8562.7 8586.7 8847.3 541.2 624.8 648.3 649.6 664.0 4121.0 4336.1 4371.3 4557.8 4571.7 68266.7 99794.0 111488.4 118214.4 118493.0 96783.5 100051.0 100261.0 100608.0 101629.0 53623.2 85916.6 86439.0 87268.6 87980.6 8295.6 8484.5 8592.4 8624.3 8729.0 45114.5 45705.3 50713.7 51266.0 52226.5 48556.3 49286.0 59386.1 75338.6 76918.2 12590.3 12593.7 13000.7 13011.4 13354.7 13733.6 13894.1 13976.9 14522.5 14838.5 12497.2 12505.9 12632.3 12717.2 12898.5 13142.4 13246.5 13484.0 13658.8 14118.8 11128.3 12090.7 12245.0 12303.5 12452.6 9376.5 9545.9 9582.3 9706.5 9715.6 9480.9 9522.0 9791.3 10380.2 10380.7 02:57:22 INFO - PROCESS | 23427 | -------- Summary: end -------- 02:57:22 INFO - PROCESS | 23427 | 02:57:22 INFO - TEST-INFO | 23427: exit 0 02:57:22 INFO - TEST-OK | dromaeo_css | took 1110296ms 02:57:22 INFO - TEST-START | kraken 02:57:22 INFO - operating with platform_type : linux_ 02:57:22 INFO - Initialising browser for kraken test... 02:57:22 INFO - TEST-INFO | started process 23658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GR1Wg/profile http://localhost:55769/getInfo.html) 02:57:26 INFO - PROCESS | 23658 | __metrics Screen width/height:1600/1200 02:57:26 INFO - PROCESS | 23658 | colorDepth:24 02:57:26 INFO - PROCESS | 23658 | Browser inner width/height: 1024/697 02:57:26 INFO - PROCESS | 23658 | __metrics 02:57:27 ERROR - PROCESS | 23658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:57:28 INFO - TEST-INFO | 23658: exit 0 02:57:28 INFO - Browser initialized. 02:57:28 INFO - Running cycle 1/1 for kraken test... 02:57:28 INFO - TEST-INFO | started process 23777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GR1Wg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:40 INFO - PROCESS | 23777 | RSS: Main: 185020416 02:57:40 INFO - PROCESS | 23777 | 02:57:42 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55769/tests/kraken/driver.html?testName=audio-beat-detection) 02:57:43 INFO - PROCESS | 23777 | RSS: Main: 191090688 02:57:43 INFO - PROCESS | 23777 | 02:57:46 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55769/tests/kraken/driver.html?testName=audio-dft) 02:57:46 INFO - PROCESS | 23777 | RSS: Main: 190021632 02:57:46 INFO - PROCESS | 23777 | 02:57:49 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55769/tests/kraken/driver.html?testName=audio-fft) 02:57:50 INFO - PROCESS | 23777 | RSS: Main: 184610816 02:57:50 INFO - PROCESS | 23777 | 02:57:52 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55769/tests/kraken/driver.html?testName=audio-oscillator) 02:57:53 INFO - PROCESS | 23777 | RSS: Main: 185339904 02:57:53 INFO - PROCESS | 23777 | 02:57:55 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:56 INFO - PROCESS | 23777 | RSS: Main: 185556992 02:57:56 INFO - PROCESS | 23777 | 02:57:59 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55769/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:59 INFO - PROCESS | 23777 | RSS: Main: 186380288 02:57:59 INFO - PROCESS | 23777 | 02:58:03 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55769/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:03 INFO - PROCESS | 23777 | RSS: Main: 183504896 02:58:03 INFO - PROCESS | 23777 | 02:58:06 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55769/tests/kraken/driver.html?testName=json-parse-financial) 02:58:07 INFO - PROCESS | 23777 | RSS: Main: 185319424 02:58:07 INFO - PROCESS | 23777 | 02:58:08 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:09 INFO - PROCESS | 23777 | RSS: Main: 185856000 02:58:09 INFO - PROCESS | 23777 | 02:58:11 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:12 INFO - PROCESS | 23777 | RSS: Main: 185765888 02:58:12 INFO - PROCESS | 23777 | 02:58:14 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:14 INFO - PROCESS | 23777 | RSS: Main: 186437632 02:58:14 INFO - PROCESS | 23777 | 02:58:17 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:18 INFO - PROCESS | 23777 | RSS: Main: 186195968 02:58:18 INFO - PROCESS | 23777 | 02:58:20 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:21 INFO - PROCESS | 23777 | RSS: Main: 186114048 02:58:21 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | Cycle 1(1): loaded http://localhost:55769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55769/tests/kraken/driver.html?testName=ai-astar) 02:58:23 INFO - PROCESS | 23777 | RSS: Main: 187183104 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | __start_tp_report 02:58:23 INFO - PROCESS | 23777 | _x_x_mozilla_page_load 02:58:23 INFO - PROCESS | 23777 | _x_x_mozilla_page_load_details 02:58:23 INFO - PROCESS | 23777 | |i|pagename|runs| 02:58:23 INFO - PROCESS | 23777 | |0;ai-astar;101;110;105;111;113;112;112;111;110;112 02:58:23 INFO - PROCESS | 23777 | |1;audio-beat-detection;165;126;155;178;128;151;151;129;186;129 02:58:23 INFO - PROCESS | 23777 | |2;audio-dft;162;165;162;165;166;167;167;163;163;162 02:58:23 INFO - PROCESS | 23777 | |3;audio-fft;75;79;77;170;75;74;76;74;178;76 02:58:23 INFO - PROCESS | 23777 | |4;audio-oscillator;86;87;144;86;86;85;150;86;87;151 02:58:23 INFO - PROCESS | 23777 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;118;118;119 02:58:23 INFO - PROCESS | 23777 | |6;imaging-darkroom;147;147;147;147;149;148;147;147;148;149 02:58:23 INFO - PROCESS | 23777 | |7;imaging-desaturate;97;96;96;96;96;98;95;96;96;95 02:58:23 INFO - PROCESS | 23777 | |8;json-parse-financial;56;55;55;55;58;56;54;54;60;55 02:58:23 INFO - PROCESS | 23777 | |9;json-stringify-tinderbox;62;64;63;62;63;63;62;63;63;63 02:58:23 INFO - PROCESS | 23777 | |10;stanford-crypto-aes;84;79;78;83;80;80;85;80;154;79 02:58:23 INFO - PROCESS | 23777 | |11;stanford-crypto-ccm;123;129;141;121;124;118;123;130;128;130 02:58:23 INFO - PROCESS | 23777 | |12;stanford-crypto-pbkdf2;160;157;162;158;160;158;158;156;155;157 02:58:23 INFO - PROCESS | 23777 | |13;stanford-crypto-sha256-iterative;66;64;65;62;61;62;62;62;62;60 02:58:23 INFO - PROCESS | 23777 | __end_tp_report 02:58:23 INFO - PROCESS | 23777 | __start_cc_report 02:58:23 INFO - PROCESS | 23777 | _x_x_mozilla_cycle_collect,858 02:58:23 INFO - PROCESS | 23777 | __end_cc_report 02:58:23 INFO - PROCESS | 23777 | __startTimestamp1466675903288__endTimestamp 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | ------- Summary: start ------- 02:58:23 INFO - PROCESS | 23777 | Number of tests: 14 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:2.35 02:58:23 INFO - PROCESS | 23777 | Values: 101.0 110.0 105.0 111.0 113.0 112.0 112.0 111.0 110.0 112.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.00 stddev:21.79 (14.2%) stddev-sans-first:22.41 02:58:23 INFO - PROCESS | 23777 | Values: 165.0 126.0 155.0 178.0 128.0 151.0 151.0 129.0 186.0 129.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:2.04 (1.2%) stddev-sans-first:2.01 02:58:23 INFO - PROCESS | 23777 | Values: 162.0 165.0 162.0 165.0 166.0 167.0 167.0 163.0 163.0 162.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.49 (55.0%) stddev-sans-first:43.35 02:58:23 INFO - PROCESS | 23777 | Values: 75.0 79.0 77.0 170.0 75.0 74.0 76.0 74.0 178.0 76.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:86.00 stddev:30.10 (35.0%) stddev-sans-first:31.15 02:58:23 INFO - PROCESS | 23777 | Values: 86.0 87.0 144.0 86.0 86.0 85.0 150.0 86.0 87.0 151.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:58:23 INFO - PROCESS | 23777 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 119.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 02:58:23 INFO - PROCESS | 23777 | Values: 147.0 147.0 147.0 147.0 149.0 148.0 147.0 147.0 148.0 149.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 02:58:23 INFO - PROCESS | 23777 | Values: 97.0 96.0 96.0 96.0 96.0 98.0 95.0 96.0 96.0 95.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.87 (3.4%) stddev-sans-first:1.99 02:58:23 INFO - PROCESS | 23777 | Values: 56.0 55.0 55.0 55.0 58.0 56.0 54.0 54.0 60.0 55.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:58:23 INFO - PROCESS | 23777 | Values: 62.0 64.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 63.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:80.00 stddev:23.24 (29.0%) stddev-sans-first:24.60 02:58:23 INFO - PROCESS | 23777 | Values: 84.0 79.0 78.0 83.0 80.0 80.0 85.0 80.0 154.0 79.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:128.50 stddev:6.46 (5.0%) stddev-sans-first:6.72 02:58:23 INFO - PROCESS | 23777 | Values: 123.0 129.0 141.0 121.0 124.0 118.0 123.0 130.0 128.0 130.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:2.08 (1.3%) stddev-sans-first:2.09 02:58:23 INFO - PROCESS | 23777 | Values: 160.0 157.0 162.0 158.0 160.0 158.0 158.0 156.0 155.0 157.0 02:58:23 INFO - PROCESS | 23777 | 02:58:23 INFO - PROCESS | 23777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:1.84 (3.0%) stddev-sans-first:1.48 02:58:23 INFO - PROCESS | 23777 | Values: 66.0 64.0 65.0 62.0 61.0 62.0 62.0 62.0 62.0 60.0 02:58:23 INFO - PROCESS | 23777 | -------- Summary: end -------- 02:58:23 INFO - PROCESS | 23777 | 02:58:24 INFO - TEST-INFO | 23777: exit 0 02:58:24 INFO - TEST-OK | kraken | took 61414ms 02:58:24 INFO - SUITE-END | took 1171s 02:58:24 INFO - Completed test suite (00:19:31) 02:58:24 INFO - javascript benchmark 02:58:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6828.61566816903, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.953995690065, 3092.366064956684, 3117.3453574749296, 3141.6230052393717, 3148.433282009239, 5244.632875698698, 5330.520253177213, 5371.5165635092835, 5429.239906413105, 5439.646422982503, 5281.815136470224, 5413.998410294089, 5419.647722898009, 5474.91787623186, 5491.066518691822, 4865.756712164386, 4964.255361695738, 5009.549140577347, 5053.140966035764, 5095.6178286628465, 4905.2642103684375, 5077.187649976005, 5113.386393632751, 5120.590352771788, 5126.0, 4882.780274887638, 4935.062338155739, 4970.6520543561965, 4993.800247990094, 5038.420581633122, 4986.800527978877, 4990.076835785391, 4992.450830408652, 4997.50024997501, 5055.963527476858, 4934.580560652349, 4970.6520543561965, 4975.651704380694, 4986.52628000343, 5023.070731914571, 5235.816746413857, 5285.233641122054, 5301.0, 5353.38436079848, 5361.892762144775, 5710.685912274823, 5726.914096288559, 5729.369769325371, 5741.0, 5742.626729262584, 5677.630953987978, 5788.479036886701, 5798.420157984167, 5801.390853960358, 5804.65172089676, 5358.490943360374, 5392.865178370533, 5419.0, 5436.945630543683, 5448.0, 5865.0, 5901.232839730807, 5902.0, 5921.171036054956, 5922.7927022554, 5519.227308176858, 5615.719214039282, 5657.632253903483, 5659.122835960433, 5667.1499275108235, 5726.055200891807, 5756.3380211276235, 5756.366799652035, 5758.798442054592, 5798.072308430631, 5527.309086364205, 5571.415001424792, 5677.148427735872, 5699.860027994418, 5715.599908006399, 5504.779808807602, 5702.429757024347, 5730.541556675456, 5739.684317362502, 5740.253767010262, 4365.519792822787, 4423.071155057474, 4425.402570652985, 4453.265211240174, 4494.033782736662, 3930.665893399036, 3956.4658771066115, 3960.4257382679352, 3967.5238971323624, 4025.8590949316635, 5304.443033481429, 5305.965336759372, 5446.2647542582035, 5538.0, 5597.944020559742, 5695.629784064023, 5730.169125476783, 5756.136579513107, 5781.248437703071, 5813.709314534256, 5388.7305634718105, 5460.672359658433, 5489.972550137224, 5490.0941344677685, 5491.780328786884, 4825.252085926687, 4873.049755297683, 4915.65590408668, 4929.112759703288, 4996.325496057985, 5899.0, 5929.377415371324, 5934.673592952429, 5962.195103661037, 5968.880622387528, 5766.0197766379815, 5781.248437703071, 5793.1020691791155, 5794.0439827428, 5803.622764520293, 5814.854628634318, 5956.583039187389, 6006.579539432198, 6016.608920420159, 6062.090686397076, 5752.769889204553, 5756.222909907109, 5759.280089988752, 5765.365809761007, 5771.249737534094, 5627.212190293444, 5807.157962095557, 5871.823845284648, 5881.588288819913, 5886.175935369138, 5447.455254474521, 5623.381428042994, 5671.262735844479, 5679.659220446786, 5700.030994730989, 5611.831645050655, 5619.662820230799, 5658.801941932013, 5669.036263835241, 5710.885782284248, 5572.4706152915405, 5573.693446860299, 5579.944200557942, 5582.692951887685, 5588.944110558842, 5481.479259470503, 5644.181593668977, 5676.290463692038, 5732.254806875079, 5759.596828221985, 5561.694106824163, 5621.269234999424, 5631.746571404378, 5645.209670646031, 5648.096304591246], "value": 5327.546568151996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.4584280326679, 599.6012651586695, 608.3308360803117, 613.435639211925, 618.0173524096685, 31847.52228716571, 34993.475097873554, 35109.82445087774, 35143.0, 35217.29565408696, 35449.0, 35860.641393586055, 35926.46110308347, 35938.460923086175, 35980.460293095624, 8409.78975525612, 8433.072362040171, 8466.365022623297, 8470.534120623362, 8474.618642161087, 8446.57767111645, 8554.0, 8562.443441176334, 8582.141785821399, 8584.656613735444, 8500.489970601753, 8528.488290702546, 8565.143485651448, 8583.098774628668, 8591.05498395176, 8519.148085191462, 8542.060373358925, 8569.528675922822, 8586.656533738644, 8589.0, 8439.493630382136, 8446.028706698748, 8462.15378462155, 8477.915220847774, 8518.020427650838, 32841.83579082113, 33172.336553269044, 33360.33279334424, 33434.49848252278, 33477.83261083703, 2582.2253324002722, 2778.3887544740123, 2861.9427611447863, 2933.1640482462394, 3137.654857965622, 26634.200973970812, 27144.0, 27340.45319093607, 27346.0, 27550.724492755016, 3880.8835734927998, 3936.5276166859876, 3976.264391087629, 4030.9395359069636, 4083.8570650027104, 266693.0, 267305.0, 267494.0, 267712.6614366935, 267952.0, 27310.5903411449, 28587.57118643222, 29242.707572924424, 29320.413591728047, 29582.260443489085, 30840.228994274872, 30960.380792384476, 31022.22444438862, 31024.22439439032, 31033.379332413224, 13346.866531334757, 13381.598552043455, 13513.52702655422, 13539.59381218565, 13572.524961626295, 11316.0, 11392.715182120348, 11452.656420307405, 11491.253068550517, 11714.23857449263, 7255.56466612005, 7270.054892864, 7275.4179665626625, 7317.743878964211, 7368.1526624438875, 2893.942121157565, 2958.497055500527, 2983.7165469280385, 2985.5372417275357, 2997.520396736512, 855.9957200213959, 936.8454205056225, 941.7268991992246, 1079.63292480557, 1092.0608276881876, 27921.860390697915, 28212.576811347848, 28325.264380768072, 28599.28501787472, 28623.71376286252, 1002.9899701003043, 1011.544804837826, 1051.3954476176077, 1087.977301336741, 1099.8020356335937, 14469.638259043608, 14685.632859178393, 14936.25318734059, 15035.699286014218, 15054.774178387333, 503368.0, 507934.0, 509748.0, 510854.0, 511136.0, 47035.76482117636, 47261.0, 47265.76367118143, 47363.0, 47462.0, 1192.5366512439748, 1196.6350263169816, 1214.9453274602663, 1219.2989031307034, 1220.9926810381294, 26409.33976650522, 27709.58435623427, 28027.0, 28080.0, 28220.576691349237, 41421.1715765677, 41423.37864932089, 41611.7919410401, 41869.0, 41873.581264188186, 438726.0, 439679.0, 440873.0, 441753.0, 442966.0, 24769.1330803421, 24837.0, 25109.497810044064, 25212.24363269105, 25519.0, 39923.80038099791, 40344.0, 40582.0, 40584.59415405808, 40973.0, 35186.64813351936, 35929.28141437209, 36419.089522762144, 36494.27011459809, 36856.631433686394, 34447.4832877512, 34931.12672183114, 34948.65051349556, 35208.64791352156, 35246.823765881, 35305.646943530235, 35662.28675426425, 35695.0, 36332.27335453223, 36459.45310820287, 31301.8434907824, 31910.62904556075, 31932.5210121853, 32193.51709724403, 32588.51117233196, 25140.0, 25378.61932071057, 25439.0, 25639.230823075337, 25907.22278331653], "value": 16488.441583019096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.38333840771037, 350.70190338212524, 359.53081228996166, 364.4515004917599, 369.77443759306817, 16676.91661541692, 18081.367152149676, 18352.357667481625, 18535.814641853576, 18746.156422960965, 14480.565583032527, 15847.445339413123, 16687.582810429747, 16694.332226710947, 16703.49889503314, 5387.946120538793, 5587.636803607773, 5635.8591035224035, 5637.577181711388, 5642.351129620085, 4040.2323558523785, 5497.972510137443, 5913.615614985034, 6266.5300102492265, 6268.404501572343, 6229.408206220424, 6254.530910181755, 6271.310155882849, 6288.245410550718, 6309.9369006310035, 6130.141780150782, 6230.8442288942915, 6254.843628909268, 6298.401651843067, 6305.4009869062365, 5397.676139431646, 5424.321959755031, 5464.726763661801, 5491.148871924858, 5505.834824955257, 21187.258445954318, 21711.891440542855, 21743.13027478899, 21885.452863678536, 21914.89042554793, 2054.6301665700166, 2339.7309309429465, 2347.1784875293683, 2347.718273807137, 2349.048635302688, 9339.813203735956, 9373.1564159226, 9524.952375238148, 9635.421874687541, 10818.296810707358, 1689.628281778019, 1845.418693111679, 1907.761529808774, 1964.1063316191098, 1972.9506762330914, 80633.19366806374, 81747.5912620439, 82917.58541207315, 83258.99999999939, 83625.16374836235, 9855.507224638739, 9918.454485003394, 9990.600375985025, 10062.943390943992, 10089.495525223709, 13386.933065334611, 13485.325733713471, 13524.459021639024, 13567.118137321042, 13580.253086080163, 7185.748498802622, 7223.349898509159, 7362.300581444754, 7447.962760186165, 7508.62456877154, 7082.079329687211, 7128.261085209862, 7235.89146162808, 7261.89107163393, 7308.1230252369, 4078.7144899857317, 4150.294449943517, 4229.175310814362, 4309.892252693645, 4320.762358070274, 1492.156931333793, 1554.759012353087, 1590.157216675164, 1596.4093285484446, 1600.5038438084232, 872.5768002518773, 880.3881302494705, 898.7303808857316, 916.5279880861361, 925.5557332480313, 17481.0, 17848.46454606364, 18031.278748849898, 18149.183286752126, 18226.27094916215, 899.5592159841631, 904.5386852705036, 907.7186072317603, 909.663424532927, 913.7715571107224, 7503.662335194929, 10106.444145571917, 10151.593936242616, 10181.236407269484, 10254.230932680079, 419493.0, 422313.0, 422339.0, 423676.0, 475915.0, 83717.58141209255, 89420.0, 91343.0, 91655.5417222923, 93848.53075734578, 412.67604930129704, 425.46604011964786, 427.1393142817226, 430.85350980666726, 433.02137169995405, 9142.588583513625, 9855.753606159617, 9897.0, 10889.673309800719, 10895.128389728961, 41023.38464923088, 41274.1745165101, 41377.37933930933, 42584.57415425806, 48524.0, 42068.78965605152, 53660.73169634127, 61170.16489505322, 62052.0, 62507.37492625016, 8166.836663266583, 8227.177282271725, 8294.37792165578, 8403.94950631171, 8575.785605359915, 12012.459439325427, 13294.268815215257, 14129.929350353183, 14142.717145657234, 14397.496087636882, 11534.077273818242, 12069.939650302043, 12150.513979441077, 12159.452824622736, 12419.565315213924, 11682.299062056303, 12014.879851201726, 12028.15802893789, 12201.450934708137, 12248.571300004458, 11994.820077699016, 12236.082293828176, 12304.26174429537, 12322.075844311534, 12425.689357766129, 8273.83452330938, 8285.295749861329, 8372.706955256781, 8461.61922713467, 8562.52906090171, 11621.418929053345, 11698.181127321346, 12071.275723456269, 12179.330136842558, 12258.632241032783], "value": 8499.163119414661, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.947042118315, 1329.6609364612025, 1364.9658758531036, 1517.1124891938216, 1554.4481708993308, 7694.499857509272, 7812.765617031491, 8321.66713331466, 8384.496930184194, 8534.317254619631, 8620.310375169987, 8689.782755431117, 8702.0, 8713.912860871389, 8737.21365077143, 2303.9424014399606, 2339.1695947938492, 2346.4603141277516, 2348.154664320843, 2350.6944097267415, 2295.540891821634, 2306.4003359126664, 2342.5197834443984, 2350.4476448034698, 2369.1471070414636, 2273.783990520898, 2303.2284184798114, 2319.211468100845, 2331.8600883946933, 2373.299876536426, 2191.0906973605934, 2200.3179014505395, 2203.5152266501423, 2214.446388402899, 2223.321886824518, 2165.9241926532495, 2177.0965049504593, 2181.465540942479, 2182.1380554680973, 2200.922967696123, 8559.871601925975, 8608.913910860874, 8658.78353041179, 8691.782705432352, 8717.69488067921, 4968.453470118284, 5122.052420302219, 5128.307678463434, 5128.435872054071, 5160.56135228506, 3127.3588914272746, 3207.6471588125287, 3316.403047451458, 3378.611459682119, 3384.8307584620916, 1105.9059979901638, 1113.7549739057395, 1118.8937050980144, 1131.0555686002199, 1137.562038615139, 11360.886391136148, 11504.137189710722, 11558.133140014448, 11573.016293615054, 11613.070954323633, 4448.799804008828, 4474.888127796766, 4475.172093162775, 4560.703554268962, 4575.473820510684, 9491.38306010107, 9528.714138575853, 9547.809043819223, 9559.617615295449, 9572.186364158984, 5057.721825299644, 5076.537879128619, 5104.2343648453025, 5116.590672746172, 5143.5113664201845, 4177.770222637723, 4506.752128632957, 4585.495595484494, 4665.6967297125575, 4692.882677933079, 3610.1696609779374, 3612.5664920209742, 3729.6829769469355, 3782.167923056978, 3795.4686343911876, 1213.9696507587205, 1216.7748966441236, 1233.3278363292027, 1240.64021433785, 1244.6390546741525, 842.6839935024366, 859.8022454835298, 865.8051938313829, 880.6521424037597, 888.05865782271, 5742.196092547047, 5746.339170995306, 5778.988676981511, 5814.127880817911, 5850.736716847752, 412.5750477008686, 414.0621492319898, 418.4852631263563, 420.17226064652584, 420.88425682937435, 3905.1994341159993, 3962.841486340514, 3967.563568007517, 3985.1830374773103, 3993.6006399360413, 10414.114800241912, 10570.10154136907, 10632.78734425307, 10783.083437907866, 10809.243352965374, 10577.31247468912, 10637.893621063691, 10746.355218686904, 10783.191260655482, 10858.457077146111, 8068.031836179696, 8095.109537950821, 8275.751727448187, 8283.544405057659, 8287.709930152416, 5595.972020139873, 5679.488846003879, 5762.337331206965, 5829.417058294137, 5857.092150716646, 10014.449205293779, 10022.799544009225, 10027.498625068863, 10080.092791648787, 10176.643817466353, 9808.9019109808, 10124.544395502073, 10292.536835842555, 10301.433421161908, 10309.48452577383, 6792.898106528505, 7006.773814582326, 7281.235470275757, 7287.1984081752025, 7341.155767086853, 8357.582120894052, 8369.539675317916, 8430.114837942174, 8451.830963380575, 8452.32381409498, 6874.931250687429, 6997.195322537973, 7091.751788687371, 7182.784516464514, 7189.820254493679, 7154.570725756263, 7212.4230061596, 7233.0, 7267.164276108315, 7282.089738782653, 6574.276829548841, 6680.03139544773, 6682.0, 6688.063671086149, 6703.631300278336, 4786.712797232177, 4870.586000189882, 4878.097551952758, 4913.63147763912, 4934.407871055496, 4992.400911890596, 5006.123928312603, 5022.121128802518, 5054.368203974504, 5089.440161582297], "value": 4375.318553922898, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.38922155688624, 306.03598664207743, 306.13669452144944, 321.0897106702498, 321.12333330009074, 5581.0512212923795, 5588.776448942038, 5643.435656434354, 5656.331382242238, 5660.5471562275025, 5588.329400471939, 5589.217509548656, 5590.524805391537, 5591.720413979295, 5623.915641265385, 4129.876103716886, 4235.830566777326, 4346.543612920629, 4356.3465480178065, 4377.934330985022, 4320.913581728363, 4351.108022855323, 4357.169988604778, 4360.80376383062, 4366.97816510917, 4192.0777428965575, 4278.780547543935, 4305.203537345586, 4316.287812510932, 4322.762248076355, 4204.432401625772, 4240.639545638609, 4302.806373713191, 4306.2894622387585, 4315.25981002066, 3772.4907137536356, 3773.9622603773887, 3782.5082739244, 3789.4315852622326, 3798.126430920876, 5388.568914486832, 5435.945640543623, 5447.536959358459, 5496.31296087989, 5502.202180683818, 4892.902141957176, 4897.579701886449, 4917.262410638397, 4921.286413470027, 4968.87577810554, 5778.451047150514, 5781.508571771405, 5793.971030144822, 5816.836632673482, 5859.326177489558, 4103.835846566134, 4117.649999750025, 4159.7920103994675, 4161.52142503613, 4166.708330416872, 5883.676397798119, 6098.908516372214, 6110.342001229435, 6138.0792881067755, 6139.754409823557, 4266.807993640294, 4268.295731204378, 4288.849890253826, 4323.724501272132, 4326.221280169537, 4340.589308474759, 4363.2800587903275, 4367.694261401735, 4371.213181627274, 4404.1411924674385, 4819.192802698988, 4821.493743156988, 4828.913494463788, 4848.418189817174, 5011.473795251446, 5790.739416726257, 5808.186853840466, 5853.824385268449, 5918.644881307136, 5924.526037916957, 1502.0, 1504.2704288420107, 1513.3038802151134, 1516.1200111861212, 1524.9466268680765, 926.5645146781002, 928.3687092776977, 952.1240458777941, 956.990430095704, 957.4638202606562, 5031.823886163967, 5120.308758317654, 5141.71720555373, 5147.922781158286, 5174.379074511083, 5268.631195816256, 5311.547494128848, 5370.838874833683, 5380.578739567132, 5413.593980451403, 5043.5460808527405, 5073.365829271341, 5269.473052694777, 5773.336066352424, 5784.623999440023, 3223.5325877747596, 3226.38698647261, 3236.7086962173516, 3246.318273162662, 3250.2037000934924, 6242.0, 6364.363563643598, 6368.5860419072615, 6386.84032899172, 6411.653552753974, 6175.2589689237575, 6175.783847565313, 6189.45263684079, 6240.906386404207, 6248.5313601479165, 6301.369863013662, 6346.238451385863, 6349.174607301114, 6366.522510811707, 6373.426391624684, 5942.0, 6155.491904483251, 6165.876682466415, 6187.0, 6200.875982480235, 6090.984962443619, 6094.2077529920825, 6111.524832442868, 6114.694265286629, 6142.78500252489, 6136.509079273558, 6206.658633775186, 6304.89664308735, 6312.84217894538, 6420.903686444801, 4210.59999300066, 4213.283741763847, 4224.1340525191645, 4244.8514301999285, 4268.509121450948, 5846.795362162304, 5911.349751527243, 6161.784337548164, 6180.013891040344, 6198.256209254918, 5879.353271140257, 5899.587028908107, 5909.6158749681135, 5913.763449461973, 5924.229850119457, 5808.680522571299, 5894.440028197314, 5903.321118071477, 5903.557233207441, 5906.2026626406605, 5549.862278232872, 5725.51333136688, 5751.683657398883, 5767.221425107725, 5780.826575202751, 5878.911816322673, 5912.970435147797, 5925.614835035709, 5952.672603006876, 5969.70151492415, 5658.830235092953, 5713.9142912855505, 5773.509251713652, 5815.273090863642, 5829.3386384880105], "value": 4430.035318014744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4517851701246, 629.1569297141834, 639.8592309691868, 648.743746220243, 679.721314261153, 12825.48698052078, 12886.80669789954, 13265.933670331648, 13281.800772988412, 13385.99605029623, 11527.596534121307, 11655.825162622568, 11679.416029198548, 11684.24052436591, 11689.357085360301, 662.4667142949924, 767.15995984397, 769.465221670939, 784.7175016993906, 790.9406794490408, 752.431913905001, 753.909530856298, 758.0524344569288, 759.1421693486353, 763.0195199169069, 810.4084018666377, 811.7970507373157, 812.4962523235603, 812.5815205169342, 818.7461886815106, 801.6552882260596, 808.5229714468462, 808.6724876425028, 810.833779075294, 814.0841553252591, 587.0694948506622, 587.8736071744595, 588.2323567744135, 588.5115354255958, 591.8816236752667, 12652.557160499338, 12770.106092573524, 12839.871601283961, 12911.935440322739, 12957.028222883322, 13524.797128043087, 13904.374303156383, 13940.442382304796, 13976.301184940814, 14199.0, 11640.185187036826, 11656.30062196271, 11732.35472049037, 11758.143241358684, 11824.586139485164, 3740.2706472237924, 3768.9057773555605, 3770.755650635284, 3774.1130834253927, 3916.74541154824, 72247.27752722458, 72457.0, 75428.62285688591, 75557.62221188915, 75873.0, 10713.277989812355, 10831.458427078614, 11031.172662050218, 11198.720031999103, 11222.0, 20575.279865204648, 20585.69121463179, 20663.8966805165, 20697.0, 20747.170113195603, 8094.0, 8104.675812967415, 8157.629031300104, 8214.671413143527, 8359.498430094214, 4712.64655150865, 4783.449903261169, 4812.0, 4840.782164802592, 4965.652404331662, 3443.896683099511, 3527.8588856445967, 3536.8585256589963, 3551.662592053751, 3561.3589553880033, 568.3009897825698, 607.8055022392792, 616.950643948483, 620.6679426506797, 632.4624069540854, 565.7906574567354, 587.2453896742666, 596.9344719675358, 630.1335663462738, 649.9837504062436, 8199.754007379788, 8456.746297611082, 8562.700305489403, 8586.656533738706, 8847.336449766293, 541.2071315522778, 624.8437890527368, 648.3386945315846, 649.6394501051961, 663.9834004149935, 4121.0, 4336.132773445261, 4371.278739008028, 4557.840475583339, 4571.657125715585, 68266.65866670635, 99794.0, 111488.44255778831, 118214.4089279548, 118493.0, 96783.51608241914, 100051.0, 100261.0, 100608.0, 101629.0, 53623.19565206525, 85916.57041714876, 86439.0, 87268.56365718131, 87980.56009719911, 8295.58522073906, 8484.533350665773, 8592.441491303045, 8624.284900567076, 8728.956355218183, 45114.548854511035, 45705.31442028306, 50713.74643126761, 51266.0, 52226.477735222164, 48556.27165592448, 49286.0, 59386.10920836104, 75338.62330688312, 76918.2308176911, 12590.307533085768, 12593.748125037264, 13000.67498312512, 13011.414486348327, 13354.732905342033, 13733.587992360246, 13894.096883702527, 13976.881849451816, 14522.49171279, 14838.480653177086, 12497.18768280059, 12505.93747031259, 12632.305223212812, 12717.236965782082, 12898.548550800677, 13142.40859161321, 13246.536371226961, 13484.0, 13658.795118073038, 14118.78821817653, 11128.332300062022, 12090.697732556404, 12245.0, 12303.507859685513, 12452.626421207378, 9376.484293363657, 9545.90454095478, 9582.329236953346, 9706.5146742664, 9715.611375544899, 9480.85778713306, 9521.952390238004, 9791.314607977372, 10380.169586433218, 10380.740481488023], "value": 7005.828308658532, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 105.0, 111.0, 113.0, 112.0, 112.0, 111.0, 110.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 126.0, 155.0, 178.0, 128.0, 151.0, 151.0, 129.0, 186.0, 129.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 165.0, 166.0, 167.0, 167.0, 163.0, 163.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 77.0, 170.0, 75.0, 74.0, 76.0, 74.0, 178.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 144.0, 86.0, 86.0, 85.0, 150.0, 86.0, 87.0, 151.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 98.0, 95.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 58.0, 56.0, 54.0, 54.0, 60.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 78.0, 83.0, 80.0, 80.0, 85.0, 80.0, 154.0, 79.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 141.0, 121.0, 124.0, 118.0, 123.0, 130.0, 128.0, 130.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 162.0, 158.0, 160.0, 158.0, 158.0, 156.0, 155.0, 157.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 60.0], "value": 62.6, "unit": "score"}]}]} 02:58:24 INFO - Return code: 0 02:58:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:58:24 ERROR - # TBPL SUCCESS # 02:58:24 INFO - Running post-action listener: _resource_record_post_action 02:58:24 INFO - ##### 02:58:24 INFO - ##### Finished run-tests step (success) 02:58:24 INFO - ##### 02:58:24 INFO - Running post-run listener: _resource_record_post_run 02:58:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 316497920; Read time: 0; Write time: 227688 02:58:24 INFO - TinderboxPrint: CPU usage
13.5% 02:58:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:58:24 INFO - TinderboxPrint: I/O write bytes / time
316,497,920 / 227,688 02:58:24 INFO - TinderboxPrint: CPU idle
8,213.2 (86.5%) 02:58:24 INFO - TinderboxPrint: CPU user
1,225.8 (12.9%) 02:58:24 INFO - TinderboxPrint: Swap in / out
0 / 0 02:58:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20385792; Read time: 0; Write time: 7804 02:58:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 291500032; Read time: 0; Write time: 219620 02:58:25 INFO - Running post-run listener: _upload_blobber_files 02:58:25 INFO - Blob upload gear active. 02:58:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:58:25 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:58:25 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:58:25 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 02:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:26 INFO - (blobuploader) - INFO - Done attempting. 02:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:30 INFO - (blobuploader) - INFO - Done attempting. 02:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:31 INFO - (blobuploader) - INFO - Done attempting. 02:58:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:58:31 INFO - Return code: 0 02:58:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:58:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:58:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef0733d217b6fa177acaa04a3888f94bbb6b98000771afc07c90e02f62b7fd68f6c96bac369b1fe94d473813b8f1f18944c652740661ca58dd83c746ccf2bc47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6b4e2e4c7b480aa460c55316d9cfa114c6594c8190832d25deeb232615c93a8e5d7535b751a8b9b1e54c0c7e81a98fa02c5ba5ad10e7642d66c4cc7c7c80c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee861a02ad1d7dc123559ec21f3191c78690af4c431fa4a849660d538c5c384ff492d00bf888b49615b5c1dc3f94f6f998484e02692912a1c4e3bd2301a2affc"} 02:58:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:58:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:58:31 INFO - Contents: 02:58:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef0733d217b6fa177acaa04a3888f94bbb6b98000771afc07c90e02f62b7fd68f6c96bac369b1fe94d473813b8f1f18944c652740661ca58dd83c746ccf2bc47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6b4e2e4c7b480aa460c55316d9cfa114c6594c8190832d25deeb232615c93a8e5d7535b751a8b9b1e54c0c7e81a98fa02c5ba5ad10e7642d66c4cc7c7c80c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee861a02ad1d7dc123559ec21f3191c78690af4c431fa4a849660d538c5c384ff492d00bf888b49615b5c1dc3f94f6f998484e02692912a1c4e3bd2301a2affc"} 02:58:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:58:31 INFO - Copying logs to upload dir... 02:58:31 INFO - mkdir: /builds/slave/test/build/upload/logs 02:58:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.482791 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-23 02:58:29.826960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:58:29.830542) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef0733d217b6fa177acaa04a3888f94bbb6b98000771afc07c90e02f62b7fd68f6c96bac369b1fe94d473813b8f1f18944c652740661ca58dd83c746ccf2bc47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6b4e2e4c7b480aa460c55316d9cfa114c6594c8190832d25deeb232615c93a8e5d7535b751a8b9b1e54c0c7e81a98fa02c5ba5ad10e7642d66c4cc7c7c80c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee861a02ad1d7dc123559ec21f3191c78690af4c431fa4a849660d538c5c384ff492d00bf888b49615b5c1dc3f94f6f998484e02692912a1c4e3bd2301a2affc"} build_url:https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/VYKd82rPRPKERYtBRcIjrw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef0733d217b6fa177acaa04a3888f94bbb6b98000771afc07c90e02f62b7fd68f6c96bac369b1fe94d473813b8f1f18944c652740661ca58dd83c746ccf2bc47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3c6b4e2e4c7b480aa460c55316d9cfa114c6594c8190832d25deeb232615c93a8e5d7535b751a8b9b1e54c0c7e81a98fa02c5ba5ad10e7642d66c4cc7c7c80c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee861a02ad1d7dc123559ec21f3191c78690af4c431fa4a849660d538c5c384ff492d00bf888b49615b5c1dc3f94f6f998484e02692912a1c4e3bd2301a2affc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:58:29.859000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:58:29.859541) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466674661.385935-387511123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:58:29.946353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:58:29.947170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:58:29.947826) ========= ========= Total master_lag: 0.19 =========