builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1465025537.89 results: success (0) buildid: 20160603220435 builduid: 9cc4c6fde58649408cfd805b0acbb263 revision: e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:17.894125) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:17.894627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:17.894935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:17.989676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:17.990003) ========= 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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 00:32:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-06-04 00:32:18 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087229 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.105572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.105900) ========= 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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.155216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.155612) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f --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 e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f --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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 00:32:18,951 truncating revision to first 12 chars 2016-06-04 00:32:18,952 Setting DEBUG logging. 2016-06-04 00:32:18,952 attempt 1/10 2016-06-04 00:32:18,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e1db300f075e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 00:32:19,406 unpacking tar archive at: mozilla-inbound-e1db300f075e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.960317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.960658) ========= script_repo_revision: e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.961081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.961352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 00:32:18.991861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-04 00:32:18.992162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:32:19 INFO - MultiFileLogger online at 20160604 00:32:19 in /builds/slave/test 00:32:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:32:19 INFO - {'append_to_log': False, 00:32:19 INFO - 'base_work_dir': '/builds/slave/test', 00:32:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:32:19 INFO - 'branch': 'Mozilla-Inbound', 00:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 00:32:19 INFO - 'config_files': ('talos/linux_config.py',), 00:32:19 INFO - 'default_actions': ('clobber', 00:32:19 INFO - 'read-buildbot-config', 00:32:19 INFO - 'download-and-extract', 00:32:19 INFO - 'populate-webroot', 00:32:19 INFO - 'create-virtualenv', 00:32:19 INFO - 'install', 00:32:19 INFO - 'run-tests'), 00:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:32:19 INFO - 'download_minidump_stackwalk': True, 00:32:19 INFO - 'download_symbols': 'ondemand', 00:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 00:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 00:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:32:19 INFO - 'installer_path': 'installer.exe', 00:32:19 INFO - 'log_level': 'info', 00:32:19 INFO - 'log_name': 'talos', 00:32:19 INFO - 'log_to_console': True, 00:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:32:19 INFO - 'opt_config_files': (), 00:32:19 INFO - 'pip_index': False, 00:32:19 INFO - 'sps_profile': False, 00:32:19 INFO - 'sps_profile_interval': 0, 00:32:19 INFO - 'suite': 'dromaeojs', 00:32:19 INFO - 'system_bits': '32', 00:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:32:19 INFO - 'title': 'talos-linux64-ix-056', 00:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:32:19 INFO - 'use_talos_json': True, 00:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:32:19 INFO - 'work_dir': 'build'} 00:32:19 INFO - ##### 00:32:19 INFO - ##### Running clobber step. 00:32:19 INFO - ##### 00:32:19 INFO - Running pre-action listener: _resource_record_pre_action 00:32:19 INFO - Running main action method: clobber 00:32:19 INFO - rmtree: /builds/slave/test/build 00:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:32:20 INFO - Running post-action listener: _resource_record_post_action 00:32:20 INFO - ##### 00:32:20 INFO - ##### Finished clobber step (success) 00:32:20 INFO - ##### 00:32:20 INFO - ##### 00:32:20 INFO - ##### Running read-buildbot-config step. 00:32:20 INFO - ##### 00:32:20 INFO - Running pre-action listener: _resource_record_pre_action 00:32:20 INFO - Running main action method: read_buildbot_config 00:32:20 INFO - Using buildbot properties: 00:32:20 INFO - { 00:32:20 INFO - "project": "", 00:32:20 INFO - "product": "firefox", 00:32:20 INFO - "script_repo_revision": "production", 00:32:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:32:20 INFO - "repository": "", 00:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:32:20 INFO - "buildid": "20160603220435", 00:32:20 INFO - "pgo_build": "True", 00:32:20 INFO - "basedir": "/builds/slave/test", 00:32:20 INFO - "buildnumber": 1042, 00:32:20 INFO - "slavename": "talos-linux64-ix-056", 00:32:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:32:20 INFO - "platform": "ubuntu64_hw", 00:32:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:32:20 INFO - "branch": "mozilla-inbound", 00:32:20 INFO - "repo_path": "integration/mozilla-inbound", 00:32:20 INFO - "revision": "e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f", 00:32:20 INFO - "stage_platform": "linux64-pgo", 00:32:20 INFO - "builduid": "9cc4c6fde58649408cfd805b0acbb263", 00:32:20 INFO - "slavebuilddir": "test" 00:32:20 INFO - } 00:32:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:32:20 INFO - Running post-action listener: _resource_record_post_action 00:32:20 INFO - ##### 00:32:20 INFO - ##### Finished read-buildbot-config step (success) 00:32:20 INFO - ##### 00:32:20 INFO - ##### 00:32:20 INFO - ##### Running download-and-extract step. 00:32:20 INFO - ##### 00:32:20 INFO - Running pre-action listener: _resource_record_pre_action 00:32:20 INFO - Running main action method: download_and_extract 00:32:20 INFO - mkdir: /builds/slave/test/build/tests 00:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:20 INFO - https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:32:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:32:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:32:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:32:29 INFO - Downloaded 1361 bytes. 00:32:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:32:29 INFO - Using the following test package requirements: 00:32:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:32:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:32:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:32:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'jsshell-linux-x86_64.zip'], 00:32:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:32:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:32:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:32:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:32:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:32:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:32:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:32:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:29 INFO - https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:32:34 INFO - Downloaded 24441874 bytes. 00:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:32:35 INFO - Return code: 0 00:32:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:32:35 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')]} 00:32:35 INFO - https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:32:37 INFO - Downloaded 24441874 bytes. 00:32:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:32:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:32:38 INFO - Return code: 0 00:32:38 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')]} 00:32:38 INFO - https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:32:39 INFO - Downloaded 10833377 bytes. 00:32:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:32:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:32:40 INFO - Return code: 0 00:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:40 INFO - https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:32:41 INFO - Downloaded 59243772 bytes. 00:32:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:32:41 INFO - mkdir: /builds/slave/test/properties 00:32:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:32:41 INFO - Writing to file /builds/slave/test/properties/build_url 00:32:41 INFO - Contents: 00:32:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:32:42 INFO - Running post-action listener: _resource_record_post_action 00:32:42 INFO - Running post-action listener: set_extra_try_arguments 00:32:42 INFO - ##### 00:32:42 INFO - ##### Finished download-and-extract step (success) 00:32:42 INFO - ##### 00:32:42 INFO - ##### 00:32:42 INFO - ##### Running populate-webroot step. 00:32:42 INFO - ##### 00:32:42 INFO - Running pre-action listener: _resource_record_pre_action 00:32:42 INFO - Running main action method: populate_webroot 00:32:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:32:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:32:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:32:42 INFO - '--tppagecycles', 00:32:42 INFO - '7'], 00:32:42 INFO - 'tests': ['tsvgm']}}, 00:32:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:32:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:32:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:32:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:32:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:32:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:32:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['damp', 'tps']}, 00:32:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'tests': ['damp', 'tps']}, 00:32:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['dromaeo_dom']}, 00:32:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:32:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'other-e10s': {'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['a11yr', 00:32:42 INFO - 'ts_paint', 00:32:42 INFO - 'tpaint', 00:32:42 INFO - 'sessionrestore', 00:32:42 INFO - 'sessionrestore_no_auto_restore', 00:32:42 INFO - 'tabpaint']}, 00:32:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['tsvgx', 00:32:42 INFO - 'tsvgr_opacity', 00:32:42 INFO - 'tart', 00:32:42 INFO - 'tscrollx', 00:32:42 INFO - 'cart']}, 00:32:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:32:42 INFO - 'tsvgr_opacity', 00:32:42 INFO - 'tart', 00:32:42 INFO - 'tscrollx', 00:32:42 INFO - 'cart']}, 00:32:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'talos_options': ['--disable-e10s'], 00:32:42 INFO - 'tests': ['tp5o']}, 00:32:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'tests': ['tp5o']}, 00:32:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'talos_options': ['--disable-e10s', 00:32:42 INFO - '--xperf_path', 00:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:32:42 INFO - 'tests': ['tp5n']}, 00:32:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:42 INFO - 'talos_options': ['--xperf_path', 00:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:32:42 INFO - 'tests': ['tp5n']}}, 00:32:42 INFO - 'talos.zip': {'path': '', 00:32:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:32:42 INFO - Running post-action listener: _resource_record_post_action 00:32:42 INFO - ##### 00:32:42 INFO - ##### Finished populate-webroot step (success) 00:32:42 INFO - ##### 00:32:42 INFO - ##### 00:32:42 INFO - ##### Running create-virtualenv step. 00:32:42 INFO - ##### 00:32:42 INFO - Running pre-action listener: _resource_record_pre_action 00:32:42 INFO - Running main action method: create_virtualenv 00:32:42 INFO - Creating virtualenv /builds/slave/test/build/venv 00:32:42 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 00:32:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:32:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:32:42 INFO - Using real prefix '/usr' 00:32:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:32:43 INFO - Installing distribute.............................................................................................................................................................................................done. 00:32:44 INFO - Installing pip.................done. 00:32:45 INFO - Return code: 0 00:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:32:45 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')]} 00:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:45 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')]} 00:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:45 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:45 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 00:32:45 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 00:32:45 INFO - Using env: {'DISPLAY': ':0', 00:32:45 INFO - 'HOME': '/home/cltbld', 00:32:45 INFO - 'LANG': 'en_US.UTF-8', 00:32:45 INFO - 'LANGUAGE': 'en_US:en', 00:32:45 INFO - 'LOGNAME': 'cltbld', 00:32:45 INFO - 'MAIL': '/var/mail/cltbld', 00:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:45 INFO - 'MOZ_NO_REMOTE': '1', 00:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:45 INFO - 'NO_EM_RESTART': '1', 00:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:45 INFO - 'PWD': '/builds/slave/test', 00:32:45 INFO - 'SHELL': '/bin/bash', 00:32:45 INFO - 'SHLVL': '1', 00:32:45 INFO - 'TERM': 'linux', 00:32:45 INFO - 'TMOUT': '86400', 00:32:45 INFO - 'USER': 'cltbld', 00:32:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:45 INFO - '_': '/tools/buildbot/bin/python'} 00:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:45 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 00:32:45 INFO - Cleaning up... 00:32:45 INFO - Return code: 0 00:32:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:32:45 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')]} 00:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:45 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')]} 00:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:45 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:45 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 00:32:45 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 00:32:45 INFO - Using env: {'DISPLAY': ':0', 00:32:45 INFO - 'HOME': '/home/cltbld', 00:32:45 INFO - 'LANG': 'en_US.UTF-8', 00:32:45 INFO - 'LANGUAGE': 'en_US:en', 00:32:45 INFO - 'LOGNAME': 'cltbld', 00:32:45 INFO - 'MAIL': '/var/mail/cltbld', 00:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:45 INFO - 'MOZ_NO_REMOTE': '1', 00:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:45 INFO - 'NO_EM_RESTART': '1', 00:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:45 INFO - 'PWD': '/builds/slave/test', 00:32:45 INFO - 'SHELL': '/bin/bash', 00:32:45 INFO - 'SHLVL': '1', 00:32:45 INFO - 'TERM': 'linux', 00:32:45 INFO - 'TMOUT': '86400', 00:32:45 INFO - 'USER': 'cltbld', 00:32:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:45 INFO - '_': '/tools/buildbot/bin/python'} 00:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:45 INFO - Downloading/unpacking psutil>=3.1.1 00:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:32:47 INFO - Installing collected packages: psutil 00:32:47 INFO - Running setup.py install for psutil 00:32:47 INFO - building 'psutil._psutil_linux' extension 00:32:47 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 00:32:47 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 00:32:47 INFO - building 'psutil._psutil_posix' extension 00:32:47 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 00:32:47 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 00:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:32:47 INFO - Successfully installed psutil 00:32:47 INFO - Cleaning up... 00:32:48 INFO - Return code: 0 00:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:32:48 INFO - Using env: {'DISPLAY': ':0', 00:32:48 INFO - 'HOME': '/home/cltbld', 00:32:48 INFO - 'LANG': 'en_US.UTF-8', 00:32:48 INFO - 'LANGUAGE': 'en_US:en', 00:32:48 INFO - 'LOGNAME': 'cltbld', 00:32:48 INFO - 'MAIL': '/var/mail/cltbld', 00:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:48 INFO - 'MOZ_NO_REMOTE': '1', 00:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:48 INFO - 'NO_EM_RESTART': '1', 00:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:48 INFO - 'PWD': '/builds/slave/test', 00:32:48 INFO - 'SHELL': '/bin/bash', 00:32:48 INFO - 'SHLVL': '1', 00:32:48 INFO - 'TERM': 'linux', 00:32:48 INFO - 'TMOUT': '86400', 00:32:48 INFO - 'USER': 'cltbld', 00:32:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:48 INFO - '_': '/tools/buildbot/bin/python'} 00:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:32:50 INFO - Installing collected packages: mozsystemmonitor 00:32:50 INFO - Running setup.py install for mozsystemmonitor 00:32:50 INFO - Successfully installed mozsystemmonitor 00:32:50 INFO - Cleaning up... 00:32:50 INFO - Return code: 0 00:32:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:32:50 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')]} 00:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:50 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')]} 00:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:50 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:50 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 00:32:50 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 00:32:50 INFO - Using env: {'DISPLAY': ':0', 00:32:50 INFO - 'HOME': '/home/cltbld', 00:32:50 INFO - 'LANG': 'en_US.UTF-8', 00:32:50 INFO - 'LANGUAGE': 'en_US:en', 00:32:50 INFO - 'LOGNAME': 'cltbld', 00:32:50 INFO - 'MAIL': '/var/mail/cltbld', 00:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:50 INFO - 'MOZ_NO_REMOTE': '1', 00:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:50 INFO - 'NO_EM_RESTART': '1', 00:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:50 INFO - 'PWD': '/builds/slave/test', 00:32:50 INFO - 'SHELL': '/bin/bash', 00:32:50 INFO - 'SHLVL': '1', 00:32:50 INFO - 'TERM': 'linux', 00:32:50 INFO - 'TMOUT': '86400', 00:32:50 INFO - 'USER': 'cltbld', 00:32:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:50 INFO - '_': '/tools/buildbot/bin/python'} 00:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:50 INFO - Downloading/unpacking jsonschema==2.5.1 00:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:32:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:52 INFO - Downloading functools32-3.2.3-2.tar.gz 00:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:32:52 INFO - warning: no files found matching '*.txt' 00:32:52 INFO - no previously-included directories found matching 'build' 00:32:52 INFO - no previously-included directories found matching 'dist' 00:32:52 INFO - no previously-included directories found matching '.git*' 00:32:52 INFO - Installing collected packages: jsonschema, functools32 00:32:52 INFO - Running setup.py install for functools32 00:32:52 INFO - warning: no files found matching '*.txt' 00:32:52 INFO - no previously-included directories found matching 'build' 00:32:52 INFO - no previously-included directories found matching 'dist' 00:32:52 INFO - no previously-included directories found matching '.git*' 00:32:52 INFO - Successfully installed jsonschema functools32 00:32:52 INFO - Cleaning up... 00:32:52 INFO - Return code: 0 00:32:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:32:52 INFO - Using env: {'DISPLAY': ':0', 00:32:52 INFO - 'HOME': '/home/cltbld', 00:32:52 INFO - 'LANG': 'en_US.UTF-8', 00:32:52 INFO - 'LANGUAGE': 'en_US:en', 00:32:52 INFO - 'LOGNAME': 'cltbld', 00:32:52 INFO - 'MAIL': '/var/mail/cltbld', 00:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:52 INFO - 'MOZ_NO_REMOTE': '1', 00:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:52 INFO - 'NO_EM_RESTART': '1', 00:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:52 INFO - 'PWD': '/builds/slave/test', 00:32:52 INFO - 'SHELL': '/bin/bash', 00:32:52 INFO - 'SHLVL': '1', 00:32:52 INFO - 'TERM': 'linux', 00:32:52 INFO - 'TMOUT': '86400', 00:32:52 INFO - 'USER': 'cltbld', 00:32:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:52 INFO - '_': '/tools/buildbot/bin/python'} 00:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:53 INFO - Downloading/unpacking blobuploader==1.2.4 00:32:53 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 00:32:53 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 00:32:53 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 00:32:53 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 00:32:53 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 00:32:53 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 00:32:54 INFO - Downloading blobuploader-1.2.4.tar.gz 00:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:32:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:32:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:55 INFO - Downloading docopt-0.6.1.tar.gz 00:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:32:55 INFO - Installing collected packages: blobuploader, requests, docopt 00:32:55 INFO - Running setup.py install for blobuploader 00:32:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:32:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:32:55 INFO - Running setup.py install for requests 00:32:56 INFO - Running setup.py install for docopt 00:32:56 INFO - Successfully installed blobuploader requests docopt 00:32:56 INFO - Cleaning up... 00:32:56 INFO - Return code: 0 00:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:32:56 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')]} 00:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:56 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')]} 00:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:56 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:56 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 00:32:56 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 00:32:56 INFO - Using env: {'DISPLAY': ':0', 00:32:56 INFO - 'HOME': '/home/cltbld', 00:32:56 INFO - 'LANG': 'en_US.UTF-8', 00:32:56 INFO - 'LANGUAGE': 'en_US:en', 00:32:56 INFO - 'LOGNAME': 'cltbld', 00:32:56 INFO - 'MAIL': '/var/mail/cltbld', 00:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:56 INFO - 'MOZ_NO_REMOTE': '1', 00:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:56 INFO - 'NO_EM_RESTART': '1', 00:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:56 INFO - 'PWD': '/builds/slave/test', 00:32:56 INFO - 'SHELL': '/bin/bash', 00:32:56 INFO - 'SHLVL': '1', 00:32:56 INFO - 'TERM': 'linux', 00:32:56 INFO - 'TMOUT': '86400', 00:32:56 INFO - 'USER': 'cltbld', 00:32:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:56 INFO - '_': '/tools/buildbot/bin/python'} 00:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:32:56 INFO - Running setup.py (path:/tmp/pip-QRYY5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:32:56 INFO - Running setup.py (path:/tmp/pip-m0xiGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:32:56 INFO - Running setup.py (path:/tmp/pip-VBuZtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:32:56 INFO - Running setup.py (path:/tmp/pip-mz92Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:32:56 INFO - Running setup.py (path:/tmp/pip-YuJwwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:32:56 INFO - Running setup.py (path:/tmp/pip-2ecRcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:32:57 INFO - Running setup.py (path:/tmp/pip-aZgZed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:32:57 INFO - Running setup.py (path:/tmp/pip-aXYCiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:32:57 INFO - Running setup.py (path:/tmp/pip-cNx_dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:32:57 INFO - Running setup.py (path:/tmp/pip-MscUz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:32:57 INFO - Running setup.py (path:/tmp/pip-mVwKhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:32:57 INFO - Running setup.py (path:/tmp/pip-QB4GAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:32:57 INFO - Running setup.py (path:/tmp/pip-whqoP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:32:57 INFO - Running setup.py (path:/tmp/pip-ZwI4pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:32:57 INFO - Running setup.py (path:/tmp/pip-HMMFHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:32:57 INFO - Running setup.py (path:/tmp/pip-lAbleI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:32:57 INFO - Running setup.py (path:/tmp/pip-p0TY4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:32:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:32:57 INFO - Running setup.py install for manifestparser 00:32:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:32:57 INFO - Running setup.py install for mozcrash 00:32:58 INFO - Running setup.py install for mozdebug 00:32:58 INFO - Running setup.py install for mozdevice 00:32:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Running setup.py install for mozfile 00:32:58 INFO - Running setup.py install for mozhttpd 00:32:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Running setup.py install for mozinfo 00:32:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Running setup.py install for mozInstall 00:32:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Running setup.py install for mozleak 00:32:58 INFO - Running setup.py install for mozlog 00:32:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:32:58 INFO - Running setup.py install for moznetwork 00:32:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Running setup.py install for mozprocess 00:32:59 INFO - Running setup.py install for mozprofile 00:32:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Running setup.py install for mozrunner 00:32:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Running setup.py install for mozscreenshot 00:32:59 INFO - Running setup.py install for moztest 00:32:59 INFO - Running setup.py install for mozversion 00:32:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:32:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:32:59 INFO - Cleaning up... 00:32:59 INFO - Return code: 0 00:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:59 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:32:59 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 00:32:59 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 00:32:59 INFO - Using env: {'DISPLAY': ':0', 00:32:59 INFO - 'HOME': '/home/cltbld', 00:32:59 INFO - 'LANG': 'en_US.UTF-8', 00:32:59 INFO - 'LANGUAGE': 'en_US:en', 00:32:59 INFO - 'LOGNAME': 'cltbld', 00:32:59 INFO - 'MAIL': '/var/mail/cltbld', 00:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:59 INFO - 'MOZ_NO_REMOTE': '1', 00:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:59 INFO - 'NO_EM_RESTART': '1', 00:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:59 INFO - 'PWD': '/builds/slave/test', 00:32:59 INFO - 'SHELL': '/bin/bash', 00:32:59 INFO - 'SHLVL': '1', 00:32:59 INFO - 'TERM': 'linux', 00:32:59 INFO - 'TMOUT': '86400', 00:32:59 INFO - 'USER': 'cltbld', 00:32:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:59 INFO - '_': '/tools/buildbot/bin/python'} 00:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:32:59 INFO - Running setup.py (path:/tmp/pip-1sN6kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:32:59 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)) 00:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:32:59 INFO - Running setup.py (path:/tmp/pip-G3RgYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:33:00 INFO - Running setup.py (path:/tmp/pip-lDCILC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:33:00 INFO - Running setup.py (path:/tmp/pip-kFjLCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:33:00 INFO - Running setup.py (path:/tmp/pip-ubWI46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:33:00 INFO - Running setup.py (path:/tmp/pip-8AjjHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:33:00 INFO - Running setup.py (path:/tmp/pip-jpQlz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:33:00 INFO - Running setup.py (path:/tmp/pip-jIxLMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:33:00 INFO - Running setup.py (path:/tmp/pip-22PBgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:33:00 INFO - Running setup.py (path:/tmp/pip-KuFVS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:33:00 INFO - Running setup.py (path:/tmp/pip-fOKo3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:33:00 INFO - Running setup.py (path:/tmp/pip-Q1dPI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:33:00 INFO - Running setup.py (path:/tmp/pip-JY9_Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:33:00 INFO - Running setup.py (path:/tmp/pip-Bmu3nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:00 INFO - Running setup.py (path:/tmp/pip-2K4INz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:00 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)) 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:33:01 INFO - Running setup.py (path:/tmp/pip-XzGbL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:33:01 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)) 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:33:01 INFO - Running setup.py (path:/tmp/pip-bUdScV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:33:01 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)) 00:33:01 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)) 00:33:01 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)) 00:33:01 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)) 00:33:01 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)) 00:33:01 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)) 00:33:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:03 INFO - Downloading blessings-1.6.tar.gz 00:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:33:03 INFO - Installing collected packages: blessings 00:33:03 INFO - Running setup.py install for blessings 00:33:03 INFO - Successfully installed blessings 00:33:03 INFO - Cleaning up... 00:33:03 INFO - Return code: 0 00:33:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:33:03 INFO - Reading from file tmpfile_stdout 00:33:03 INFO - Current package versions: 00:33:03 INFO - argparse == 1.2.1 00:33:03 INFO - blessings == 1.6 00:33:03 INFO - blobuploader == 1.2.4 00:33:03 INFO - docopt == 0.6.1 00:33:03 INFO - functools32 == 3.2.3-2 00:33:03 INFO - jsonschema == 2.5.1 00:33:03 INFO - manifestparser == 1.1 00:33:03 INFO - mozInstall == 1.12 00:33:03 INFO - mozcrash == 0.17 00:33:03 INFO - mozdebug == 0.1 00:33:03 INFO - mozdevice == 0.48 00:33:03 INFO - mozfile == 1.2 00:33:03 INFO - mozhttpd == 0.7 00:33:03 INFO - mozinfo == 0.9 00:33:03 INFO - mozleak == 0.1 00:33:03 INFO - mozlog == 3.2 00:33:03 INFO - moznetwork == 0.27 00:33:03 INFO - mozprocess == 0.22 00:33:03 INFO - mozprofile == 0.28 00:33:03 INFO - mozrunner == 6.11 00:33:03 INFO - mozscreenshot == 0.1 00:33:03 INFO - mozsystemmonitor == 0.3 00:33:03 INFO - moztest == 0.7 00:33:03 INFO - mozversion == 1.4 00:33:03 INFO - psutil == 3.1.1 00:33:03 INFO - requests == 1.2.3 00:33:03 INFO - wsgiref == 0.1.2 00:33:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:33:03 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 00:33:03 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 00:33:03 INFO - Using env: {'DISPLAY': ':0', 00:33:03 INFO - 'HOME': '/home/cltbld', 00:33:03 INFO - 'LANG': 'en_US.UTF-8', 00:33:03 INFO - 'LANGUAGE': 'en_US:en', 00:33:03 INFO - 'LOGNAME': 'cltbld', 00:33:03 INFO - 'MAIL': '/var/mail/cltbld', 00:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:03 INFO - 'MOZ_NO_REMOTE': '1', 00:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:03 INFO - 'NO_EM_RESTART': '1', 00:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:03 INFO - 'PWD': '/builds/slave/test', 00:33:03 INFO - 'SHELL': '/bin/bash', 00:33:03 INFO - 'SHLVL': '1', 00:33:03 INFO - 'TERM': 'linux', 00:33:03 INFO - 'TMOUT': '86400', 00:33:03 INFO - 'USER': 'cltbld', 00:33:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:03 INFO - '_': '/tools/buildbot/bin/python'} 00:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 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)) 00:33:03 INFO - Cleaning up... 00:33:03 INFO - Return code: 0 00:33:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:33:03 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 00:33:03 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 00:33:03 INFO - Using env: {'DISPLAY': ':0', 00:33:03 INFO - 'HOME': '/home/cltbld', 00:33:03 INFO - 'LANG': 'en_US.UTF-8', 00:33:03 INFO - 'LANGUAGE': 'en_US:en', 00:33:03 INFO - 'LOGNAME': 'cltbld', 00:33:03 INFO - 'MAIL': '/var/mail/cltbld', 00:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:03 INFO - 'MOZ_NO_REMOTE': '1', 00:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:03 INFO - 'NO_EM_RESTART': '1', 00:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:03 INFO - 'PWD': '/builds/slave/test', 00:33:03 INFO - 'SHELL': '/bin/bash', 00:33:03 INFO - 'SHLVL': '1', 00:33:03 INFO - 'TERM': 'linux', 00:33:03 INFO - 'TMOUT': '86400', 00:33:03 INFO - 'USER': 'cltbld', 00:33:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:03 INFO - '_': '/tools/buildbot/bin/python'} 00:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:33:03 INFO - Cleaning up... 00:33:03 INFO - Return code: 0 00:33:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 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 0x7f06eefe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, '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': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', '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 00:33:03 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 00:33:03 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 00:33:03 INFO - Using env: {'DISPLAY': ':0', 00:33:03 INFO - 'HOME': '/home/cltbld', 00:33:03 INFO - 'LANG': 'en_US.UTF-8', 00:33:03 INFO - 'LANGUAGE': 'en_US:en', 00:33:03 INFO - 'LOGNAME': 'cltbld', 00:33:03 INFO - 'MAIL': '/var/mail/cltbld', 00:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:03 INFO - 'MOZ_NO_REMOTE': '1', 00:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:03 INFO - 'NO_EM_RESTART': '1', 00:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:03 INFO - 'PWD': '/builds/slave/test', 00:33:03 INFO - 'SHELL': '/bin/bash', 00:33:03 INFO - 'SHLVL': '1', 00:33:03 INFO - 'TERM': 'linux', 00:33:03 INFO - 'TMOUT': '86400', 00:33:03 INFO - 'USER': 'cltbld', 00:33:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:03 INFO - '_': '/tools/buildbot/bin/python'} 00:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:04 INFO - Downloading/unpacking flake8 00:33:04 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 00:33:04 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 00:33:04 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 00:33:04 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 00:33:04 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 00:33:04 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 00:33:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:33:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:33:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 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 00:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:33:06 INFO - no previously-included directories found matching 'docs/_build' 00:33:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:33:07 INFO - Running setup.py install for pep8 00:33:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:33:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:33:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:33:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:33:07 INFO - no previously-included directories found matching 'docs/_build' 00:33:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:33:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:33:07 INFO - Cleaning up... 00:33:07 INFO - Return code: 0 00:33:07 INFO - Running post-action listener: _resource_record_post_action 00:33:07 INFO - Running post-action listener: _start_resource_monitoring 00:33:07 INFO - Starting resource monitoring. 00:33:07 INFO - ##### 00:33:07 INFO - ##### Finished create-virtualenv step (success) 00:33:07 INFO - ##### 00:33:07 INFO - ##### 00:33:07 INFO - ##### Running install step. 00:33:07 INFO - ##### 00:33:07 INFO - Running pre-action listener: _resource_record_pre_action 00:33:07 INFO - Running main action method: install 00:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:33:07 INFO - Reading from file tmpfile_stdout 00:33:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:33:07 INFO - Reading from file tmpfile_stdout 00:33:07 INFO - Output received: 00:33:07 INFO - Usage: mozinstall [options] installer 00:33:07 INFO - Options: 00:33:07 INFO - -h, --help show this help message and exit 00:33:07 INFO - -d DEST, --destination=DEST 00:33:07 INFO - Directory to install application into. [default: 00:33:07 INFO - "/builds/slave/test"] 00:33:07 INFO - --app=APP Application being installed. [default: firefox] 00:33:07 INFO - mkdir: /builds/slave/test/build/application 00:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:33:24 INFO - Reading from file tmpfile_stdout 00:33:24 INFO - Output received: 00:33:24 INFO - /builds/slave/test/build/application/firefox/firefox 00:33:24 INFO - Running post-action listener: _resource_record_post_action 00:33:24 INFO - ##### 00:33:24 INFO - ##### Finished install step (success) 00:33:24 INFO - ##### 00:33:24 INFO - ##### 00:33:24 INFO - ##### Running run-tests step. 00:33:24 INFO - ##### 00:33:24 INFO - Running pre-action listener: _resource_record_pre_action 00:33:24 INFO - Running main action method: run_tests 00:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:33:24 INFO - Python 2.7.3 00:33:24 INFO - Return code: 0 00:33:24 INFO - grabbing minidump binary from tooltool 00:33:24 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')]} 00:33:24 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 0x1ade2e0>, '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 0x1a4a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:33:24 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 00:33:24 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 00:33:24 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 00:33:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:33:24 INFO - Return code: 0 00:33:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:33:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:33:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:33:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:33:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:33:25 INFO - Return code: 0 00:33:25 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:33:25 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:33:25 INFO - Using env: {'DISPLAY': ':0', 00:33:25 INFO - 'HOME': '/home/cltbld', 00:33:25 INFO - 'LANG': 'en_US.UTF-8', 00:33:25 INFO - 'LANGUAGE': 'en_US:en', 00:33:25 INFO - 'LOGNAME': 'cltbld', 00:33:25 INFO - 'MAIL': '/var/mail/cltbld', 00:33:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:33:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:25 INFO - 'MOZ_NO_REMOTE': '1', 00:33:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:25 INFO - 'NO_EM_RESTART': '1', 00:33:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:25 INFO - 'PWD': '/builds/slave/test', 00:33:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:33:25 INFO - 'SHELL': '/bin/bash', 00:33:25 INFO - 'SHLVL': '1', 00:33:25 INFO - 'TERM': 'linux', 00:33:25 INFO - 'TMOUT': '86400', 00:33:25 INFO - 'USER': 'cltbld', 00:33:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547', 00:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:25 INFO - '_': '/tools/buildbot/bin/python'} 00:33:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:33:25 INFO - mozversion application_buildid: 20160603220435 00:33:25 INFO - mozversion application_changeset: e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f 00:33:25 INFO - mozversion application_display_name: Nightly 00:33:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:33:25 INFO - mozversion application_name: Firefox 00:33:25 INFO - mozversion application_remotingname: firefox 00:33:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:33:25 INFO - mozversion application_vendor: Mozilla 00:33:25 INFO - mozversion application_version: 49.0a1 00:33:25 INFO - mozversion platform_buildid: 20160603220435 00:33:25 INFO - mozversion platform_changeset: e1db300f075e3f4bfc9e7ff1a61a77cc101abe1f 00:33:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:33:25 INFO - mozversion platform_version: 49.0a1 00:33:25 INFO - using testdate: 1465025605 00:33:25 INFO - actual date: 1465025605 00:33:25 INFO - starting webserver on 'localhost:56069' 00:33:25 INFO - SUITE-START | Running 2 tests 00:33:25 INFO - TEST-START | dromaeo_css 00:33:25 INFO - operating with platform_type : linux_ 00:33:25 INFO - Initialising browser for dromaeo_css test... 00:33:25 INFO - TEST-INFO | started process 25759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIsHW6n/profile http://localhost:56069/getInfo.html) 00:33:29 INFO - PROCESS | 25759 | __metrics Screen width/height:1600/1200 00:33:29 INFO - PROCESS | 25759 | colorDepth:24 00:33:29 INFO - PROCESS | 25759 | Browser inner width/height: 1024/697 00:33:29 INFO - PROCESS | 25759 | __metrics 00:33:31 ERROR - PROCESS | 25759 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:33:31 INFO - TEST-INFO | 25759: exit 0 00:33:31 INFO - Browser initialized. 00:33:31 INFO - Running cycle 1/1 for dromaeo_css test... 00:33:31 INFO - TEST-INFO | started process 25842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIsHW6n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:33:43 INFO - PROCESS | 25842 | RSS: Main: 156422144 00:33:43 INFO - PROCESS | 25842 | 00:34:34 INFO - PROCESS | 25842 | 1465025674817 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] 00:36:42 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56069/tests/dromaeo/cssquery-ext.html) 00:36:43 INFO - PROCESS | 25842 | RSS: Main: 286371840 00:36:43 INFO - PROCESS | 25842 | 00:39:46 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-ext.html (next: http://localhost:56069/tests/dromaeo/cssquery-jquery.html) 00:39:47 INFO - PROCESS | 25842 | RSS: Main: 244994048 00:39:47 INFO - PROCESS | 25842 | 00:42:49 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56069/tests/dromaeo/cssquery-mootools.html) 00:42:49 INFO - PROCESS | 25842 | RSS: Main: 242372608 00:42:49 INFO - PROCESS | 25842 | 00:45:51 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56069/tests/dromaeo/cssquery-prototype.html) 00:45:52 INFO - PROCESS | 25842 | RSS: Main: 239874048 00:45:52 INFO - PROCESS | 25842 | 00:48:55 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56069/tests/dromaeo/cssquery-yui.html) 00:48:55 INFO - PROCESS | 25842 | RSS: Main: 223203328 00:48:55 INFO - PROCESS | 25842 | 00:51:58 INFO - PROCESS | 25842 | Cycle 1(1): loaded http://localhost:56069/tests/dromaeo/cssquery-yui.html (next: http://localhost:56069/tests/dromaeo/cssquery-dojo.html) 00:51:59 INFO - PROCESS | 25842 | RSS: Main: 283418624 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | __start_tp_report 00:51:59 INFO - PROCESS | 25842 | _x_x_mozilla_page_load 00:51:59 INFO - PROCESS | 25842 | _x_x_mozilla_page_load_details 00:51:59 INFO - PROCESS | 25842 | |i|pagename|runs| 00:51:59 INFO - PROCESS | 25842 | |0;dojo.html;3105.5807465992084;3105.829179395134;3123.1099136746025;3140.3405284890173;3163.9209019774503;5251.474852514747;5353.170258609912;5367.543758780504;5467.91798123028;5544.916826247604;5382.757775900084;5392.73036348183;5410.269613602162;5413.296271484702;5445.945540544593;4800.663953523246;4873.1715608346485;4877.463479017305;4888.266759985995;5044.924326135111;4964.851054468371;4978.825741099062;5009.824656137036;5019.472955339692;5021.874453138683;4783.091212669599;4804.327394164819;4863.610911127119;4873.780679869396;4892.119418504668;4772.73749943753;4799.3760811094335;4850.320955066293;4928.43323017854;4960.107180707471;4879.341288925985;4884.975575122137;4889.413270407538;4906.9263961040615;4914.090893184736;5244.370675518962;5274.630775845692;5289.44460831611;5321.707306098163;5394.541463975567;5774.4802967732685;5808.157817116495;5820.388859169769;5822.854428639275;5827.592068555203;5845.85385365365;5853.795117170878;5856.121581762727;5867.207926929896;5874.9118763218585;5334.359876814807;5367.46325367464;5405.37838148614;5427.83716488506;5455.18172274158;5974.103884417372;6021.217241758543;6023.45788879003;6025.879482410327;6027;5770.42295770428;5772.365039845614;5776.566757493205;5778.3643799182055;5782.277215348082;5631.183478395692;5717.685527295956;5818.5054270386645;5827.94172058274;5864.501517371071;5815.069588865761;5832.533397328203;5836.591438599342;5838.4453476919625;5839.445252700986;5630.577706672016;5824.097264923944;5868.765249389977;5869.941300587025;5873.647581145145;4320.870373888788;4338.0239446125;4375.146846364992;4383.912321753611;4404.55954404557;3899.200663863901;3904.375299951994;3925.0776067624083;3939.9015024624614;3946.309395855771;5379.65032272901;5490.478404551562;5519.31008623922;5523.061079616475;5523.861903452445;5722.141678748138;5791.710414479344;5817.912731309034;5843.883122337615;5845.7369418376275;5517.586181036439;5521.944780552143;5523.116301391758;5525.889482210333;5534.335879694382;4880.414350277918;5002.924956125661;5009.423916249605;5019.949800501949;5061.898762024739;5991.910121348184;6021;6080.209572755513;6108.908366374508;6118.847028824226;5856.765729370777;5859.707014649336;5860.150278209721;5868.2077919480325;5872.794452194153;5855.268091488564;6042;6047.606905551125;6053.364396738455;6057.1519987200945;5752.367239603724;5849.444302791228;5849.707514624167;5864.530837533072;5900.173975643327;5904.527637789052;5918.3489816121055;5930.52555795544;5953.821385358447;5965.403459654173;5574;5614.438556144353;5691.14632805066;5793.507551858139;5795.420457954171;5723.227364305765;5767.480926716616;5770.826875193751;5773.422657734193;5798.188253644409;5629.662220266797;5655.632383895034;5664.291963504562;5665.773369065356;5672.376038635829;5410.431904650112;5525.281713377235;5605.075162598288;5686.175504551899;5777.6822274775295;5473.589480788877;5478.972605136949;5500.50495455411;5565.471280228372;5569.526590239713 00:51:59 INFO - PROCESS | 25842 | |1;ext.html;570.1049352516549;609.3997412548639;624.9000159974402;641.99679001605;643.649211179907;30934.53598196026;31531.84234078829;34113.317733645315;34141;42308.36537451933;41125.17749645013;46219.768901155534;46247.306290405584;46359.30461043087;46409;8727.51998640076;8917.420367676114;8922.197002269795;8927.598258078402;8934.28525717941;8709.34679899007;8853.867191992125;8868.689595864145;8869.290456763443;8880.067592902717;8911.10888911107;8959.462432254053;8973.10268973104;8977.910220897773;8996.235319997808;8845.380823342337;8859.114088591154;8898.110188981114;8899.15458031486;8909.95545022274;8688.131186881325;8789.736307910773;8792.648294068229;8803.647854085893;8816.955915220382;39693.40459893104;39908.80045599782;40028.59971400307;40158.79920600378;40169.59830401688;3506.2286297014616;3601.117726157082;3675.3935600625864;3702.833372498244;3916.236333914888;31933.361332773213;32112.518312225337;32462.350752985043;34032.6596734032;34124.317513649585;4356;4399.868003959887;4426.424564806554;4434.091011342699;4574.921006957317;353039;357241.9999999974;360401.3658839002;360689;363009;53787;54255.45744542583;54860.17709734357;54883.45116548863;54883.72558137184;56311;60701.39298607046;61475.692621536604;61715.38284617186;62857.68571157115;16616.6676666466;16758.832411675972;16785.748213776802;16820.495385138467;16824.242909068875;11606.187566870407;11630.302181869114;11651.650450486499;11654.53381864733;11656.53373865036;16140.435084771976;16461.58846028835;16465.58836029085;17166.570835729206;17851.910740446474;6306.432421082033;6542.672866356663;6568.7372505099265;6600.339966003361;6684.665766711645;974.6539978307741;1047.5809676129609;1095.90684791792;1098.19282827122;1164.778692048508;32440.188995275308;32745.34509309848;32863.671363286536;32889.17777055593;33072.3385532288;1135.3755434510986;1190.2382475215868;1192.1595275331044;1203.8615559210803;1215.4226742297337;16781;16990.320387184373;17117.65764684724;17277.56806079858;17301.546340592045;518019;521041;528659;528778;530625;59043.114353284735;59098.704506477196;59190.11214831781;59270.70364648149;59300.703496483104;1328.5947785925193;1391.4921053815285;1400.271858633505;1401.2083173007015;1402.6353148181342;31487.685123149393;32149.839250803598;32378.514322285657;32410.83794581012;32848.69676095505;52684;52736.47263527316;53144.734276328374;53259.73370133279;53293;486187;491924;492105;492238.5433019654;493047;31828.5225721619;37363.43954840734;37410.25179496449;42579.361309581;42990.35514467223;42471.3629295567;48994.265086024454;49023;49367.59486077117;50768;40491.595084048786;41336.1732765349;41399.7930010348;41823.58176418197;42064;39602.5345622118;40759.592404076764;40982.1803563933;41337.379939300336;41493.377599336636;40222;40629.18741625092;41985;42044.78977605092;42134.15731685288;35670.64329356673;36611.81694091512;36822.63177368192;37117.6288237125;37188.44217336796;27701.87139804487;28196.85901570479;28304.694225898245;28316.15051548457;28393.15752956275 00:51:59 INFO - PROCESS | 25842 | |2;jquery.html;374.1861451343328;393.93303138466456;394.52262762057927;395.0597577764919;420.97053206275575;16148;18557.16492757826;18636.720449193257;18701.101329293946;19893.20427182911;18638.161282742276;18952;19144.712829307537;19319.13063912124;19518.414447566596;5559.861003474905;5634.464725851038;5696.601237913348;5746.25298711169;5746.7413966371405;5540.085885828834;5683.630564013347;5691.8577035574235;5693.231413759131;5734.741936612862;5475.151351540518;5644.435556444343;5654.830355089354;5672.9432705672825;5753.741081651336;5731;5786.103154011093;5800.303963524383;5812.244408226925;5822.301323841145;5480.561555075585;5656.038473459522;5702.372738998707;5746.425357464262;5755.971220143872;13386.598402047954;13467.730645387135;13491.595252142451;17199.312027518885;19686.80313196864;2269.8751568663715;2377.465070359173;2388.558116748407;2408.783209511135;2738.6713594368603;10005.349652272651;10851.891481085167;13748.587542373745;14178.149311041267;14235;1907.4754442528276;1969.7833238343771;2001.0695026812602;2006.7892871248455;2092.4664210626192;69789.3021069793;72197.27802721958;75606.62196688981;77271;82216.65591736577;10956.34261944286;10972.561097556008;11144.275622084539;11169.27399719032;11213.439328033566;15222.847771522365;15432;15440.45958391451;15523.84476155224;15529.767053494206;7796.220377962159;7810.57041862703;7873.330766884765;7957.641906114239;8017.318527925075;7502.887456688154;7578.772636820904;7580.559693658187;7690.615469226516;7705;4721.669483136147;4752.263399173134;4807.567318941312;4817.855464336076;4876.097921884463;1883.5385330593817;1916.28845184063;1970.6748386516065;1977.8022197780394;2001.279539365827;864.2394692670409;939.8261321655516;949.6438835436711;1071.5553045486035;1082.832161015044;18251.81748182501;19124.2350305989;19381.321653742052;19460.513487162934;19686.606267874562;975.2636759246724;991.0782971836262;1000.7548150703125;1017.5726194998118;1019.4749703902496;10446.112080473093;10743.020815721631;10756.354618722746;10825.880123616611;10872.045233765879;474763;479844;480048;486577;492654;92671;94592.0540794597;94672;94762;95268;986.6004268271362;1003.7791685829106;1013.2400699475394;1019.1439191079529;1020.9540570674337;16674.583135421228;16763.413280535122;17101.74347384815;17161;17270.913645431694;38205.80897095497;39056;39971.40042899301;40445;42083.36874946817;54391.18413223726;55946.44053559412;57235.14147287877;57250.141247880485;57527.42472575221;8154.510729356258;8192.426530142833;8586.914130858611;8908.55457227123;8968.910310896808;12249.265044097383;13057.151285166434;13117.73764524685;13737.931310343385;13881.722365552834;11402.600908968147;11526.82709759371;11620.6513804586;11746.647600571996;11879.643610691694;11419.486123124314;11528.942355288169;11652;11679.708007299545;12350.938245308716;11613.129015323715;11735.882641173821;11814.409279536161;11827.586034488751;12175;7520.962395187989;7726.961365193138;8606.311495080254;8654.82690346202;8684.305255579664;11108.833367499332;11471.369074700639;11584.47869845842;11698.181127321346;12019.399030048637 00:51:59 INFO - PROCESS | 25842 | |3;mootools.html;1323.0056536574425;1496.8278647955485;1539.99130569477;1696.3723422333737;1857.8978156201404;8524.318054555637;8819.647214111435;8875.378723489366;9274.953625231865;9318.068193180696;9089.40918840275;9260.212881905047;9267.675631352904;9286.39638423502;9299.95350023249;2035.8676686015435;2349.2482405630203;2412.203972689017;2412.6501657259773;2441.438469152096;2434.7808697217247;2439.3901524618846;2445.730969593343;2446.633005049248;2450.656908032877;2424.781769640732;2428.4293191100164;2456.0298682020593;2457.0785955266774;2457.1031573475643;2011.688188330811;2284.7715228477186;2345.1674655497395;2354.0701422937846;2377.9643305350432;2401.6637670726113;2410.0480310277517;2427.368884090132;2429.963550546743;2433.9391515212083;8930.776730581723;8981.595828187681;9002;9006.639734410615;9020.18818306349;5306.151015837448;5476;5478.698671573062;5479.506844383985;5479.506844384025;3237.7247933925646;3301.8679252829857;3359.260962588227;3367.3097015111844;3427.8286085695618;1136.891995260449;1138.1918837625296;1147.1396452660504;1152.2913408253946;1157.3692337675986;12835.679108022281;12877.935610321889;12886.1623994441;12893.290869002201;12894.871051289461;4702.811887524529;4744.952550474451;4836.661433699677;4839.2983017462975;4879.609631229493;10567.788644227072;10663.946680266548;10672.893271067345;10713.928607139223;10744.14046876248;5461.699606521679;5464.726763661801;5465.6447330923365;5466.890662186734;5469.945300547023;4237.851675191354;4929.2359684248995;5071.909539448962;5075.264086707407;5152.3044389007755;4070.8778736637946;4133.689973252018;4137.606927341898;4216.177845320194;4219.156168766259;1290.283892439705;1313.8620444853152;1321.3657444426728;1321.9471221151045;1328.7608230518406;872.8530829111578;929.4887811703536;971.2812518736084;972.8686627305365;984.0012387426767;5853.853653658693;5975.92433361999;6005.429484198994;6023.216981792339;6080;450.59446498151925;476.768767147933;477.88769639134773;481.8482178113883;484.9379858110726;3930.1746633207345;4020.6582440492884;4022.7586344819406;4029.762818259675;4108;11136.10911127124;11449.713757156138;11584.47869845859;11592.36242006681;11592.594259200887;11258.155638327158;11453.198276120758;11467.254628449124;11470.655880323604;11500.539978400937;8265.710700125466;8547.188017138486;8549.572521373906;8560.272376847914;8590.527520986281;5713.314402271754;5760.193572899713;5791.623544469596;5804.94195058044;5876.823695289148;10471.528781205016;10552.261341706315;10553.736156596147;10650.680479585624;10660.200484963503;10521.263511554118;10817.675469735921;10888.836667449836;10934.671959841218;10966.06788422993;6911.170659520689;7042.683079261548;7069.151701795612;8186.713465028695;8235.29999950011;7601.809954751176;8516;8795.252403545514;8824.735257942271;9059.773505662411;7251.093613298338;7264.055672762507;7359.337659610661;7502.962485187758;7566.772996810105;7400.777976660709;7515.286047825448;7561.2060733622175;7593.620318984139;7726.575038372944;6808.319168083351;6811.89782153278;6861.862762744618;6872.381485666314;6879.380855723009;5011.4236862761245;5182.429932707324;5289.3652761668845;5290.100682883842;5324.1747529133045;4997.0505603935135;5030.647854650286;5053.444121146745;5066.341375621146;5112.923306150485 00:51:59 INFO - PROCESS | 25842 | |4;prototype.html;326.5281667989756;333.6763339560626;341.32588138426604;344.1516661429577;347.15294680978394;5268.420473747894;5348.304720386354;5377.327834020747;5411.756470958807;5417.052015897217;4965.230389289657;5080.491950804918;5159.432462429139;5220.6606570572885;5229.712365819878;4063.5123785145825;4108.828983739635;4121.896952576195;4136.689748268885;4140.648044916185;4097.098638299584;4117.485314335708;4125.814338354766;4144.979275103636;4148.460700108997;3896.5713771485116;3987.680985521166;4092.897677558055;4138.13099249158;4139.77231252281;4074.7962601870086;4083;4086.6730661547003;4097.160082183145;4111.732737372061;3677.3196958562485;3684.428913518409;3699.85200591976;3704.4441334639514;3713.1274150574595;5024.392194497762;5025.648204625678;5028.446870844205;5114.232865070232;5151.227315902607;4723.858284251478;4738.526147385269;4746.738929358884;4767.093162734899;4782.282657601353;5504.4770746778995;5517.5930137815;5535.944640553583;5547.55619550435;5551.250581171531;3883.9026925460216;4019.4573732546023;4031.488191928027;4032.2338755636333;4083.958590559418;5647.830565083013;5709.914351284734;5722.768120433035;5727.627704199255;5740.8851822963725;4124.731892426983;4127.607877251657;4146.875593732193;4159;4167.354060120686;4049.6152865477734;4176.686748493875;4206.8527601534415;4220.240356735817;4226.260404429213;4590.6557008223845;4662.7202367858035;4709.246520556694;4721.15019296523;4721.976390118096;5422.7017514036315;5486.451354864482;5490.145124535219;5543.390227075019;5557.916631250535;1365.603974847303;1389.4442223110836;1411.2026704911898;1421.8933579981542;1453.8182727159106;929.8837645294338;949.5110018340561;950.8589692369185;955.6511873166384;958.750724811554;4738.251813947971;4738.407699037621;4764.404449443819;4772.069446457907;4815.15734746418;4969.527894849984;4970.453250142481;4992.179418628463;5002.89994200114;5017.222330538772;4410.625096866738;4745.549172828576;4749.482774129648;4776.966626192393;4834.323194752737;2684.717989708771;2700.7569318761407;2701.7973651975785;2706.5114187196964;2706.538469226635;5148.382194136652;5169.483051694876;5177.249298851645;5207.973960130251;5233.586931528542;4765.309030190603;5064.316317297192;5076.82231121909;5103.97448012765;5104.2088476286235;5147.3308469898675;5167.948320516822;5172.27588137661;5187.63686541946;5193.792248310026;4927.630427718007;4954.727489988085;4978.30303757467;4994.825181118644;5028.446870844277;4864.078688917928;4961.603071754179;5075.4417014127675;5268.2361057647195;5726.141078838041;5944.256967879015;5952.404759524013;5977.402259773988;5982.192404025575;5996.970015149896;4092.9181416372103;4127.215828992482;4143.357779544175;4144.854930077553;4158.584141585939;5382.381026182039;5694.373618902;5715.342735585461;5732.9394062098645;5853.795117170878;5405.891882162414;5568.415316391721;5586.748596313095;5593.636413633101;5595.440455954372;5530.861728456821;5533.750981205936;5544.7543744783425;5554.583406244467;5588.972055139699;5281.366236051698;5468.265867066467;5498.992867603376;5512.779488820563;5545.889082218414;5599;5604.327480702342;5609.915851262316;5651.095824668033;5670.574706896917;5542.614346413397;5549.38956714753;5550;5556.916646250229;5561.527270181918 00:51:59 INFO - PROCESS | 25842 | |5;yui.html;787.5432249295409;814.3525896911955;844.7930257087014;850.15409667381;889.1641856654746;14934.999999999987;16132;16178.919105404457;16199.028058316495;16213.189340532985;14269.50056748014;14312.642183945407;14315.78526322106;14318.140911545288;14508.202048887308;788.4362680683296;799;800.8598495263335;801.286854699318;802.8474589827944;665.3213722003553;781.9100803407596;784.4077721320396;784.8626490364192;784.9882251766228;848.1094850407079;857.459800325797;861.3238607692962;862.038826708219;862.65062649627;848.2747251100313;851.1105894340429;852.3607294529103;854.0647990450509;855.2858363266648;523.1629392971254;605.2948315212772;620.1813606040029;621.7077973352517;622.7726879688926;14264.572062838131;14292.285385730776;14310.928445357811;14326;14367.568972930829;13827.819601491612;14192.219427931459;14618.26908654563;14699.926500367537;14848.703025939529;13058.869411305956;13090.45878522784;13165.341732913412;13165.539206127836;13407.396667150002;4384.561543845622;4498.977505112486;4515.277555591089;4575.9771201143785;4667.529728135661;74364.25635743627;76037.61981190114;76220.61889690516;76347.23652763512;76454.617726911;10839.349639021684;11465.254758440675;11624.128190385754;11795;11810.114241431927;20374.592508149755;20971.685424718642;21019;21029.789702102782;21040;8356.582170891552;8377.533931562075;8379.62291696875;8451.028131764802;8559.272461840688;4850.417949846041;4990.9768497457935;5050.77271522775;5171.818986335536;5301.3373328333955;3498.370293347171;3626.419772836386;3627.891163265106;3629.8185090745355;3631.4915911772373;642.3287664390723;643.2184895352169;644.7292137302344;656.5240200854342;665.2416245480157;538.5422390967724;555.3086407422704;625.7309356976543;629.6662768732579;640.5132099604241;8927.642894284156;8931.687390941286;9189.356745027917;9220.953895230616;9267.170881119697;605.857623458487;639.2467789890981;640.3372509452694;687.7592842505084;716.698986425692;4389.31965545341;4394.406755088086;4443.888902777457;4524.6380289576755;4600.723956562617;116536;127290.36354818166;127894;129414;131855;65559.67220163964;75339;103746;107362.46318768512;108917;89210.55394722986;92510.53744731234;93035;94987.52506237425;95867.52066239624;8694.608742606471;8927;9054.728358149267;9120.680776172801;9364.157225849705;52944.73527632337;53031.469685302654;53275;53954.73022634862;54655.453445465035;72923.63538182275;77601;78105.21894781207;79192.60403697945;79267;10718.464076795974;10912.727181820517;11058.281211721212;11100.777984440105;11518.53925842957;12225.796140168773;12964.805527917277;13025.283609401195;13255.734885302047;14018.088824226392;11128.721781955515;12491.500339986298;12674.176178548365;12905;13015.154014988995;13236.13965092266;13284.667883302995;13338.666533336744;13421.261830599411;13677.110987785762;13066.803997939849;13486.190828550318;13876.444942202199;14711.779323309946;14740.778888316898;11355.824442192737;11414.258073225214;11538.538458461904;11594.826077608674;11633.47649355764;11154.49804758804;11642.359670218219;11756.412179390825;11944.343061131722;12054.578089766816 00:51:59 INFO - PROCESS | 25842 | __end_tp_report 00:51:59 INFO - PROCESS | 25842 | __start_cc_report 00:51:59 INFO - PROCESS | 25842 | _x_x_mozilla_cycle_collect,1080 00:51:59 INFO - PROCESS | 25842 | __end_cc_report 00:51:59 INFO - PROCESS | 25842 | __startTimestamp1465026719035__endTimestamp 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | ------- Summary: start ------- 00:51:59 INFO - PROCESS | 25842 | Number of tests: 6 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#0] dojo.html Cycles:165 Average:5395.85 Median:5574.00 stddev:638.86 (11.5%) stddev-sans-first:615.04 00:51:59 INFO - PROCESS | 25842 | Values: 3105.6 3105.8 3123.1 3140.3 3163.9 5251.5 5353.2 5367.5 5467.9 5544.9 5382.8 5392.7 5410.3 5413.3 5445.9 4800.7 4873.2 4877.5 4888.3 5044.9 4964.9 4978.8 5009.8 5019.5 5021.9 4783.1 4804.3 4863.6 4873.8 4892.1 4772.7 4799.4 4850.3 4928.4 4960.1 4879.3 4885.0 4889.4 4906.9 4914.1 5244.4 5274.6 5289.4 5321.7 5394.5 5774.5 5808.2 5820.4 5822.9 5827.6 5845.9 5853.8 5856.1 5867.2 5874.9 5334.4 5367.5 5405.4 5427.8 5455.2 5974.1 6021.2 6023.5 6025.9 6027.0 5770.4 5772.4 5776.6 5778.4 5782.3 5631.2 5717.7 5818.5 5827.9 5864.5 5815.1 5832.5 5836.6 5838.4 5839.4 5630.6 5824.1 5868.8 5869.9 5873.6 4320.9 4338.0 4375.1 4383.9 4404.6 3899.2 3904.4 3925.1 3939.9 3946.3 5379.7 5490.5 5519.3 5523.1 5523.9 5722.1 5791.7 5817.9 5843.9 5845.7 5517.6 5521.9 5523.1 5525.9 5534.3 4880.4 5002.9 5009.4 5019.9 5061.9 5991.9 6021.0 6080.2 6108.9 6118.8 5856.8 5859.7 5860.2 5868.2 5872.8 5855.3 6042.0 6047.6 6053.4 6057.2 5752.4 5849.4 5849.7 5864.5 5900.2 5904.5 5918.3 5930.5 5953.8 5965.4 5574.0 5614.4 5691.1 5793.5 5795.4 5723.2 5767.5 5770.8 5773.4 5798.2 5629.7 5655.6 5664.3 5665.8 5672.4 5410.4 5525.3 5605.1 5686.2 5777.7 5473.6 5479.0 5500.5 5565.5 5569.5 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#1] ext.html Cycles:180 Average:61702.23 Median:41446.59 stddev:123109.98 (297.0%) stddev-sans-first:123369.78 00:51:59 INFO - PROCESS | 25842 | Values: 570.1 609.4 624.9 642.0 643.6 30934.5 31531.8 34113.3 34141.0 42308.4 41125.2 46219.8 46247.3 46359.3 46409.0 8727.5 8917.4 8922.2 8927.6 8934.3 8709.3 8853.9 8868.7 8869.3 8880.1 8911.1 8959.5 8973.1 8977.9 8996.2 8845.4 8859.1 8898.1 8899.2 8910.0 8688.1 8789.7 8792.6 8803.6 8817.0 39693.4 39908.8 40028.6 40158.8 40169.6 3506.2 3601.1 3675.4 3702.8 3916.2 31933.4 32112.5 32462.4 34032.7 34124.3 4356.0 4399.9 4426.4 4434.1 4574.9 353039.0 357242.0 360401.4 360689.0 363009.0 53787.0 54255.5 54860.2 54883.5 54883.7 56311.0 60701.4 61475.7 61715.4 62857.7 16616.7 16758.8 16785.7 16820.5 16824.2 11606.2 11630.3 11651.7 11654.5 11656.5 16140.4 16461.6 16465.6 17166.6 17851.9 6306.4 6542.7 6568.7 6600.3 6684.7 974.7 1047.6 1095.9 1098.2 1164.8 32440.2 32745.3 32863.7 32889.2 33072.3 1135.4 1190.2 1192.2 1203.9 1215.4 16781.0 16990.3 17117.7 17277.6 17301.5 518019.0 521041.0 528659.0 528778.0 530625.0 59043.1 59098.7 59190.1 59270.7 59300.7 1328.6 1391.5 1400.3 1401.2 1402.6 31487.7 32149.8 32378.5 32410.8 32848.7 52684.0 52736.5 53144.7 53259.7 53293.0 486187.0 491924.0 492105.0 492238.5 493047.0 31828.5 37363.4 37410.3 42579.4 42990.4 42471.4 48994.3 49023.0 49367.6 50768.0 40491.6 41336.2 41399.8 41823.6 42064.0 39602.5 40759.6 40982.2 41337.4 41493.4 40222.0 40629.2 41985.0 42044.8 42134.2 35670.6 36611.8 36822.6 37117.6 37188.4 27701.9 28196.9 28304.7 28316.2 28393.2 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#2] jquery.html Cycles:180 Average:28424.37 Median:2383.01 stddev:79604.88 (3340.5%) stddev-sans-first:79800.33 00:51:59 INFO - PROCESS | 25842 | Values: 374.2 393.9 394.5 395.1 421.0 16148.0 18557.2 18636.7 18701.1 19893.2 18638.2 18952.0 19144.7 19319.1 19518.4 5559.9 5634.5 5696.6 5746.3 5746.7 5540.1 5683.6 5691.9 5693.2 5734.7 5475.2 5644.4 5654.8 5672.9 5753.7 5731.0 5786.1 5800.3 5812.2 5822.3 5480.6 5656.0 5702.4 5746.4 5756.0 13386.6 13467.7 13491.6 17199.3 19686.8 2269.9 2377.5 2388.6 2408.8 2738.7 10005.3 10851.9 13748.6 14178.1 14235.0 1907.5 1969.8 2001.1 2006.8 2092.5 69789.3 72197.3 75606.6 77271.0 82216.7 10956.3 10972.6 11144.3 11169.3 11213.4 15222.8 15432.0 15440.5 15523.8 15529.8 7796.2 7810.6 7873.3 7957.6 8017.3 7502.9 7578.8 7580.6 7690.6 7705.0 4721.7 4752.3 4807.6 4817.9 4876.1 1883.5 1916.3 1970.7 1977.8 2001.3 864.2 939.8 949.6 1071.6 1082.8 18251.8 19124.2 19381.3 19460.5 19686.6 975.3 991.1 1000.8 1017.6 1019.5 10446.1 10743.0 10756.4 10825.9 10872.0 474763.0 479844.0 480048.0 486577.0 492654.0 92671.0 94592.1 94672.0 94762.0 95268.0 986.6 1003.8 1013.2 1019.1 1021.0 16674.6 16763.4 17101.7 17161.0 17270.9 38205.8 39056.0 39971.4 40445.0 42083.4 54391.2 55946.4 57235.1 57250.1 57527.4 8154.5 8192.4 8586.9 8908.6 8968.9 12249.3 13057.2 13117.7 13737.9 13881.7 11402.6 11526.8 11620.7 11746.6 11879.6 11419.5 11528.9 11652.0 11679.7 12350.9 11613.1 11735.9 11814.4 11827.6 12175.0 7521.0 7727.0 8606.3 8654.8 8684.3 11108.8 11471.4 11584.5 11698.2 12019.4 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#3] mootools.html Cycles:180 Average:5915.00 Median:479.87 stddev:3456.21 (720.2%) stddev-sans-first:3448.68 00:51:59 INFO - PROCESS | 25842 | Values: 1323.0 1496.8 1540.0 1696.4 1857.9 8524.3 8819.6 8875.4 9275.0 9318.1 9089.4 9260.2 9267.7 9286.4 9300.0 2035.9 2349.2 2412.2 2412.7 2441.4 2434.8 2439.4 2445.7 2446.6 2450.7 2424.8 2428.4 2456.0 2457.1 2457.1 2011.7 2284.8 2345.2 2354.1 2378.0 2401.7 2410.0 2427.4 2430.0 2433.9 8930.8 8981.6 9002.0 9006.6 9020.2 5306.2 5476.0 5478.7 5479.5 5479.5 3237.7 3301.9 3359.3 3367.3 3427.8 1136.9 1138.2 1147.1 1152.3 1157.4 12835.7 12877.9 12886.2 12893.3 12894.9 4702.8 4745.0 4836.7 4839.3 4879.6 10567.8 10663.9 10672.9 10713.9 10744.1 5461.7 5464.7 5465.6 5466.9 5469.9 4237.9 4929.2 5071.9 5075.3 5152.3 4070.9 4133.7 4137.6 4216.2 4219.2 1290.3 1313.9 1321.4 1321.9 1328.8 872.9 929.5 971.3 972.9 984.0 5853.9 5975.9 6005.4 6023.2 6080.0 450.6 476.8 477.9 481.8 484.9 3930.2 4020.7 4022.8 4029.8 4108.0 11136.1 11449.7 11584.5 11592.4 11592.6 11258.2 11453.2 11467.3 11470.7 11500.5 8265.7 8547.2 8549.6 8560.3 8590.5 5713.3 5760.2 5791.6 5804.9 5876.8 10471.5 10552.3 10553.7 10650.7 10660.2 10521.3 10817.7 10888.8 10934.7 10966.1 6911.2 7042.7 7069.2 8186.7 8235.3 7601.8 8516.0 8795.3 8824.7 9059.8 7251.1 7264.1 7359.3 7503.0 7566.8 7400.8 7515.3 7561.2 7593.6 7726.6 6808.3 6811.9 6861.9 6872.4 6879.4 5011.4 5182.4 5289.4 5290.1 5324.2 4997.1 5030.6 5053.4 5066.3 5112.9 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#4] prototype.html Cycles:180 Average:4529.58 Median:4998.86 stddev:1307.57 (26.2%) stddev-sans-first:1272.62 00:51:59 INFO - PROCESS | 25842 | Values: 326.5 333.7 341.3 344.2 347.2 5268.4 5348.3 5377.3 5411.8 5417.1 4965.2 5080.5 5159.4 5220.7 5229.7 4063.5 4108.8 4121.9 4136.7 4140.6 4097.1 4117.5 4125.8 4145.0 4148.5 3896.6 3987.7 4092.9 4138.1 4139.8 4074.8 4083.0 4086.7 4097.2 4111.7 3677.3 3684.4 3699.9 3704.4 3713.1 5024.4 5025.6 5028.4 5114.2 5151.2 4723.9 4738.5 4746.7 4767.1 4782.3 5504.5 5517.6 5535.9 5547.6 5551.3 3883.9 4019.5 4031.5 4032.2 4084.0 5647.8 5709.9 5722.8 5727.6 5740.9 4124.7 4127.6 4146.9 4159.0 4167.4 4049.6 4176.7 4206.9 4220.2 4226.3 4590.7 4662.7 4709.2 4721.2 4722.0 5422.7 5486.5 5490.1 5543.4 5557.9 1365.6 1389.4 1411.2 1421.9 1453.8 929.9 949.5 950.9 955.7 958.8 4738.3 4738.4 4764.4 4772.1 4815.2 4969.5 4970.5 4992.2 5002.9 5017.2 4410.6 4745.5 4749.5 4777.0 4834.3 2684.7 2700.8 2701.8 2706.5 2706.5 5148.4 5169.5 5177.2 5208.0 5233.6 4765.3 5064.3 5076.8 5104.0 5104.2 5147.3 5167.9 5172.3 5187.6 5193.8 4927.6 4954.7 4978.3 4994.8 5028.4 4864.1 4961.6 5075.4 5268.2 5726.1 5944.3 5952.4 5977.4 5982.2 5997.0 4092.9 4127.2 4143.4 4144.9 4158.6 5382.4 5694.4 5715.3 5732.9 5853.8 5405.9 5568.4 5586.7 5593.6 5595.4 5530.9 5533.8 5544.8 5554.6 5589.0 5281.4 5468.3 5499.0 5512.8 5545.9 5599.0 5604.3 5609.9 5651.1 5670.6 5542.6 5549.4 5550.0 5556.9 5561.5 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - PROCESS | 25842 | [#5] yui.html Cycles:180 Average:21150.46 Median:4588.35 stddev:31317.20 (682.5%) stddev-sans-first:31367.73 00:51:59 INFO - PROCESS | 25842 | Values: 787.5 814.4 844.8 850.2 889.2 14935.0 16132.0 16178.9 16199.0 16213.2 14269.5 14312.6 14315.8 14318.1 14508.2 788.4 799.0 800.9 801.3 802.8 665.3 781.9 784.4 784.9 785.0 848.1 857.5 861.3 862.0 862.7 848.3 851.1 852.4 854.1 855.3 523.2 605.3 620.2 621.7 622.8 14264.6 14292.3 14310.9 14326.0 14367.6 13827.8 14192.2 14618.3 14699.9 14848.7 13058.9 13090.5 13165.3 13165.5 13407.4 4384.6 4499.0 4515.3 4576.0 4667.5 74364.3 76037.6 76220.6 76347.2 76454.6 10839.3 11465.3 11624.1 11795.0 11810.1 20374.6 20971.7 21019.0 21029.8 21040.0 8356.6 8377.5 8379.6 8451.0 8559.3 4850.4 4991.0 5050.8 5171.8 5301.3 3498.4 3626.4 3627.9 3629.8 3631.5 642.3 643.2 644.7 656.5 665.2 538.5 555.3 625.7 629.7 640.5 8927.6 8931.7 9189.4 9221.0 9267.2 605.9 639.2 640.3 687.8 716.7 4389.3 4394.4 4443.9 4524.6 4600.7 116536.0 127290.4 127894.0 129414.0 131855.0 65559.7 75339.0 103746.0 107362.5 108917.0 89210.6 92510.5 93035.0 94987.5 95867.5 8694.6 8927.0 9054.7 9120.7 9364.2 52944.7 53031.5 53275.0 53954.7 54655.5 72923.6 77601.0 78105.2 79192.6 79267.0 10718.5 10912.7 11058.3 11100.8 11518.5 12225.8 12964.8 13025.3 13255.7 14018.1 11128.7 12491.5 12674.2 12905.0 13015.2 13236.1 13284.7 13338.7 13421.3 13677.1 13066.8 13486.2 13876.4 14711.8 14740.8 11355.8 11414.3 11538.5 11594.8 11633.5 11154.5 11642.4 11756.4 11944.3 12054.6 00:51:59 INFO - PROCESS | 25842 | -------- Summary: end -------- 00:51:59 INFO - PROCESS | 25842 | 00:51:59 INFO - TEST-INFO | 25842: exit 0 00:51:59 INFO - TEST-OK | dromaeo_css | took 1114167ms 00:51:59 INFO - TEST-START | kraken 00:51:59 INFO - operating with platform_type : linux_ 00:51:59 INFO - Initialising browser for kraken test... 00:51:59 INFO - TEST-INFO | started process 26021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphdT9lU/profile http://localhost:56069/getInfo.html) 00:52:04 INFO - PROCESS | 26021 | __metrics Screen width/height:1600/1200 00:52:04 INFO - PROCESS | 26021 | colorDepth:24 00:52:04 INFO - PROCESS | 26021 | Browser inner width/height: 1024/697 00:52:04 INFO - PROCESS | 26021 | __metrics 00:52:04 ERROR - PROCESS | 26021 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:52:05 INFO - TEST-INFO | 26021: exit 0 00:52:05 INFO - Browser initialized. 00:52:05 INFO - Running cycle 1/1 for kraken test... 00:52:05 INFO - TEST-INFO | started process 26104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphdT9lU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:17 INFO - PROCESS | 26104 | RSS: Main: 156442624 00:52:17 INFO - PROCESS | 26104 | 00:52:20 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56069/tests/kraken/driver.html?testName=audio-beat-detection) 00:52:20 INFO - PROCESS | 26104 | RSS: Main: 214835200 00:52:20 INFO - PROCESS | 26104 | 00:52:23 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56069/tests/kraken/driver.html?testName=audio-dft) 00:52:24 INFO - PROCESS | 26104 | RSS: Main: 202899456 00:52:24 INFO - PROCESS | 26104 | 00:52:27 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56069/tests/kraken/driver.html?testName=audio-fft) 00:52:28 INFO - PROCESS | 26104 | RSS: Main: 269053952 00:52:28 INFO - PROCESS | 26104 | 00:52:30 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56069/tests/kraken/driver.html?testName=audio-oscillator) 00:52:30 INFO - PROCESS | 26104 | RSS: Main: 179232768 00:52:30 INFO - PROCESS | 26104 | 00:52:32 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56069/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:52:33 INFO - PROCESS | 26104 | RSS: Main: 183586816 00:52:33 INFO - PROCESS | 26104 | 00:52:36 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56069/tests/kraken/driver.html?testName=imaging-darkroom) 00:52:37 INFO - PROCESS | 26104 | RSS: Main: 219852800 00:52:37 INFO - PROCESS | 26104 | 00:52:40 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56069/tests/kraken/driver.html?testName=imaging-desaturate) 00:52:41 INFO - PROCESS | 26104 | RSS: Main: 220192768 00:52:41 INFO - PROCESS | 26104 | 00:52:43 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56069/tests/kraken/driver.html?testName=json-parse-financial) 00:52:44 INFO - PROCESS | 26104 | RSS: Main: 221147136 00:52:44 INFO - PROCESS | 26104 | 00:52:46 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56069/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:52:46 INFO - PROCESS | 26104 | RSS: Main: 203165696 00:52:46 INFO - PROCESS | 26104 | 00:52:48 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:52:49 INFO - PROCESS | 26104 | RSS: Main: 208588800 00:52:49 INFO - PROCESS | 26104 | 00:52:51 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:52:51 INFO - PROCESS | 26104 | RSS: Main: 217038848 00:52:51 INFO - PROCESS | 26104 | 00:52:54 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:52:55 INFO - PROCESS | 26104 | RSS: Main: 223809536 00:52:55 INFO - PROCESS | 26104 | 00:52:57 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:52:58 INFO - PROCESS | 26104 | RSS: Main: 223715328 00:52:58 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | Cycle 1(1): loaded http://localhost:56069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56069/tests/kraken/driver.html?testName=ai-astar) 00:53:00 INFO - PROCESS | 26104 | RSS: Main: 266412032 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | __start_tp_report 00:53:00 INFO - PROCESS | 26104 | _x_x_mozilla_page_load 00:53:00 INFO - PROCESS | 26104 | _x_x_mozilla_page_load_details 00:53:00 INFO - PROCESS | 26104 | |i|pagename|runs| 00:53:00 INFO - PROCESS | 26104 | |0;ai-astar;110;105;111;110;111;111;110;109;108;110 00:53:00 INFO - PROCESS | 26104 | |1;audio-beat-detection;160;128;131;177;129;157;158;127;197;125 00:53:00 INFO - PROCESS | 26104 | |2;audio-dft;162;162;161;162;163;162;163;163;162;161 00:53:00 INFO - PROCESS | 26104 | |3;audio-fft;76;75;76;116;75;76;75;75;100;76 00:53:00 INFO - PROCESS | 26104 | |4;audio-oscillator;86;86;111;85;86;86;114;87;86;127 00:53:00 INFO - PROCESS | 26104 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 00:53:00 INFO - PROCESS | 26104 | |6;imaging-darkroom;147;147;147;146;146;146;145;146;146;145 00:53:00 INFO - PROCESS | 26104 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 00:53:00 INFO - PROCESS | 26104 | |8;json-parse-financial;56;54;54;53;54;55;52;52;54;55 00:53:00 INFO - PROCESS | 26104 | |9;json-stringify-tinderbox;63;63;63;63;63;63;64;64;64;64 00:53:00 INFO - PROCESS | 26104 | |10;stanford-crypto-aes;81;86;79;81;82;81;79;80;129;80 00:53:00 INFO - PROCESS | 26104 | |11;stanford-crypto-ccm;134;129;124;121;122;129;129;126;138;132 00:53:00 INFO - PROCESS | 26104 | |12;stanford-crypto-pbkdf2;159;163;159;161;160;159;165;162;161;163 00:53:00 INFO - PROCESS | 26104 | |13;stanford-crypto-sha256-iterative;68;63;65;64;63;65;62;62;62;65 00:53:00 INFO - PROCESS | 26104 | __end_tp_report 00:53:00 INFO - PROCESS | 26104 | __start_cc_report 00:53:00 INFO - PROCESS | 26104 | _x_x_mozilla_cycle_collect,1584 00:53:00 INFO - PROCESS | 26104 | __end_cc_report 00:53:00 INFO - PROCESS | 26104 | __startTimestamp1465026780262__endTimestamp 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | ------- Summary: start ------- 00:53:00 INFO - PROCESS | 26104 | Number of tests: 14 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 00:53:00 INFO - PROCESS | 26104 | Values: 110.0 105.0 111.0 110.0 111.0 111.0 110.0 109.0 108.0 110.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:157.50 stddev:24.90 (15.8%) stddev-sans-first:26.08 00:53:00 INFO - PROCESS | 26104 | Values: 160.0 128.0 131.0 177.0 129.0 157.0 158.0 127.0 197.0 125.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 00:53:00 INFO - PROCESS | 26104 | Values: 162.0 162.0 161.0 162.0 163.0 162.0 163.0 163.0 162.0 161.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:14.22 (18.8%) stddev-sans-first:14.92 00:53:00 INFO - PROCESS | 26104 | Values: 76.0 75.0 76.0 116.0 75.0 76.0 75.0 75.0 100.0 76.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:86.00 stddev:15.66 (18.2%) stddev-sans-first:16.24 00:53:00 INFO - PROCESS | 26104 | Values: 86.0 86.0 111.0 85.0 86.0 86.0 114.0 87.0 86.0 127.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 00:53:00 INFO - PROCESS | 26104 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 00:53:00 INFO - PROCESS | 26104 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:53:00 INFO - PROCESS | 26104 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:1.12 00:53:00 INFO - PROCESS | 26104 | Values: 56.0 54.0 54.0 53.0 54.0 55.0 52.0 52.0 54.0 55.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 00:53:00 INFO - PROCESS | 26104 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 64.0 64.0 64.0 64.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:81.00 stddev:15.31 (18.9%) stddev-sans-first:16.14 00:53:00 INFO - PROCESS | 26104 | Values: 81.0 86.0 79.0 81.0 82.0 81.0 79.0 80.0 129.0 80.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.00 stddev:5.36 (4.2%) stddev-sans-first:5.29 00:53:00 INFO - PROCESS | 26104 | Values: 134.0 129.0 124.0 121.0 122.0 129.0 129.0 126.0 138.0 132.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:2.04 (1.3%) stddev-sans-first:2.01 00:53:00 INFO - PROCESS | 26104 | Values: 159.0 163.0 159.0 161.0 160.0 159.0 165.0 162.0 161.0 163.0 00:53:00 INFO - PROCESS | 26104 | 00:53:00 INFO - PROCESS | 26104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.91 (3.0%) stddev-sans-first:1.33 00:53:00 INFO - PROCESS | 26104 | Values: 68.0 63.0 65.0 64.0 63.0 65.0 62.0 62.0 62.0 65.0 00:53:00 INFO - PROCESS | 26104 | -------- Summary: end -------- 00:53:00 INFO - PROCESS | 26104 | 00:53:01 INFO - TEST-INFO | 26104: exit 0 00:53:01 INFO - TEST-OK | kraken | took 61459ms 00:53:01 INFO - SUITE-END | took 1175s 00:53:01 INFO - Completed test suite (00:19:35) 00:53:01 INFO - javascript benchmark 00:53:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.5807465992084, 3105.829179395134, 3123.1099136746025, 3140.3405284890173, 3163.9209019774503, 5251.474852514747, 5353.170258609912, 5367.543758780504, 5467.91798123028, 5544.916826247604, 5382.757775900084, 5392.73036348183, 5410.269613602162, 5413.296271484702, 5445.945540544593, 4800.663953523246, 4873.1715608346485, 4877.463479017305, 4888.266759985995, 5044.924326135111, 4964.851054468371, 4978.825741099062, 5009.824656137036, 5019.472955339692, 5021.874453138683, 4783.091212669599, 4804.327394164819, 4863.610911127119, 4873.780679869396, 4892.119418504668, 4772.73749943753, 4799.3760811094335, 4850.320955066293, 4928.43323017854, 4960.107180707471, 4879.341288925985, 4884.975575122137, 4889.413270407538, 4906.9263961040615, 4914.090893184736, 5244.370675518962, 5274.630775845692, 5289.44460831611, 5321.707306098163, 5394.541463975567, 5774.4802967732685, 5808.157817116495, 5820.388859169769, 5822.854428639275, 5827.592068555203, 5845.85385365365, 5853.795117170878, 5856.121581762727, 5867.207926929896, 5874.9118763218585, 5334.359876814807, 5367.46325367464, 5405.37838148614, 5427.83716488506, 5455.18172274158, 5974.103884417372, 6021.217241758543, 6023.45788879003, 6025.879482410327, 6027.0, 5770.42295770428, 5772.365039845614, 5776.566757493205, 5778.3643799182055, 5782.277215348082, 5631.183478395692, 5717.685527295956, 5818.5054270386645, 5827.94172058274, 5864.501517371071, 5815.069588865761, 5832.533397328203, 5836.591438599342, 5838.4453476919625, 5839.445252700986, 5630.577706672016, 5824.097264923944, 5868.765249389977, 5869.941300587025, 5873.647581145145, 4320.870373888788, 4338.0239446125, 4375.146846364992, 4383.912321753611, 4404.55954404557, 3899.200663863901, 3904.375299951994, 3925.0776067624083, 3939.9015024624614, 3946.309395855771, 5379.65032272901, 5490.478404551562, 5519.31008623922, 5523.061079616475, 5523.861903452445, 5722.141678748138, 5791.710414479344, 5817.912731309034, 5843.883122337615, 5845.7369418376275, 5517.586181036439, 5521.944780552143, 5523.116301391758, 5525.889482210333, 5534.335879694382, 4880.414350277918, 5002.924956125661, 5009.423916249605, 5019.949800501949, 5061.898762024739, 5991.910121348184, 6021.0, 6080.209572755513, 6108.908366374508, 6118.847028824226, 5856.765729370777, 5859.707014649336, 5860.150278209721, 5868.2077919480325, 5872.794452194153, 5855.268091488564, 6042.0, 6047.606905551125, 6053.364396738455, 6057.1519987200945, 5752.367239603724, 5849.444302791228, 5849.707514624167, 5864.530837533072, 5900.173975643327, 5904.527637789052, 5918.3489816121055, 5930.52555795544, 5953.821385358447, 5965.403459654173, 5574.0, 5614.438556144353, 5691.14632805066, 5793.507551858139, 5795.420457954171, 5723.227364305765, 5767.480926716616, 5770.826875193751, 5773.422657734193, 5798.188253644409, 5629.662220266797, 5655.632383895034, 5664.291963504562, 5665.773369065356, 5672.376038635829, 5410.431904650112, 5525.281713377235, 5605.075162598288, 5686.175504551899, 5777.6822274775295, 5473.589480788877, 5478.972605136949, 5500.50495455411, 5565.471280228372, 5569.526590239713], "value": 5351.185947971867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1049352516549, 609.3997412548639, 624.9000159974402, 641.99679001605, 643.649211179907, 30934.53598196026, 31531.84234078829, 34113.317733645315, 34141.0, 42308.36537451933, 41125.17749645013, 46219.768901155534, 46247.306290405584, 46359.30461043087, 46409.0, 8727.51998640076, 8917.420367676114, 8922.197002269795, 8927.598258078402, 8934.28525717941, 8709.34679899007, 8853.867191992125, 8868.689595864145, 8869.290456763443, 8880.067592902717, 8911.10888911107, 8959.462432254053, 8973.10268973104, 8977.910220897773, 8996.235319997808, 8845.380823342337, 8859.114088591154, 8898.110188981114, 8899.15458031486, 8909.95545022274, 8688.131186881325, 8789.736307910773, 8792.648294068229, 8803.647854085893, 8816.955915220382, 39693.40459893104, 39908.80045599782, 40028.59971400307, 40158.79920600378, 40169.59830401688, 3506.2286297014616, 3601.117726157082, 3675.3935600625864, 3702.833372498244, 3916.236333914888, 31933.361332773213, 32112.518312225337, 32462.350752985043, 34032.6596734032, 34124.317513649585, 4356.0, 4399.868003959887, 4426.424564806554, 4434.091011342699, 4574.921006957317, 353039.0, 357241.9999999974, 360401.3658839002, 360689.0, 363009.0, 53787.0, 54255.45744542583, 54860.17709734357, 54883.45116548863, 54883.72558137184, 56311.0, 60701.39298607046, 61475.692621536604, 61715.38284617186, 62857.68571157115, 16616.6676666466, 16758.832411675972, 16785.748213776802, 16820.495385138467, 16824.242909068875, 11606.187566870407, 11630.302181869114, 11651.650450486499, 11654.53381864733, 11656.53373865036, 16140.435084771976, 16461.58846028835, 16465.58836029085, 17166.570835729206, 17851.910740446474, 6306.432421082033, 6542.672866356663, 6568.7372505099265, 6600.339966003361, 6684.665766711645, 974.6539978307741, 1047.5809676129609, 1095.90684791792, 1098.19282827122, 1164.778692048508, 32440.188995275308, 32745.34509309848, 32863.671363286536, 32889.17777055593, 33072.3385532288, 1135.3755434510986, 1190.2382475215868, 1192.1595275331044, 1203.8615559210803, 1215.4226742297337, 16781.0, 16990.320387184373, 17117.65764684724, 17277.56806079858, 17301.546340592045, 518019.0, 521041.0, 528659.0, 528778.0, 530625.0, 59043.114353284735, 59098.704506477196, 59190.11214831781, 59270.70364648149, 59300.703496483104, 1328.5947785925193, 1391.4921053815285, 1400.271858633505, 1401.2083173007015, 1402.6353148181342, 31487.685123149393, 32149.839250803598, 32378.514322285657, 32410.83794581012, 32848.69676095505, 52684.0, 52736.47263527316, 53144.734276328374, 53259.73370133279, 53293.0, 486187.0, 491924.0, 492105.0, 492238.5433019654, 493047.0, 31828.5225721619, 37363.43954840734, 37410.25179496449, 42579.361309581, 42990.35514467223, 42471.3629295567, 48994.265086024454, 49023.0, 49367.59486077117, 50768.0, 40491.595084048786, 41336.1732765349, 41399.7930010348, 41823.58176418197, 42064.0, 39602.5345622118, 40759.592404076764, 40982.1803563933, 41337.379939300336, 41493.377599336636, 40222.0, 40629.18741625092, 41985.0, 42044.78977605092, 42134.15731685288, 35670.64329356673, 36611.81694091512, 36822.63177368192, 37117.6288237125, 37188.44217336796, 27701.87139804487, 28196.85901570479, 28304.694225898245, 28316.15051548457, 28393.15752956275], "value": 20217.377055618443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1861451343328, 393.93303138466456, 394.52262762057927, 395.0597577764919, 420.97053206275575, 16148.0, 18557.16492757826, 18636.720449193257, 18701.101329293946, 19893.20427182911, 18638.161282742276, 18952.0, 19144.712829307537, 19319.13063912124, 19518.414447566596, 5559.861003474905, 5634.464725851038, 5696.601237913348, 5746.25298711169, 5746.7413966371405, 5540.085885828834, 5683.630564013347, 5691.8577035574235, 5693.231413759131, 5734.741936612862, 5475.151351540518, 5644.435556444343, 5654.830355089354, 5672.9432705672825, 5753.741081651336, 5731.0, 5786.103154011093, 5800.303963524383, 5812.244408226925, 5822.301323841145, 5480.561555075585, 5656.038473459522, 5702.372738998707, 5746.425357464262, 5755.971220143872, 13386.598402047954, 13467.730645387135, 13491.595252142451, 17199.312027518885, 19686.80313196864, 2269.8751568663715, 2377.465070359173, 2388.558116748407, 2408.783209511135, 2738.6713594368603, 10005.349652272651, 10851.891481085167, 13748.587542373745, 14178.149311041267, 14235.0, 1907.4754442528276, 1969.7833238343771, 2001.0695026812602, 2006.7892871248455, 2092.4664210626192, 69789.3021069793, 72197.27802721958, 75606.62196688981, 77271.0, 82216.65591736577, 10956.34261944286, 10972.561097556008, 11144.275622084539, 11169.27399719032, 11213.439328033566, 15222.847771522365, 15432.0, 15440.45958391451, 15523.84476155224, 15529.767053494206, 7796.220377962159, 7810.57041862703, 7873.330766884765, 7957.641906114239, 8017.318527925075, 7502.887456688154, 7578.772636820904, 7580.559693658187, 7690.615469226516, 7705.0, 4721.669483136147, 4752.263399173134, 4807.567318941312, 4817.855464336076, 4876.097921884463, 1883.5385330593817, 1916.28845184063, 1970.6748386516065, 1977.8022197780394, 2001.279539365827, 864.2394692670409, 939.8261321655516, 949.6438835436711, 1071.5553045486035, 1082.832161015044, 18251.81748182501, 19124.2350305989, 19381.321653742052, 19460.513487162934, 19686.606267874562, 975.2636759246724, 991.0782971836262, 1000.7548150703125, 1017.5726194998118, 1019.4749703902496, 10446.112080473093, 10743.020815721631, 10756.354618722746, 10825.880123616611, 10872.045233765879, 474763.0, 479844.0, 480048.0, 486577.0, 492654.0, 92671.0, 94592.0540794597, 94672.0, 94762.0, 95268.0, 986.6004268271362, 1003.7791685829106, 1013.2400699475394, 1019.1439191079529, 1020.9540570674337, 16674.583135421228, 16763.413280535122, 17101.74347384815, 17161.0, 17270.913645431694, 38205.80897095497, 39056.0, 39971.40042899301, 40445.0, 42083.36874946817, 54391.18413223726, 55946.44053559412, 57235.14147287877, 57250.141247880485, 57527.42472575221, 8154.510729356258, 8192.426530142833, 8586.914130858611, 8908.55457227123, 8968.910310896808, 12249.265044097383, 13057.151285166434, 13117.73764524685, 13737.931310343385, 13881.722365552834, 11402.600908968147, 11526.82709759371, 11620.6513804586, 11746.647600571996, 11879.643610691694, 11419.486123124314, 11528.942355288169, 11652.0, 11679.708007299545, 12350.938245308716, 11613.129015323715, 11735.882641173821, 11814.409279536161, 11827.586034488751, 12175.0, 7520.962395187989, 7726.961365193138, 8606.311495080254, 8654.82690346202, 8684.305255579664, 11108.833367499332, 11471.369074700639, 11584.47869845842, 11698.181127321346, 12019.399030048637], "value": 9114.257595950337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.0056536574425, 1496.8278647955485, 1539.99130569477, 1696.3723422333737, 1857.8978156201404, 8524.318054555637, 8819.647214111435, 8875.378723489366, 9274.953625231865, 9318.068193180696, 9089.40918840275, 9260.212881905047, 9267.675631352904, 9286.39638423502, 9299.95350023249, 2035.8676686015435, 2349.2482405630203, 2412.203972689017, 2412.6501657259773, 2441.438469152096, 2434.7808697217247, 2439.3901524618846, 2445.730969593343, 2446.633005049248, 2450.656908032877, 2424.781769640732, 2428.4293191100164, 2456.0298682020593, 2457.0785955266774, 2457.1031573475643, 2011.688188330811, 2284.7715228477186, 2345.1674655497395, 2354.0701422937846, 2377.9643305350432, 2401.6637670726113, 2410.0480310277517, 2427.368884090132, 2429.963550546743, 2433.9391515212083, 8930.776730581723, 8981.595828187681, 9002.0, 9006.639734410615, 9020.18818306349, 5306.151015837448, 5476.0, 5478.698671573062, 5479.506844383985, 5479.506844384025, 3237.7247933925646, 3301.8679252829857, 3359.260962588227, 3367.3097015111844, 3427.8286085695618, 1136.891995260449, 1138.1918837625296, 1147.1396452660504, 1152.2913408253946, 1157.3692337675986, 12835.679108022281, 12877.935610321889, 12886.1623994441, 12893.290869002201, 12894.871051289461, 4702.811887524529, 4744.952550474451, 4836.661433699677, 4839.2983017462975, 4879.609631229493, 10567.788644227072, 10663.946680266548, 10672.893271067345, 10713.928607139223, 10744.14046876248, 5461.699606521679, 5464.726763661801, 5465.6447330923365, 5466.890662186734, 5469.945300547023, 4237.851675191354, 4929.2359684248995, 5071.909539448962, 5075.264086707407, 5152.3044389007755, 4070.8778736637946, 4133.689973252018, 4137.606927341898, 4216.177845320194, 4219.156168766259, 1290.283892439705, 1313.8620444853152, 1321.3657444426728, 1321.9471221151045, 1328.7608230518406, 872.8530829111578, 929.4887811703536, 971.2812518736084, 972.8686627305365, 984.0012387426767, 5853.853653658693, 5975.92433361999, 6005.429484198994, 6023.216981792339, 6080.0, 450.59446498151925, 476.768767147933, 477.88769639134773, 481.8482178113883, 484.9379858110726, 3930.1746633207345, 4020.6582440492884, 4022.7586344819406, 4029.762818259675, 4108.0, 11136.10911127124, 11449.713757156138, 11584.47869845859, 11592.36242006681, 11592.594259200887, 11258.155638327158, 11453.198276120758, 11467.254628449124, 11470.655880323604, 11500.539978400937, 8265.710700125466, 8547.188017138486, 8549.572521373906, 8560.272376847914, 8590.527520986281, 5713.314402271754, 5760.193572899713, 5791.623544469596, 5804.94195058044, 5876.823695289148, 10471.528781205016, 10552.261341706315, 10553.736156596147, 10650.680479585624, 10660.200484963503, 10521.263511554118, 10817.675469735921, 10888.836667449836, 10934.671959841218, 10966.06788422993, 6911.170659520689, 7042.683079261548, 7069.151701795612, 8186.713465028695, 8235.29999950011, 7601.809954751176, 8516.0, 8795.252403545514, 8824.735257942271, 9059.773505662411, 7251.093613298338, 7264.055672762507, 7359.337659610661, 7502.962485187758, 7566.772996810105, 7400.777976660709, 7515.286047825448, 7561.2060733622175, 7593.620318984139, 7726.575038372944, 6808.319168083351, 6811.89782153278, 6861.862762744618, 6872.381485666314, 6879.380855723009, 5011.4236862761245, 5182.429932707324, 5289.3652761668845, 5290.100682883842, 5324.1747529133045, 4997.0505603935135, 5030.647854650286, 5053.444121146745, 5066.341375621146, 5112.923306150485], "value": 4633.7225669524305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5281667989756, 333.6763339560626, 341.32588138426604, 344.1516661429577, 347.15294680978394, 5268.420473747894, 5348.304720386354, 5377.327834020747, 5411.756470958807, 5417.052015897217, 4965.230389289657, 5080.491950804918, 5159.432462429139, 5220.6606570572885, 5229.712365819878, 4063.5123785145825, 4108.828983739635, 4121.896952576195, 4136.689748268885, 4140.648044916185, 4097.098638299584, 4117.485314335708, 4125.814338354766, 4144.979275103636, 4148.460700108997, 3896.5713771485116, 3987.680985521166, 4092.897677558055, 4138.13099249158, 4139.77231252281, 4074.7962601870086, 4083.0, 4086.6730661547003, 4097.160082183145, 4111.732737372061, 3677.3196958562485, 3684.428913518409, 3699.85200591976, 3704.4441334639514, 3713.1274150574595, 5024.392194497762, 5025.648204625678, 5028.446870844205, 5114.232865070232, 5151.227315902607, 4723.858284251478, 4738.526147385269, 4746.738929358884, 4767.093162734899, 4782.282657601353, 5504.4770746778995, 5517.5930137815, 5535.944640553583, 5547.55619550435, 5551.250581171531, 3883.9026925460216, 4019.4573732546023, 4031.488191928027, 4032.2338755636333, 4083.958590559418, 5647.830565083013, 5709.914351284734, 5722.768120433035, 5727.627704199255, 5740.8851822963725, 4124.731892426983, 4127.607877251657, 4146.875593732193, 4159.0, 4167.354060120686, 4049.6152865477734, 4176.686748493875, 4206.8527601534415, 4220.240356735817, 4226.260404429213, 4590.6557008223845, 4662.7202367858035, 4709.246520556694, 4721.15019296523, 4721.976390118096, 5422.7017514036315, 5486.451354864482, 5490.145124535219, 5543.390227075019, 5557.916631250535, 1365.603974847303, 1389.4442223110836, 1411.2026704911898, 1421.8933579981542, 1453.8182727159106, 929.8837645294338, 949.5110018340561, 950.8589692369185, 955.6511873166384, 958.750724811554, 4738.251813947971, 4738.407699037621, 4764.404449443819, 4772.069446457907, 4815.15734746418, 4969.527894849984, 4970.453250142481, 4992.179418628463, 5002.89994200114, 5017.222330538772, 4410.625096866738, 4745.549172828576, 4749.482774129648, 4776.966626192393, 4834.323194752737, 2684.717989708771, 2700.7569318761407, 2701.7973651975785, 2706.5114187196964, 2706.538469226635, 5148.382194136652, 5169.483051694876, 5177.249298851645, 5207.973960130251, 5233.586931528542, 4765.309030190603, 5064.316317297192, 5076.82231121909, 5103.97448012765, 5104.2088476286235, 5147.3308469898675, 5167.948320516822, 5172.27588137661, 5187.63686541946, 5193.792248310026, 4927.630427718007, 4954.727489988085, 4978.30303757467, 4994.825181118644, 5028.446870844277, 4864.078688917928, 4961.603071754179, 5075.4417014127675, 5268.2361057647195, 5726.141078838041, 5944.256967879015, 5952.404759524013, 5977.402259773988, 5982.192404025575, 5996.970015149896, 4092.9181416372103, 4127.215828992482, 4143.357779544175, 4144.854930077553, 4158.584141585939, 5382.381026182039, 5694.373618902, 5715.342735585461, 5732.9394062098645, 5853.795117170878, 5405.891882162414, 5568.415316391721, 5586.748596313095, 5593.636413633101, 5595.440455954372, 5530.861728456821, 5533.750981205936, 5544.7543744783425, 5554.583406244467, 5588.972055139699, 5281.366236051698, 5468.265867066467, 5498.992867603376, 5512.779488820563, 5545.889082218414, 5599.0, 5604.327480702342, 5609.915851262316, 5651.095824668033, 5670.574706896917, 5542.614346413397, 5549.38956714753, 5550.0, 5556.916646250229, 5561.527270181918], "value": 4119.65365631812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.5432249295409, 814.3525896911955, 844.7930257087014, 850.15409667381, 889.1641856654746, 14934.999999999987, 16132.0, 16178.919105404457, 16199.028058316495, 16213.189340532985, 14269.50056748014, 14312.642183945407, 14315.78526322106, 14318.140911545288, 14508.202048887308, 788.4362680683296, 799.0, 800.8598495263335, 801.286854699318, 802.8474589827944, 665.3213722003553, 781.9100803407596, 784.4077721320396, 784.8626490364192, 784.9882251766228, 848.1094850407079, 857.459800325797, 861.3238607692962, 862.038826708219, 862.65062649627, 848.2747251100313, 851.1105894340429, 852.3607294529103, 854.0647990450509, 855.2858363266648, 523.1629392971254, 605.2948315212772, 620.1813606040029, 621.7077973352517, 622.7726879688926, 14264.572062838131, 14292.285385730776, 14310.928445357811, 14326.0, 14367.568972930829, 13827.819601491612, 14192.219427931459, 14618.26908654563, 14699.926500367537, 14848.703025939529, 13058.869411305956, 13090.45878522784, 13165.341732913412, 13165.539206127836, 13407.396667150002, 4384.561543845622, 4498.977505112486, 4515.277555591089, 4575.9771201143785, 4667.529728135661, 74364.25635743627, 76037.61981190114, 76220.61889690516, 76347.23652763512, 76454.617726911, 10839.349639021684, 11465.254758440675, 11624.128190385754, 11795.0, 11810.114241431927, 20374.592508149755, 20971.685424718642, 21019.0, 21029.789702102782, 21040.0, 8356.582170891552, 8377.533931562075, 8379.62291696875, 8451.028131764802, 8559.272461840688, 4850.417949846041, 4990.9768497457935, 5050.77271522775, 5171.818986335536, 5301.3373328333955, 3498.370293347171, 3626.419772836386, 3627.891163265106, 3629.8185090745355, 3631.4915911772373, 642.3287664390723, 643.2184895352169, 644.7292137302344, 656.5240200854342, 665.2416245480157, 538.5422390967724, 555.3086407422704, 625.7309356976543, 629.6662768732579, 640.5132099604241, 8927.642894284156, 8931.687390941286, 9189.356745027917, 9220.953895230616, 9267.170881119697, 605.857623458487, 639.2467789890981, 640.3372509452694, 687.7592842505084, 716.698986425692, 4389.31965545341, 4394.406755088086, 4443.888902777457, 4524.6380289576755, 4600.723956562617, 116536.0, 127290.36354818166, 127894.0, 129414.0, 131855.0, 65559.67220163964, 75339.0, 103746.0, 107362.46318768512, 108917.0, 89210.55394722986, 92510.53744731234, 93035.0, 94987.52506237425, 95867.52066239624, 8694.608742606471, 8927.0, 9054.728358149267, 9120.680776172801, 9364.157225849705, 52944.73527632337, 53031.469685302654, 53275.0, 53954.73022634862, 54655.453445465035, 72923.63538182275, 77601.0, 78105.21894781207, 79192.60403697945, 79267.0, 10718.464076795974, 10912.727181820517, 11058.281211721212, 11100.777984440105, 11518.53925842957, 12225.796140168773, 12964.805527917277, 13025.283609401195, 13255.734885302047, 14018.088824226392, 11128.721781955515, 12491.500339986298, 12674.176178548365, 12905.0, 13015.154014988995, 13236.13965092266, 13284.667883302995, 13338.666533336744, 13421.261830599411, 13677.110987785762, 13066.803997939849, 13486.190828550318, 13876.444942202199, 14711.779323309946, 14740.778888316898, 11355.824442192737, 11414.258073225214, 11538.538458461904, 11594.826077608674, 11633.47649355764, 11154.49804758804, 11642.359670218219, 11756.412179390825, 11944.343061131722, 12054.578089766816], "value": 7515.974844661504, "unit": "score"}], "name": "dromaeo_css", "value": 7218.601569234863, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 111.0, 111.0, 110.0, 109.0, 108.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 131.0, 177.0, 129.0, 157.0, 158.0, 127.0, 197.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 116.0, 75.0, 76.0, 75.0, 75.0, 100.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 111.0, 85.0, 86.0, 86.0, 114.0, 87.0, 86.0, 127.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 53.0, 54.0, 55.0, 52.0, 52.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 79.0, 81.0, 82.0, 81.0, 79.0, 80.0, 129.0, 80.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 124.0, 121.0, 122.0, 129.0, 129.0, 126.0, 138.0, 132.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 159.0, 161.0, 160.0, 159.0, 165.0, 162.0, 161.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 65.0, 64.0, 63.0, 65.0, 62.0, 62.0, 62.0, 65.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1512.5000000000002, "alertThreshold": 2.0}]} 00:53:01 INFO - Return code: 0 00:53:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:53:01 ERROR - # TBPL SUCCESS # 00:53:01 INFO - Running post-action listener: _resource_record_post_action 00:53:01 INFO - ##### 00:53:01 INFO - ##### Finished run-tests step (success) 00:53:01 INFO - ##### 00:53:01 INFO - Running post-run listener: _resource_record_post_run 00:53:01 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 540200960; Read time: 184; Write time: 531600 00:53:01 INFO - TinderboxPrint: CPU usage
13.2% 00:53:01 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 00:53:01 INFO - TinderboxPrint: I/O write bytes / time
540,200,960 / 531,600 00:53:01 INFO - TinderboxPrint: CPU idle
8,268.7 (86.8%) 00:53:01 INFO - TinderboxPrint: CPU user
1,211.2 (12.7%) 00:53:01 INFO - TinderboxPrint: Swap in / out
0 / 0 00:53:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247754752; Read time: 0; Write time: 313432 00:53:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291631104; Read time: 184; Write time: 218132 00:53:02 INFO - Running post-run listener: _upload_blobber_files 00:53:02 INFO - Blob upload gear active. 00:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:53:02 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 00:53:02 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'] 00:53:02 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 00:53:02 INFO - (blobuploader) - INFO - Open directory for files ... 00:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:06 INFO - (blobuploader) - INFO - Done attempting. 00:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:07 INFO - (blobuploader) - INFO - Done attempting. 00:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:07 INFO - (blobuploader) - INFO - Done attempting. 00:53:07 INFO - (blobuploader) - INFO - Iteration through files over. 00:53:07 INFO - Return code: 0 00:53:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:53:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:53:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4975b298bc33322e68eb90a7aa3113309a69744534d1a91fb132b5eda46a22557caa61fa58ea48a5e5f80c061cce0b79142f0cd3b2ca79f4e00f2471eabc193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4836825bee755bf5254c545493900c3c63263f9b6d04183e4b05eceeaa9cd82b04cf6c08a982e7cf6548b37e89753435232f048e64ed68373d36c1dbfee5da73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f9bd65dd53e4c55563140bbb48cf0038edfc411ee9a895dfc3fe9db4e5b47ceae79f65253a4dc7bc3cd2041caa0b1b1bdcc2b33f2917f0b194770c105f3fdf9"} 00:53:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:53:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:53:07 INFO - Contents: 00:53:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4975b298bc33322e68eb90a7aa3113309a69744534d1a91fb132b5eda46a22557caa61fa58ea48a5e5f80c061cce0b79142f0cd3b2ca79f4e00f2471eabc193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4836825bee755bf5254c545493900c3c63263f9b6d04183e4b05eceeaa9cd82b04cf6c08a982e7cf6548b37e89753435232f048e64ed68373d36c1dbfee5da73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f9bd65dd53e4c55563140bbb48cf0038edfc411ee9a895dfc3fe9db4e5b47ceae79f65253a4dc7bc3cd2041caa0b1b1bdcc2b33f2917f0b194770c105f3fdf9"} 00:53:07 INFO - Running post-run listener: copy_logs_to_upload_dir 00:53:07 INFO - Copying logs to upload dir... 00:53:07 INFO - mkdir: /builds/slave/test/build/upload/logs 00:53:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.990498 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-04 00:53:06.977916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 00:53:06.981981) ========= 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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4975b298bc33322e68eb90a7aa3113309a69744534d1a91fb132b5eda46a22557caa61fa58ea48a5e5f80c061cce0b79142f0cd3b2ca79f4e00f2471eabc193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4836825bee755bf5254c545493900c3c63263f9b6d04183e4b05eceeaa9cd82b04cf6c08a982e7cf6548b37e89753435232f048e64ed68373d36c1dbfee5da73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f9bd65dd53e4c55563140bbb48cf0038edfc411ee9a895dfc3fe9db4e5b47ceae79f65253a4dc7bc3cd2041caa0b1b1bdcc2b33f2917f0b194770c105f3fdf9"} build_url:https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/ImLOxGdMQyGOYMeTxp0Egw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4975b298bc33322e68eb90a7aa3113309a69744534d1a91fb132b5eda46a22557caa61fa58ea48a5e5f80c061cce0b79142f0cd3b2ca79f4e00f2471eabc193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4836825bee755bf5254c545493900c3c63263f9b6d04183e4b05eceeaa9cd82b04cf6c08a982e7cf6548b37e89753435232f048e64ed68373d36c1dbfee5da73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f9bd65dd53e4c55563140bbb48cf0038edfc411ee9a895dfc3fe9db4e5b47ceae79f65253a4dc7bc3cd2041caa0b1b1bdcc2b33f2917f0b194770c105f3fdf9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 00:53:07.007006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:53:07.007323) ========= 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=52faae308a556c440401f8e5000001e8-1465021565.671599-1879193547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 00:53:07.089538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 00:53:07.089858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 00:53:07.090169) ========= ========= Total master_lag: 0.16 =========