builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1466625736.7 results: success (0) buildid: 20160622103005 builduid: 10836223ccf84b2a8620c7f04f7b2919 revision: fdd1161f445604e720214966a7eaed8e7833ad9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.704771) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.705277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.705572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.737648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.737936) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 13:02:16-- 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-22 13:02:17 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121175 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.874383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.874672) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015922 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.928622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:16.928962) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fdd1161f445604e720214966a7eaed8e7833ad9e --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 fdd1161f445604e720214966a7eaed8e7833ad9e --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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 13:02:17,134 truncating revision to first 12 chars 2016-06-22 13:02:17,134 Setting DEBUG logging. 2016-06-22 13:02:17,134 attempt 1/10 2016-06-22 13:02:17,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fdd1161f4456?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 13:02:17,650 unpacking tar archive at: mozilla-inbound-fdd1161f4456/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:17.806664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:17.807183) ========= script_repo_revision: fdd1161f445604e720214966a7eaed8e7833ad9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:17.807627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:17.807986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 13:02:17.817609) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-22 13:02:17.817962) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:02:18 INFO - MultiFileLogger online at 20160622 13:02:18 in /builds/slave/test 13:02:18 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 13:02:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:02:18 INFO - {'append_to_log': False, 13:02:18 INFO - 'base_work_dir': '/builds/slave/test', 13:02:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:02:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:02:18 INFO - 'branch': 'Mozilla-Inbound', 13:02:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:02:18 INFO - 'config_files': ('talos/linux_config.py',), 13:02:18 INFO - 'default_actions': ('clobber', 13:02:18 INFO - 'read-buildbot-config', 13:02:18 INFO - 'download-and-extract', 13:02:18 INFO - 'populate-webroot', 13:02:18 INFO - 'create-virtualenv', 13:02:18 INFO - 'install', 13:02:18 INFO - 'run-tests'), 13:02:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:02:18 INFO - 'download_minidump_stackwalk': True, 13:02:18 INFO - 'download_symbols': 'ondemand', 13:02:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:02:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:02:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:02:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:02:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:02:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:02:18 INFO - 'installer_path': 'installer.exe', 13:02:18 INFO - 'log_level': 'info', 13:02:18 INFO - 'log_name': 'talos', 13:02:18 INFO - 'log_to_console': True, 13:02:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:02:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:02:18 INFO - 'opt_config_files': (), 13:02:18 INFO - 'pip_index': False, 13:02:18 INFO - 'sps_profile': False, 13:02:18 INFO - 'sps_profile_interval': 0, 13:02:18 INFO - 'suite': 'dromaeojs', 13:02:18 INFO - 'system_bits': '32', 13:02:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:18 INFO - 'title': 'talos-linux64-ix-012', 13:02:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:02:18 INFO - 'use_talos_json': True, 13:02:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:02:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:02:18 INFO - 'work_dir': 'build'} 13:02:18 INFO - ##### 13:02:18 INFO - ##### Running clobber step. 13:02:18 INFO - ##### 13:02:18 INFO - Running pre-action listener: _resource_record_pre_action 13:02:18 INFO - Running main action method: clobber 13:02:18 INFO - rmtree: /builds/slave/test/build 13:02:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:02:18 INFO - Running post-action listener: _resource_record_post_action 13:02:18 INFO - ##### 13:02:18 INFO - ##### Finished clobber step (success) 13:02:18 INFO - ##### 13:02:18 INFO - ##### 13:02:18 INFO - ##### Running read-buildbot-config step. 13:02:18 INFO - ##### 13:02:18 INFO - Running pre-action listener: _resource_record_pre_action 13:02:18 INFO - Running main action method: read_buildbot_config 13:02:18 INFO - Using buildbot properties: 13:02:18 INFO - { 13:02:18 INFO - "project": "", 13:02:18 INFO - "product": "firefox", 13:02:18 INFO - "script_repo_revision": "production", 13:02:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:02:18 INFO - "repository": "", 13:02:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:02:18 INFO - "buildid": "20160622103005", 13:02:18 INFO - "pgo_build": "True", 13:02:18 INFO - "basedir": "/builds/slave/test", 13:02:18 INFO - "buildnumber": 1969, 13:02:18 INFO - "slavename": "talos-linux64-ix-012", 13:02:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:02:18 INFO - "platform": "ubuntu64_hw", 13:02:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:02:18 INFO - "branch": "mozilla-inbound", 13:02:18 INFO - "repo_path": "integration/mozilla-inbound", 13:02:18 INFO - "revision": "fdd1161f445604e720214966a7eaed8e7833ad9e", 13:02:18 INFO - "stage_platform": "linux64-pgo", 13:02:18 INFO - "builduid": "10836223ccf84b2a8620c7f04f7b2919", 13:02:18 INFO - "slavebuilddir": "test" 13:02:18 INFO - } 13:02:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:02:18 INFO - Running post-action listener: _resource_record_post_action 13:02:18 INFO - ##### 13:02:18 INFO - ##### Finished read-buildbot-config step (success) 13:02:18 INFO - ##### 13:02:18 INFO - ##### 13:02:18 INFO - ##### Running download-and-extract step. 13:02:18 INFO - ##### 13:02:18 INFO - Running pre-action listener: _resource_record_pre_action 13:02:18 INFO - Running main action method: download_and_extract 13:02:18 INFO - mkdir: /builds/slave/test/build/tests 13:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:18 INFO - https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:02:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:02:19 INFO - Downloaded 1361 bytes. 13:02:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:19 INFO - Using the following test package requirements: 13:02:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:02:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:02:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'jsshell-linux-x86_64.zip'], 13:02:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:02:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:02:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:02:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:02:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:02:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:19 INFO - https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:02:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:21 INFO - Downloaded 24269733 bytes. 13:02:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:02:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:02:23 INFO - Return code: 0 13:02:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:23 INFO - https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:30 INFO - Downloaded 24269733 bytes. 13:02:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:02:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:02:31 INFO - Return code: 0 13:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:31 INFO - https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:02:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:02:32 INFO - Downloaded 14405384 bytes. 13:02:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:02:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:02:32 INFO - Return code: 0 13:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:32 INFO - https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:02:34 INFO - Downloaded 60136571 bytes. 13:02:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:34 INFO - mkdir: /builds/slave/test/properties 13:02:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:34 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:34 INFO - Contents: 13:02:34 INFO - build_url:https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:34 INFO - Running post-action listener: _resource_record_post_action 13:02:34 INFO - Running post-action listener: set_extra_try_arguments 13:02:34 INFO - ##### 13:02:34 INFO - ##### Finished download-and-extract step (success) 13:02:34 INFO - ##### 13:02:34 INFO - ##### 13:02:34 INFO - ##### Running populate-webroot step. 13:02:34 INFO - ##### 13:02:34 INFO - Running pre-action listener: _resource_record_pre_action 13:02:34 INFO - Running main action method: populate_webroot 13:02:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:34 INFO - '--tppagecycles', 13:02:34 INFO - '7'], 13:02:34 INFO - 'tests': ['tsvgm']}}, 13:02:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:02:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:02:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:02:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['damp', 'tps']}, 13:02:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'tests': ['damp', 'tps']}, 13:02:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['dromaeo_dom']}, 13:02:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['basic_compositor_video']}, 13:02:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:02:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'other-e10s': {'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['a11yr', 13:02:34 INFO - 'ts_paint', 13:02:34 INFO - 'tpaint', 13:02:34 INFO - 'sessionrestore', 13:02:34 INFO - 'sessionrestore_no_auto_restore', 13:02:34 INFO - 'tabpaint']}, 13:02:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['tsvgx', 13:02:34 INFO - 'tsvgr_opacity', 13:02:34 INFO - 'tart', 13:02:34 INFO - 'tscrollx', 13:02:34 INFO - 'cart']}, 13:02:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:02:34 INFO - 'tsvgr_opacity', 13:02:34 INFO - 'tart', 13:02:34 INFO - 'tscrollx', 13:02:34 INFO - 'cart']}, 13:02:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'talos_options': ['--disable-e10s'], 13:02:34 INFO - 'tests': ['tp5o']}, 13:02:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'tests': ['tp5o']}, 13:02:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'talos_options': ['--disable-e10s', 13:02:34 INFO - '--xperf_path', 13:02:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:34 INFO - 'tests': ['tp5n']}, 13:02:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:34 INFO - 'talos_options': ['--xperf_path', 13:02:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:34 INFO - 'tests': ['tp5n']}}, 13:02:34 INFO - 'talos.zip': {'path': '', 13:02:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:34 INFO - Running post-action listener: _resource_record_post_action 13:02:34 INFO - ##### 13:02:34 INFO - ##### Finished populate-webroot step (success) 13:02:34 INFO - ##### 13:02:34 INFO - ##### 13:02:34 INFO - ##### Running create-virtualenv step. 13:02:34 INFO - ##### 13:02:34 INFO - Running pre-action listener: _resource_record_pre_action 13:02:34 INFO - Running main action method: create_virtualenv 13:02:34 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:34 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 13:02:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:35 INFO - Using real prefix '/usr' 13:02:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:37 INFO - Installing pip.................done. 13:02:37 INFO - Return code: 0 13:02:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:02:37 INFO - Using env: {'DISPLAY': ':0', 13:02:37 INFO - 'HOME': '/home/cltbld', 13:02:37 INFO - 'LANG': 'en_US.UTF-8', 13:02:37 INFO - 'LANGUAGE': 'en_US:en', 13:02:37 INFO - 'LOGNAME': 'cltbld', 13:02:37 INFO - 'MAIL': '/var/mail/cltbld', 13:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:37 INFO - 'MOZ_NO_REMOTE': '1', 13:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:37 INFO - 'NO_EM_RESTART': '1', 13:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:37 INFO - 'PWD': '/builds/slave/test', 13:02:37 INFO - 'SHELL': '/bin/bash', 13:02:37 INFO - 'SHLVL': '1', 13:02:37 INFO - 'TERM': 'linux', 13:02:37 INFO - 'TMOUT': '86400', 13:02:37 INFO - 'USER': 'cltbld', 13:02:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:37 INFO - '_': '/tools/buildbot/bin/python'} 13:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:37 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 13:02:37 INFO - Cleaning up... 13:02:37 INFO - Return code: 0 13:02:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:02:37 INFO - Using env: {'DISPLAY': ':0', 13:02:37 INFO - 'HOME': '/home/cltbld', 13:02:37 INFO - 'LANG': 'en_US.UTF-8', 13:02:37 INFO - 'LANGUAGE': 'en_US:en', 13:02:37 INFO - 'LOGNAME': 'cltbld', 13:02:37 INFO - 'MAIL': '/var/mail/cltbld', 13:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:37 INFO - 'MOZ_NO_REMOTE': '1', 13:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:37 INFO - 'NO_EM_RESTART': '1', 13:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:37 INFO - 'PWD': '/builds/slave/test', 13:02:37 INFO - 'SHELL': '/bin/bash', 13:02:37 INFO - 'SHLVL': '1', 13:02:37 INFO - 'TERM': 'linux', 13:02:37 INFO - 'TMOUT': '86400', 13:02:37 INFO - 'USER': 'cltbld', 13:02:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:37 INFO - '_': '/tools/buildbot/bin/python'} 13:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:37 INFO - Downloading/unpacking psutil>=3.1.1 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:39 INFO - Installing collected packages: psutil 13:02:39 INFO - Running setup.py install for psutil 13:02:40 INFO - building 'psutil._psutil_linux' extension 13:02:40 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 13:02:40 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 13:02:40 INFO - building 'psutil._psutil_posix' extension 13:02:40 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 13:02:40 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 13:02:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:40 INFO - Successfully installed psutil 13:02:40 INFO - Cleaning up... 13:02:40 INFO - Return code: 0 13:02:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:02:40 INFO - Using env: {'DISPLAY': ':0', 13:02:40 INFO - 'HOME': '/home/cltbld', 13:02:40 INFO - 'LANG': 'en_US.UTF-8', 13:02:40 INFO - 'LANGUAGE': 'en_US:en', 13:02:40 INFO - 'LOGNAME': 'cltbld', 13:02:40 INFO - 'MAIL': '/var/mail/cltbld', 13:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:40 INFO - 'MOZ_NO_REMOTE': '1', 13:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:40 INFO - 'NO_EM_RESTART': '1', 13:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:40 INFO - 'PWD': '/builds/slave/test', 13:02:40 INFO - 'SHELL': '/bin/bash', 13:02:40 INFO - 'SHLVL': '1', 13:02:40 INFO - 'TERM': 'linux', 13:02:40 INFO - 'TMOUT': '86400', 13:02:40 INFO - 'USER': 'cltbld', 13:02:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:40 INFO - '_': '/tools/buildbot/bin/python'} 13:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:02:42 INFO - Installing collected packages: mozsystemmonitor 13:02:42 INFO - Running setup.py install for mozsystemmonitor 13:02:42 INFO - Successfully installed mozsystemmonitor 13:02:42 INFO - Cleaning up... 13:02:42 INFO - Return code: 0 13:02:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:02:42 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')]} 13:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:42 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')]} 13:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:42 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:42 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 13:02:42 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 13:02:42 INFO - Using env: {'DISPLAY': ':0', 13:02:42 INFO - 'HOME': '/home/cltbld', 13:02:42 INFO - 'LANG': 'en_US.UTF-8', 13:02:42 INFO - 'LANGUAGE': 'en_US:en', 13:02:42 INFO - 'LOGNAME': 'cltbld', 13:02:42 INFO - 'MAIL': '/var/mail/cltbld', 13:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:42 INFO - 'MOZ_NO_REMOTE': '1', 13:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:42 INFO - 'NO_EM_RESTART': '1', 13:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:42 INFO - 'PWD': '/builds/slave/test', 13:02:42 INFO - 'SHELL': '/bin/bash', 13:02:42 INFO - 'SHLVL': '1', 13:02:42 INFO - 'TERM': 'linux', 13:02:42 INFO - 'TMOUT': '86400', 13:02:42 INFO - 'USER': 'cltbld', 13:02:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:42 INFO - '_': '/tools/buildbot/bin/python'} 13:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:43 INFO - Downloading/unpacking jsonschema==2.5.1 13:02:43 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 13:02:43 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 13:02:43 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 13:02:43 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 13:02:43 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 13:02:43 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 13:02:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:45 INFO - warning: no files found matching '*.txt' 13:02:45 INFO - no previously-included directories found matching 'build' 13:02:45 INFO - no previously-included directories found matching 'dist' 13:02:45 INFO - no previously-included directories found matching '.git*' 13:02:45 INFO - Installing collected packages: jsonschema, functools32 13:02:45 INFO - Running setup.py install for functools32 13:02:45 INFO - warning: no files found matching '*.txt' 13:02:45 INFO - no previously-included directories found matching 'build' 13:02:45 INFO - no previously-included directories found matching 'dist' 13:02:45 INFO - no previously-included directories found matching '.git*' 13:02:45 INFO - Successfully installed jsonschema functools32 13:02:45 INFO - Cleaning up... 13:02:45 INFO - Return code: 0 13:02:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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', '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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:02: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 blobuploader==1.2.4 13:02:45 INFO - Using env: {'DISPLAY': ':0', 13:02:45 INFO - 'HOME': '/home/cltbld', 13:02:45 INFO - 'LANG': 'en_US.UTF-8', 13:02:45 INFO - 'LANGUAGE': 'en_US:en', 13:02:45 INFO - 'LOGNAME': 'cltbld', 13:02:45 INFO - 'MAIL': '/var/mail/cltbld', 13:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:45 INFO - 'MOZ_NO_REMOTE': '1', 13:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:45 INFO - 'NO_EM_RESTART': '1', 13:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:45 INFO - 'PWD': '/builds/slave/test', 13:02:45 INFO - 'SHELL': '/bin/bash', 13:02:45 INFO - 'SHLVL': '1', 13:02:45 INFO - 'TERM': 'linux', 13:02:45 INFO - 'TMOUT': '86400', 13:02:45 INFO - 'USER': 'cltbld', 13:02:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:45 INFO - '_': '/tools/buildbot/bin/python'} 13:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:02:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:47 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 13:02:48 INFO - Downloading docopt-0.6.1.tar.gz 13:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:48 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:48 INFO - Running setup.py install for blobuploader 13:02:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:02:48 INFO - Running setup.py install for requests 13:02:48 INFO - Running setup.py install for docopt 13:02:48 INFO - Successfully installed blobuploader requests docopt 13:02:48 INFO - Cleaning up... 13:02:48 INFO - Return code: 0 13:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:48 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:48 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 13:02:48 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 13:02:48 INFO - Using env: {'DISPLAY': ':0', 13:02:48 INFO - 'HOME': '/home/cltbld', 13:02:48 INFO - 'LANG': 'en_US.UTF-8', 13:02:48 INFO - 'LANGUAGE': 'en_US:en', 13:02:48 INFO - 'LOGNAME': 'cltbld', 13:02:48 INFO - 'MAIL': '/var/mail/cltbld', 13:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:48 INFO - 'MOZ_NO_REMOTE': '1', 13:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:48 INFO - 'NO_EM_RESTART': '1', 13:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:48 INFO - 'PWD': '/builds/slave/test', 13:02:48 INFO - 'SHELL': '/bin/bash', 13:02:48 INFO - 'SHLVL': '1', 13:02:48 INFO - 'TERM': 'linux', 13:02:48 INFO - 'TMOUT': '86400', 13:02:48 INFO - 'USER': 'cltbld', 13:02:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:48 INFO - '_': '/tools/buildbot/bin/python'} 13:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:49 INFO - Running setup.py (path:/tmp/pip-nWxXeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:49 INFO - Running setup.py (path:/tmp/pip-cKaE0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:49 INFO - Running setup.py (path:/tmp/pip-htgyIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:49 INFO - Running setup.py (path:/tmp/pip-oMO0yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:49 INFO - Running setup.py (path:/tmp/pip-z4XxFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:49 INFO - Running setup.py (path:/tmp/pip-faTuLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:49 INFO - Running setup.py (path:/tmp/pip-wTVGbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:49 INFO - Running setup.py (path:/tmp/pip-f8V6oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:49 INFO - Running setup.py (path:/tmp/pip-5Njm3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:49 INFO - Running setup.py (path:/tmp/pip-k59dVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:49 INFO - Running setup.py (path:/tmp/pip-Oz0xvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:49 INFO - Running setup.py (path:/tmp/pip-KtJ5xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:49 INFO - Running setup.py (path:/tmp/pip-RrE7Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:50 INFO - Running setup.py (path:/tmp/pip-pT7RUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:50 INFO - Running setup.py (path:/tmp/pip-0Lbkdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:50 INFO - Running setup.py (path:/tmp/pip-02H0Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:50 INFO - Running setup.py (path:/tmp/pip-Jls9Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:50 INFO - Running setup.py install for manifestparser 13:02:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:02:50 INFO - Running setup.py install for mozcrash 13:02:50 INFO - Running setup.py install for mozdebug 13:02:50 INFO - Running setup.py install for mozdevice 13:02:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:02:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:02:50 INFO - Running setup.py install for mozfile 13:02:50 INFO - Running setup.py install for mozhttpd 13:02:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:02:50 INFO - Running setup.py install for mozinfo 13:02:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for mozInstall 13:02:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for mozleak 13:02:51 INFO - Running setup.py install for mozlog 13:02:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for moznetwork 13:02:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for mozprocess 13:02:51 INFO - Running setup.py install for mozprofile 13:02:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for mozrunner 13:02:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:02:51 INFO - Running setup.py install for mozscreenshot 13:02:51 INFO - Running setup.py install for moztest 13:02:52 INFO - Running setup.py install for mozversion 13:02:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:02:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:52 INFO - Cleaning up... 13:02:52 INFO - Return code: 0 13:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:52 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:52 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 13:02:52 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 13:02:52 INFO - Using env: {'DISPLAY': ':0', 13:02:52 INFO - 'HOME': '/home/cltbld', 13:02:52 INFO - 'LANG': 'en_US.UTF-8', 13:02:52 INFO - 'LANGUAGE': 'en_US:en', 13:02:52 INFO - 'LOGNAME': 'cltbld', 13:02:52 INFO - 'MAIL': '/var/mail/cltbld', 13:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:52 INFO - 'MOZ_NO_REMOTE': '1', 13:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:52 INFO - 'NO_EM_RESTART': '1', 13:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:52 INFO - 'PWD': '/builds/slave/test', 13:02:52 INFO - 'SHELL': '/bin/bash', 13:02:52 INFO - 'SHLVL': '1', 13:02:52 INFO - 'TERM': 'linux', 13:02:52 INFO - 'TMOUT': '86400', 13:02:52 INFO - 'USER': 'cltbld', 13:02:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:52 INFO - '_': '/tools/buildbot/bin/python'} 13:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:52 INFO - Running setup.py (path:/tmp/pip-3ikwlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:52 INFO - Running setup.py (path:/tmp/pip-XNtekv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:52 INFO - Running setup.py (path:/tmp/pip-ol1ErU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:52 INFO - Running setup.py (path:/tmp/pip-4rzMT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:52 INFO - Running setup.py (path:/tmp/pip-4zFxgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:52 INFO - Running setup.py (path:/tmp/pip-k1JKNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:52 INFO - Running setup.py (path:/tmp/pip-1uKBzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:52 INFO - Running setup.py (path:/tmp/pip-FtJFqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:52 INFO - Running setup.py (path:/tmp/pip-3NmTR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:52 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)) 13:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:53 INFO - Running setup.py (path:/tmp/pip-2R3KCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:53 INFO - Running setup.py (path:/tmp/pip-lgZc7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:53 INFO - Running setup.py (path:/tmp/pip-9REFDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:53 INFO - Running setup.py (path:/tmp/pip-6rQIVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:53 INFO - Running setup.py (path:/tmp/pip-sfauMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:53 INFO - Running setup.py (path:/tmp/pip-1Trh9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:53 INFO - Running setup.py (path:/tmp/pip-aZrPyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:53 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)) 13:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:53 INFO - Running setup.py (path:/tmp/pip-XJ48Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:53 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)) 13:02:53 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)) 13:02:53 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)) 13:02:53 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)) 13:02:53 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)) 13:02:53 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)) 13:02:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:55 INFO - Downloading blessings-1.6.tar.gz 13:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:55 INFO - Installing collected packages: blessings 13:02:55 INFO - Running setup.py install for blessings 13:02:55 INFO - Successfully installed blessings 13:02:55 INFO - Cleaning up... 13:02:55 INFO - Return code: 0 13:02:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:02:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:55 INFO - Reading from file tmpfile_stdout 13:02:55 INFO - Current package versions: 13:02:55 INFO - argparse == 1.2.1 13:02:55 INFO - blessings == 1.6 13:02:55 INFO - blobuploader == 1.2.4 13:02:55 INFO - docopt == 0.6.1 13:02:55 INFO - functools32 == 3.2.3-2 13:02:55 INFO - jsonschema == 2.5.1 13:02:55 INFO - manifestparser == 1.1 13:02:55 INFO - mozInstall == 1.12 13:02:55 INFO - mozcrash == 0.17 13:02:55 INFO - mozdebug == 0.1 13:02:55 INFO - mozdevice == 0.48 13:02:55 INFO - mozfile == 1.2 13:02:55 INFO - mozhttpd == 0.7 13:02:55 INFO - mozinfo == 0.9 13:02:55 INFO - mozleak == 0.1 13:02:55 INFO - mozlog == 3.2 13:02:55 INFO - moznetwork == 0.27 13:02:55 INFO - mozprocess == 0.22 13:02:55 INFO - mozprofile == 0.28 13:02:55 INFO - mozrunner == 6.11 13:02:55 INFO - mozscreenshot == 0.1 13:02:55 INFO - mozsystemmonitor == 0.3 13:02:55 INFO - moztest == 0.7 13:02:55 INFO - mozversion == 1.4 13:02:55 INFO - psutil == 3.1.1 13:02:55 INFO - requests == 1.2.3 13:02:55 INFO - wsgiref == 0.1.2 13:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:55 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:55 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 13:02:55 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 13:02:55 INFO - Using env: {'DISPLAY': ':0', 13:02:55 INFO - 'HOME': '/home/cltbld', 13:02:55 INFO - 'LANG': 'en_US.UTF-8', 13:02:55 INFO - 'LANGUAGE': 'en_US:en', 13:02:55 INFO - 'LOGNAME': 'cltbld', 13:02:55 INFO - 'MAIL': '/var/mail/cltbld', 13:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:55 INFO - 'MOZ_NO_REMOTE': '1', 13:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:55 INFO - 'NO_EM_RESTART': '1', 13:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:55 INFO - 'PWD': '/builds/slave/test', 13:02:55 INFO - 'SHELL': '/bin/bash', 13:02:55 INFO - 'SHLVL': '1', 13:02:55 INFO - 'TERM': 'linux', 13:02:55 INFO - 'TMOUT': '86400', 13:02:55 INFO - 'USER': 'cltbld', 13:02:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:55 INFO - '_': '/tools/buildbot/bin/python'} 13:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 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)) 13:02:56 INFO - Cleaning up... 13:02:56 INFO - Return code: 0 13:02:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:56 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:56 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 13:02:56 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 13:02:56 INFO - Using env: {'DISPLAY': ':0', 13:02:56 INFO - 'HOME': '/home/cltbld', 13:02:56 INFO - 'LANG': 'en_US.UTF-8', 13:02:56 INFO - 'LANGUAGE': 'en_US:en', 13:02:56 INFO - 'LOGNAME': 'cltbld', 13:02:56 INFO - 'MAIL': '/var/mail/cltbld', 13:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:56 INFO - 'MOZ_NO_REMOTE': '1', 13:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:56 INFO - 'NO_EM_RESTART': '1', 13:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:56 INFO - 'PWD': '/builds/slave/test', 13:02:56 INFO - 'SHELL': '/bin/bash', 13:02:56 INFO - 'SHLVL': '1', 13:02:56 INFO - 'TERM': 'linux', 13:02:56 INFO - 'TMOUT': '86400', 13:02:56 INFO - 'USER': 'cltbld', 13:02:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:56 INFO - '_': '/tools/buildbot/bin/python'} 13:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:02:56 INFO - Cleaning up... 13:02:56 INFO - Return code: 0 13:02:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:56 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 0x7f82d631cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', '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 13:02:56 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 13:02:56 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 13:02:56 INFO - Using env: {'DISPLAY': ':0', 13:02:56 INFO - 'HOME': '/home/cltbld', 13:02:56 INFO - 'LANG': 'en_US.UTF-8', 13:02:56 INFO - 'LANGUAGE': 'en_US:en', 13:02:56 INFO - 'LOGNAME': 'cltbld', 13:02:56 INFO - 'MAIL': '/var/mail/cltbld', 13:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:56 INFO - 'MOZ_NO_REMOTE': '1', 13:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:56 INFO - 'NO_EM_RESTART': '1', 13:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:56 INFO - 'PWD': '/builds/slave/test', 13:02:56 INFO - 'SHELL': '/bin/bash', 13:02:56 INFO - 'SHLVL': '1', 13:02:56 INFO - 'TERM': 'linux', 13:02:56 INFO - 'TMOUT': '86400', 13:02:56 INFO - 'USER': 'cltbld', 13:02:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:56 INFO - '_': '/tools/buildbot/bin/python'} 13:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:56 INFO - Downloading/unpacking flake8 13:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:02:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:02:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:58 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 13:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:59 INFO - no previously-included directories found matching 'docs/_build' 13:02:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:02:59 INFO - Running setup.py install for pep8 13:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:59 INFO - no previously-included directories found matching 'docs/_build' 13:02:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:02:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:02:59 INFO - Cleaning up... 13:02:59 INFO - Return code: 0 13:02:59 INFO - Running post-action listener: _resource_record_post_action 13:02:59 INFO - Running post-action listener: _start_resource_monitoring 13:02:59 INFO - Starting resource monitoring. 13:02:59 INFO - ##### 13:02:59 INFO - ##### Finished create-virtualenv step (success) 13:02:59 INFO - ##### 13:02:59 INFO - ##### 13:02:59 INFO - ##### Running install step. 13:02:59 INFO - ##### 13:02:59 INFO - Running pre-action listener: _resource_record_pre_action 13:02:59 INFO - Running main action method: install 13:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:59 INFO - Reading from file tmpfile_stdout 13:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:02:59 INFO - Reading from file tmpfile_stdout 13:02:59 INFO - Output received: 13:02:59 INFO - Usage: mozinstall [options] installer 13:02:59 INFO - Options: 13:02:59 INFO - -h, --help show this help message and exit 13:02:59 INFO - -d DEST, --destination=DEST 13:02:59 INFO - Directory to install application into. [default: 13:02:59 INFO - "/builds/slave/test"] 13:02:59 INFO - --app=APP Application being installed. [default: firefox] 13:02:59 INFO - mkdir: /builds/slave/test/build/application 13:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:03:16 INFO - Reading from file tmpfile_stdout 13:03:16 INFO - Output received: 13:03:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:03:16 INFO - Running post-action listener: _resource_record_post_action 13:03:16 INFO - ##### 13:03:16 INFO - ##### Finished install step (success) 13:03:16 INFO - ##### 13:03:16 INFO - ##### 13:03:16 INFO - ##### Running run-tests step. 13:03:16 INFO - ##### 13:03:16 INFO - Running pre-action listener: _resource_record_pre_action 13:03:16 INFO - Running main action method: run_tests 13:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:03:16 INFO - Python 2.7.3 13:03:16 INFO - Return code: 0 13:03:16 INFO - grabbing minidump binary from tooltool 13:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:16 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 0x11cb1c0>, '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 0x11cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:03:16 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 13:03:16 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 13:03:16 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 13:03:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:16 INFO - Return code: 0 13:03:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:03:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:03:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:03:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:03:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:03:17 INFO - Return code: 0 13:03:17 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/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 13:03:17 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/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 13:03:17 INFO - Using env: {'DISPLAY': ':0', 13:03:17 INFO - 'HOME': '/home/cltbld', 13:03:17 INFO - 'LANG': 'en_US.UTF-8', 13:03:17 INFO - 'LANGUAGE': 'en_US:en', 13:03:17 INFO - 'LOGNAME': 'cltbld', 13:03:17 INFO - 'MAIL': '/var/mail/cltbld', 13:03:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:03:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:17 INFO - 'MOZ_NO_REMOTE': '1', 13:03:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:17 INFO - 'NO_EM_RESTART': '1', 13:03:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:17 INFO - 'PWD': '/builds/slave/test', 13:03:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:03:17 INFO - 'SHELL': '/bin/bash', 13:03:17 INFO - 'SHLVL': '1', 13:03:17 INFO - 'TERM': 'linux', 13:03:17 INFO - 'TMOUT': '86400', 13:03:17 INFO - 'USER': 'cltbld', 13:03:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422', 13:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:17 INFO - '_': '/tools/buildbot/bin/python'} 13:03:17 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/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 13:03:18 INFO - mozversion application_buildid: 20160622103005 13:03:18 INFO - mozversion application_changeset: fdd1161f445604e720214966a7eaed8e7833ad9e 13:03:18 INFO - mozversion application_display_name: Nightly 13:03:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:18 INFO - mozversion application_name: Firefox 13:03:18 INFO - mozversion application_remotingname: firefox 13:03:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:03:18 INFO - mozversion application_vendor: Mozilla 13:03:18 INFO - mozversion application_version: 50.0a1 13:03:18 INFO - mozversion platform_buildid: 20160622103005 13:03:18 INFO - mozversion platform_changeset: fdd1161f445604e720214966a7eaed8e7833ad9e 13:03:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:03:18 INFO - mozversion platform_version: 50.0a1 13:03:18 INFO - using testdate: 1466625798 13:03:18 INFO - actual date: 1466625798 13:03:18 INFO - starting webserver on 'localhost:48077' 13:03:18 INFO - SUITE-START | Running 2 tests 13:03:18 INFO - TEST-START | dromaeo_css 13:03:18 INFO - operating with platform_type : linux_ 13:03:18 INFO - Initialising browser for dromaeo_css test... 13:03:18 INFO - TEST-INFO | started process 28201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcchE2r/profile http://localhost:48077/getInfo.html) 13:03:21 INFO - PROCESS | 28201 | __metrics Screen width/height:1600/1200 13:03:21 INFO - PROCESS | 28201 | colorDepth:24 13:03:21 INFO - PROCESS | 28201 | Browser inner width/height: 1024/697 13:03:21 INFO - PROCESS | 28201 | __metrics 13:03:22 INFO - PROCESS | 28201 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:23 INFO - TEST-INFO | 28201: exit 0 13:03:23 INFO - Browser initialized. 13:03:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:03:23 INFO - TEST-INFO | started process 28285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcchE2r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:35 INFO - PROCESS | 28285 | RSS: Main: 174022656 13:03:35 INFO - PROCESS | 28285 | 13:04:27 INFO - PROCESS | 28285 | 1466625867163 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] 13:06:34 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48077/tests/dromaeo/cssquery-ext.html) 13:06:35 INFO - PROCESS | 28285 | RSS: Main: 265195520 13:06:35 INFO - PROCESS | 28285 | 13:09:37 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-ext.html (next: http://localhost:48077/tests/dromaeo/cssquery-jquery.html) 13:09:38 INFO - PROCESS | 28285 | RSS: Main: 265986048 13:09:38 INFO - PROCESS | 28285 | 13:12:40 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48077/tests/dromaeo/cssquery-mootools.html) 13:12:41 INFO - PROCESS | 28285 | RSS: Main: 262967296 13:12:41 INFO - PROCESS | 28285 | 13:15:43 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48077/tests/dromaeo/cssquery-prototype.html) 13:15:43 INFO - PROCESS | 28285 | RSS: Main: 255295488 13:15:43 INFO - PROCESS | 28285 | 13:18:46 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48077/tests/dromaeo/cssquery-yui.html) 13:18:47 INFO - PROCESS | 28285 | RSS: Main: 243974144 13:18:47 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | Cycle 1(1): loaded http://localhost:48077/tests/dromaeo/cssquery-yui.html (next: http://localhost:48077/tests/dromaeo/cssquery-dojo.html) 13:21:50 INFO - PROCESS | 28285 | RSS: Main: 296497152 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | __start_tp_report 13:21:50 INFO - PROCESS | 28285 | _x_x_mozilla_page_load 13:21:50 INFO - PROCESS | 28285 | _x_x_mozilla_page_load_details 13:21:50 INFO - PROCESS | 28285 | |i|pagename|runs| 13:21:50 INFO - PROCESS | 28285 | |0;dojo.html;3073.2163298358914;3074.6617872034076;3093.226693326669;3099.7365223955962;3140.764442666799;5202.167653175493;5260.395054568726;5305.230741542484;5359.91960120598;5396.676199428032;5206.687598744078;5308.150695888658;5373.731313434332;5399.325084364455;5457.727113644321;4737.0525894821;4796.3045358423005;4798.040391921612;4826.227803551433;4956.107900577895;4878.802838322347;4893.1926232171645;4912.582430493412;4931.630127740415;4944.678595891273;4771.737554434505;4800.49594792547;4841.080194763002;4856.660033797635;4904.705717656952;4744.051189762062;4757.310190022462;4776.47458779534;4779.235322348408;4886.071646387175;4780.259059845729;4806.519348065165;4813.205821039524;4830;4859.198232291703;5143.074246635604;5235.502627250406;5296.470352964711;5313.362396512404;5316.787328506855;5681.573881958829;5744.052231381817;5769.913451298234;5782.190493330937;5784;5779.797707080274;5793.246877905887;5800.4489573490455;5802.62282951611;5806.680632565207;5227.947720522822;5250.159974404115;5309.123994540934;5311.734413279282;5381.919271210935;5863.853403664857;5873.676947767828;5874.353821079678;5875.177475153482;5876.794312199053;5480.506754392044;5626.099824028136;5646;5650.491455769001;5654.095344744821;5577.888442231133;5629.155626656035;5690.231818704505;5730.398308177665;5734.369219385864;5675.318961724537;5676.035074037423;5676.403977582295;5687.658740475585;5689.68706721126;5491.807786727445;5565.638233514808;5707.286589176353;5714.457126572969;5718.857028574319;4282.700210985201;4296.7851607420125;4311.331743579687;4349.391085248068;4349.695521313541;3858.3247931611854;3864.7294689371474;3878.3600705883778;3903.6096390361304;3918.7844668542934;5221.530062294411;5226.425093239741;5278.102722537178;5282.339707536558;5309;5617.41017193197;5662.603617746719;5676.631018983753;5699.572532060112;5759.366469688331;5354.973225133927;5365.731713414314;5367.221752845893;5368.731563421813;5369.4362091980565;4830.903381932412;4844.806207751651;4882.438519570223;4930.975345123252;4963.057019166346;5865.472107510344;5866.178734977107;5868.09044598088;5875.618084824473;5910.290765108129;5692.629979051514;5697.800576979786;5700.401457847032;5702.173184888085;5706.087026075808;5737.110747834093;5745.2818397700285;5784.2769653793275;5841.32824725162;5853.912191317048;5562.916556251578;5575.2473416088305;5588.580856435702;5589.217509548747;5591.04952158126;5630.971845140748;5672.631278966854;5690.687012214368;5691;5693.914591281051;5398.1902714593125;5584.246126772996;5601.971990140023;5665.065264231521;5669.149627555899;5653.095504719389;5663.8867222656145;5664.461876121762;5666.575006874418;5669.007923613269;5325.866853328698;5527.419620939743;5555.916661250004;5577.330720313426;5583.944160558342;5541.5843811715085;5618.4662457066515;5623.971880140573;5702.2016917630735;5703.543716502752;5509.146082357241;5514.862128446821;5519.199716041071;5524.613277070566;5526.06056970308 13:21:50 INFO - PROCESS | 28285 | |1;ext.html;596.221930380853;626.8182227154125;630.193352508789;634.7048622390589;645.6900687669919;41353;43433;43487.56512434879;47260.76369618147;47321;45423.31865022027;46142.53857461424;46152.53847461524;46219.53780462194;46235;8873.822523549541;8904.154105359981;8972.05793391691;8976.730698079067;8978.910210897873;8777.517236551987;8857.689980850671;8860.601272942733;8900.109989001114;8929.55352232389;8949.328800339968;8964.058773828752;8965.058668839776;8971.596278167466;8985.415947963395;8916.063813299608;8943.910560894374;8957.955210223907;8958.68644597436;8964.551772411354;8889.288856891433;8918.955405222932;8953.731388058368;8961.372703910729;8963.596638151299;42207;42605.36091958623;42606.573934260574;42647.36028959568;42657.146857062995;3472.5659292588425;3582.498450216972;3674.4488326750934;3674.650908163747;4191.685623578243;32405.351892962244;32767.50848737271;33048.173795655064;33096.50355244673;34069.14827129317;4384.298512238027;4480.103979204139;4483.349914262414;4558.430196225472;4577.702449340783;319819;320073;320973.9999999977;321542;321577;51035.489645103815;56539.15191272134;58533.4146658528;58592.414075859546;58955;56314.43685563174;56348.71825640927;56351;56374;56406.43593564012;15865.762013569805;16054.036757794569;16066.839331606534;16071.27679254413;16094.19529023544;11936.403179840972;11965.940170299093;12060.457279422448;12083.21459105173;12085.516579336903;16849.747253791204;19055.90472047631;19108.904455477634;19129.713054304197;19207.135678894483;6389.201349831271;6635.834104147339;6838.213605435439;6899.448044156556;7023.157221133497;1024.0834453164375;1028.290479569095;1037.9377237365782;1044.253358848427;1116.4529380603446;31596.684033159832;32168.19579510531;32444.188895277806;32495.51256731151;32886.671133288364;1124.7694222684331;1149.1553708024596;1162.2968104296947;1179.262960649594;1204.8493938257718;16661.916690416714;16808.243629036722;17066.743998840026;17143.228554715068;17465.825341746673;541709;547407;549086;920631;924669;57124.71628120903;58163.709181454666;58366;58497.41502584919;58547.70726146342;1297.695041665208;1304.230504002624;1319.8944084473412;1322.1009713394983;1328.8206092177625;30425.847870760503;31770.841145795046;32360;32784.1803954903;32967.67032329742;50849.49150508447;51622;51638.74180629223;51758.74120629373;51793.22310165275;494377;498852.5401610926;500104;500372;500390;27739.306517337227;28719;28826.855865720536;28834;28878.566821497276;47766.761166193945;48466.757666211444;48818.5118148814;48842.26736599025;49952.25071623856;40237.1952560953;40959.36162553464;41351.1729765409;41785.582144178166;41950.79024604857;40014.39978400268;40115.59884401118;40971.79514102411;40992.79503602463;41153.176936460506;39690.83496542591;40599.797001014806;40786.18427631372;41351.37972930469;41524.58475415207;34162.608617396545;35420;36248.456273155396;36702.8164859174;36833.26333473369;26710;27301.863490683216;27361;27455.313617159733;27484.312892177855 13:21:50 INFO - PROCESS | 28285 | |2;jquery.html;367.93377192105413;381.2185020707549;383.51676887122215;385.1468996173475;404.92913740095474;17029.233684484196;18747.812521874777;18849.623007539874;18874.43376698698;19559.413217603458;17171.313147474088;18253.452396428096;18376.90811545944;18570;18575.256989720394;5494.1758736189595;5509.724513774316;5687.601867869251;5687.971560142214;5746.224259724946;5643.5203007744185;5646.858828529299;5686.829395118132;5701.0878259478495;5722.628029178111;5229.137192363255;5655.660660360371;5659.971700141494;5667.801626943058;5669.206311116447;5504.394516603171;5585.720713964326;5622.606417550773;5626.324841019084;5629.408912064236;5259.474052594748;5438.91841622376;5444.428335024805;5567.638103523299;5571.303587051619;12859.099863009593;12899.484020639256;12967.67580810478;13064.150830196102;19196;2170.959298259631;2214.7563767985507;2247.381969958258;2371.33602591273;2713.7693296069856;9618.326717129803;9867.753306167331;10137.594496220143;12127.696807579792;14203.431862725478;1944.1057113727702;1978.792226816178;1983.464464594566;1989;2015.737954065962;80196.59901700512;83524;85443.57278213631;86177.99999999937;86795;10282.126019288444;10318.587256509656;10411.427371494641;10565.471726413649;10690.251682382159;13728.51950181759;13832.377543010589;13852.58442246714;13852.861471385359;13871;7293.52592081513;7570.924290757132;7645.388368930472;7672.117706463717;7738.264864837832;7167.641617919187;7222.855542889113;7263.3826124778925;7308.598027108454;7354.227806080285;4312.972009147538;4321.286987647003;4352.521222665504;4390.846320378771;4507.233770259064;1791.4177892185091;1808.5026617680244;1829.6249268899844;1893.7159426086198;1917.9904100479687;951.3245595627183;962.9518524073768;981.249344251648;1032.1175395037285;1032.5250384822916;17614.647707046042;18863.339783107524;18887.81112188888;18980.62038759217;19401.2239510418;948.9193418559362;964.392432767352;964.9903500965041;1005.6027868991707;1045.4824861693357;10158.796824063626;10664.680059598224;10692;10709.53788765639;10757.515911783988;482050;489049;498983;501972;502823;65623;81172.59413703012;94563;95221.5238923801;96060.51969740246;886.8980067292215;934.5934518484481;947.6020071569819;975.9414435133915;979.3389462113046;16371.672566548365;16954.152292385086;17483.912580437525;17612.64774704473;17827.732584011508;29258;30463.543046853873;35084.64915350916;37491.06272343213;43543;54606.72696636491;55046.511859777995;56682.43317566771;56964.71517642551;57257;8156.755297341089;8363.790905227417;8383.203595658402;8558.78603034929;8626.78433039154;9557.61769529211;13320;13515.526956556867;13531.188128712309;13546.72906541844;11617.709557261136;11617.883821162019;11727.47226374798;11761.470733816828;11826.82259766087;11391.54433822671;11703.23928944616;11720.238184517979;11837.289762614271;11839.704007399883;11480.483378248166;11724.296542207494;11790.469428875893;11804.645860624196;11861.288322700666;8368.83262334762;8419.326453883798;8435.27950310559;8440.451370660887;8488.575571221538;8512.616932237941;10613.628523001658;11713.765724685289;11895.702607434883;11988 13:21:50 INFO - PROCESS | 28285 | |3;mootools.html;1263.3493750718376;1431.606308265227;1478.13529085485;1575.4643421236776;1722.4143791111028;8456.154384561542;8929.330300227477;8981.236594889426;9241.306901982345;9268.536573171332;8995.460272383662;9177.587008584613;9189.954050229757;9200.217981471566;9209.815803683923;2292.0373443153917;2310.7111611048617;2315.6989591353185;2316.4672125411166;2319.3273950554317;2157.514559224178;2203.449137715571;2291.59897018022;2308.272894038381;2313.7570555091725;2276.8633881967053;2282.109977108929;2302.26327575176;2345.2143531916827;2348.7886090251873;2216.8448208625405;2218.223621732397;2234.20685656592;2234.7653496382973;2234.999999999992;2234.1733558583264;2239.1603148819195;2243.495213576932;2244.8540844845197;2245.4498647831388;8795.736127916172;9009.639614415415;9144.405613635092;9165.908340916572;9181.540922953825;5167.664101833407;5301.072312345363;5306.575473962073;5310.468953104697;5315.893682126336;3180.204948762809;3257.511373294025;3304.7686661933676;3355.4128027595075;3357.244619960514;1051.526812934175;1058.7300238439225;1059.046857827961;1060.734816295926;1083.2363183955372;12114.333711645855;12175.45210465531;12221.572244971472;12227.877721222763;12281.508739650404;4285.485741711014;4364.650827933758;4438.068005718771;4465.754383508938;4469.932951005738;9723.562439690231;9726.465044422624;9728.513574321256;9737.756556086155;9788.168005719594;5124.128898087334;5144.125498665236;5144.588432925357;5155.793768249228;5156.123459011977;4058.330375488011;4076.8369265229057;4115;4614.054118905617;4655.37152484417;3609.7112231021456;3638.5269914911423;3703.685186759156;3725.385311423585;3736.5889752127246;1072.2922870905165;1104.7127746785734;1111.8109921313396;1115.041064684387;1126.4255229832681;819.4673462249585;896.1441823058963;912.5665308978182;919.7700574856286;987.7333120057544;6181.196444462191;6210.627362358183;6333.65164915934;6392.904106438407;6587;896.4442045931564;910.6994691751706;916.2761418479326;919.2921450483091;929.8326301265702;4211.36829475575;4272.829086836554;4297.59172878576;4353.172897149531;4372.6501879850175;11171.776564468664;11552.480138393792;11571.363575003455;11693.941530292293;11731.120165987584;10602.257841951143;11482.598109066143;11503.137264705014;11507.482163302671;11508.88491115078;8102.149274326229;8448.366372522085;8515.40392172542;8519.19067688581;8522.87215691765;5878.3239927408895;6150.907736383869;6556.967215163893;6593.670316484061;6606.141201643755;10702.89297107019;10728.195385346286;10754.193435492212;10770.299930504492;10782.1913356497;10112.747181320527;10247.48762561854;10921.617743378943;11051.171162163031;11083.556657733601;7184.784456466315;7838.216178382344;7858.60706964638;8146.348292136733;8173.5504547250475;9028.413153145024;9029;9155;9161.175494205554;9169.862452063091;7561.546307221584;7958.960205198937;8011.839763204586;8105.513669179868;8193.67225310981;7549.811254718676;7616.466847320635;7716.498427602188;7829.256220659028;8091.83816323682;6905.861882762417;7291.52605080668;7350.96324518374;7414.592197429193;7436.256374362521;5065.949340506695;5224.085784987688;5446.918296225639;5504.862378440571;5522.337319521683;5484.808031719031;5504.394516603091;5556.833295001156;5619.353774316006;5666.008448521575 13:21:50 INFO - PROCESS | 28285 | |4;prototype.html;314.6617386309717;329.67526985918863;329.97030267275943;337.364068730443;338.28452822280855;5287.101192797224;5297.576193904488;5301.3373328333955;5304.867378315539;5392.811251606195;5219.373675158977;5306.336707911511;5309.654872433289;5343.370272067018;5348.786048558063;3901.5513215980172;4019.477467929165;4138.296489596776;4144.088300573869;4189.245935731567;4105.979470102645;4149.170165966803;4151.584841515854;4173.457450531427;4175.519815221242;3927.9214415711667;4114.506259248894;4121.814518346667;4128.298189307825;4142.502899652046;3937.8818635440985;3976.2047590481875;4008.358662613997;4069.491313585802;4133.152703695735;3667.7615954963107;3674.65090816372;3676.5036720042717;3684.889453316405;3690.6493883081334;5050.671706339076;5175.430702622709;5184.896302073975;5188.351456067991;5190.662606930538;4442.200403927324;4673.485916549177;4689.132510485537;4690.437147542282;4697.154512187805;5512.503874651301;5513.636681624206;5523.944760552383;5549.639273447213;5554.416786237427;3939.1333906540517;3939.251542207;3941.2708648900043;3943.4873466449467;3947.2500224957166;5458.536024437927;5773.913391299134;5782.306123265193;5800;5820.148127417578;3995.680345572347;4016.758994460342;4040.1919616076902;4040.2929487339597;4045.3325201342036;4075.347944328893;4088.8160032798596;4088.9386659200136;4099.868068604369;4136.793160342031;4583.770811459413;4695.95304046962;4700.177468942989;4719.10337035962;4727.463574338354;5466.644668096561;5517.503424691797;5586.301712285965;5591.30108736408;5595.720213989284;1417.248858105206;1423.9715205696036;1425.600831767107;1433.2976841347665;1434.7776094705337;862.0948004595275;873.0701802580231;912.9908700913039;914.8124634449922;955.5843208204453;5378.1663842104535;5391.595630327741;5402.432744561843;5402.433294344674;5424.538914192259;5516.668999860021;5526.392096869341;5562.471565201299;5664.49019588239;5698.777476784057;5150.742462876841;5274.472552744772;5288.65623734456;5296.523312901857;5343.3587969443915;2948.764098872085;2983.254186453387;2983.582798170895;2996.146098362;2996.1760515857877;5782.537397008229;5799.3040835100055;5813.09896965971;5816.476517113396;5817.0983497557945;5486.423925487767;5711.828645140569;5734.856628584235;5788.363280039276;5794.971025144847;5783.624064435799;5833.766649333979;5834.912476312858;5854.736536855852;5877.031194549873;5480.780768769205;5531.8893622126525;5640.633358831663;5646.71766411686;5681.261436013292;5587.273654424899;5595.747232103712;5604.299462567179;5609.971950140223;5617.522510586646;5836.620619659709;5856.150858125633;5859.20900678403;5866.6480011199465;5896.852578685567;3860.6680695160126;3968.6229808168177;3989.6808255340084;4010.979945100256;4016.2328575427887;5551.694656793915;5602.915956260741;5610.074337734228;5679.460451257124;5693.259876216065;5439.0753571893665;5495.450454954473;5540.279763630702;5570.6657600544095;5619.550435965031;5483.643563168382;5514.944850551443;5523.199136125159;5532.3637781655625;5549.223108764695;5247.658902171346;5433.5277448759925;5434.972825135849;5480.314960629921;5491.176323551339;5557.527610153183;5575.219469274224;5582.190582365615;5591;5597.888042239051;5393.541548968382;5439.809606663748;5441.2654291670115;5463.808766693147;5466.3713672928125 13:21:50 INFO - PROCESS | 28285 | |5;yui.html;710.318094629156;726.5204964723283;754.8339365339626;771.3366504805863;822.8560001999653;15278.465253716122;15771.92114039431;15787.210639468023;15813;15816.971896826713;14616.707665846676;14664;14671.046381985163;14672.706545869076;14711;654.1822721598003;760.3233122520961;775.3061010395693;776.421565933379;777.9455438119334;781.4803155901319;785.9842803143933;786.1823703348539;786.728578640371;787.5510958753513;833.6248688090353;835.5822088955522;836.861917783565;837.5519097282955;837.660747397305;685.3009929871528;701.7193122750889;801.5951944268165;822.5270469480013;828.3869936247194;601.6149664214906;601.8645804693953;601.9759209631653;602.220124938206;602.2231321595137;14706.117632942058;14736.263186840722;14741.55775326742;14759.557213283619;14785.186814725186;13528.526501572496;13961.720765584632;14063.2968351582;14186.574402767934;14759.409623615042;12158;12426.62720118398;12494.500219991189;12639.431225594779;12674.429650665743;4293.506246781629;4318.373835793793;4355.1725172217175;4393.692441529094;4470.709403888737;67507;68396.97404538887;68821;70185.2981470189;70261.64869175621;10975.50610222542;11032.50353734084;11205.159613029055;11209.383483908463;11335.886641133648;19281.807181928;19387.22451101968;19426.902865485583;19665.8033419664;19727.210911563376;8052.516848989079;8467.95766021166;8772.956135219283;8882.777930551658;8911.384830199893;4559.4072770539615;4690.718556886598;4721.881952951135;4956.628252881048;4969.453360130383;3598.766080204831;3735.5704094028993;3744.8876533704033;3745.700343972476;3747.34421476246;672.7645324136611;677.4986509982577;677.7864972533636;684.1619016704597;694.5971336624746;628.2429672244934;687.0244253160424;713.1549114299571;734.8273155808381;773.2190487607556;9181.35730498872;9425.245980321557;9473.478958657202;9669.371490853073;10082.848757268646;696.6098984568657;696.9721211151599;702.3398005874461;710.6482291265753;737.3806002957541;4367.213901497697;4713.222318317439;4715.811367545329;4743.739094349844;4756.6908150970075;91870.54064729634;94387.52806236062;95957;106125.46937265265;117383.41308293404;57416.425835741946;58855;59158;61357;88544;80610.59694701488;84443.57778211069;86831.69752453719;87086.56456717676;87622;10253.58985640566;10376.190571274583;10608.575656973635;10672.733181670521;10676.89323106759;51883.74058129685;52106.739466302424;52283.47716522786;52590.737046316055;54046;71203;78257.60871195607;78792;79080;79506;12603.810942835682;12987.350632468528;13057.723238220036;13072.169896214347;13270.46918123303;14852.331645076214;15166.469173578871;15318.463853765064;15508.147051912254;15539.145347006022;13779.793303100261;14630;14938.701225975203;15007.32467038964;15610.9219453902;14189.574312770634;14521.198575120452;15369.615759606098;15594.688106238038;15780.447684330993;14122.646933826736;14243.145411275356;14244.287785610884;14355.56933292003;14712.411503539739;11181.664550063511;11724.648260552198;11888.643340699793;12031.885245082902;12146.817797733218;12015.434135028634;12068.818967715666;12248.938755306166;12282.14025018276;12288.834054286013 13:21:50 INFO - PROCESS | 28285 | __end_tp_report 13:21:50 INFO - PROCESS | 28285 | __start_cc_report 13:21:50 INFO - PROCESS | 28285 | _x_x_mozilla_cycle_collect,804 13:21:50 INFO - PROCESS | 28285 | __end_cc_report 13:21:50 INFO - PROCESS | 28285 | __startTimestamp1466626910394__endTimestamp 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | ------- Summary: start ------- 13:21:50 INFO - PROCESS | 28285 | Number of tests: 6 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#0] dojo.html Cycles:165 Average:5286.65 Median:5524.61 stddev:603.97 (10.9%) stddev-sans-first:580.32 13:21:50 INFO - PROCESS | 28285 | Values: 3073.2 3074.7 3093.2 3099.7 3140.8 5202.2 5260.4 5305.2 5359.9 5396.7 5206.7 5308.2 5373.7 5399.3 5457.7 4737.1 4796.3 4798.0 4826.2 4956.1 4878.8 4893.2 4912.6 4931.6 4944.7 4771.7 4800.5 4841.1 4856.7 4904.7 4744.1 4757.3 4776.5 4779.2 4886.1 4780.3 4806.5 4813.2 4830.0 4859.2 5143.1 5235.5 5296.5 5313.4 5316.8 5681.6 5744.1 5769.9 5782.2 5784.0 5779.8 5793.2 5800.4 5802.6 5806.7 5227.9 5250.2 5309.1 5311.7 5381.9 5863.9 5873.7 5874.4 5875.2 5876.8 5480.5 5626.1 5646.0 5650.5 5654.1 5577.9 5629.2 5690.2 5730.4 5734.4 5675.3 5676.0 5676.4 5687.7 5689.7 5491.8 5565.6 5707.3 5714.5 5718.9 4282.7 4296.8 4311.3 4349.4 4349.7 3858.3 3864.7 3878.4 3903.6 3918.8 5221.5 5226.4 5278.1 5282.3 5309.0 5617.4 5662.6 5676.6 5699.6 5759.4 5355.0 5365.7 5367.2 5368.7 5369.4 4830.9 4844.8 4882.4 4931.0 4963.1 5865.5 5866.2 5868.1 5875.6 5910.3 5692.6 5697.8 5700.4 5702.2 5706.1 5737.1 5745.3 5784.3 5841.3 5853.9 5562.9 5575.2 5588.6 5589.2 5591.0 5631.0 5672.6 5690.7 5691.0 5693.9 5398.2 5584.2 5602.0 5665.1 5669.1 5653.1 5663.9 5664.5 5666.6 5669.0 5325.9 5527.4 5555.9 5577.3 5583.9 5541.6 5618.5 5624.0 5702.2 5703.5 5509.1 5514.9 5519.2 5524.6 5526.1 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#1] ext.html Cycles:180 Average:65567.56 Median:42078.90 stddev:144711.72 (343.9%) stddev-sans-first:145035.45 13:21:50 INFO - PROCESS | 28285 | Values: 596.2 626.8 630.2 634.7 645.7 41353.0 43433.0 43487.6 47260.8 47321.0 45423.3 46142.5 46152.5 46219.5 46235.0 8873.8 8904.2 8972.1 8976.7 8978.9 8777.5 8857.7 8860.6 8900.1 8929.6 8949.3 8964.1 8965.1 8971.6 8985.4 8916.1 8943.9 8958.0 8958.7 8964.6 8889.3 8919.0 8953.7 8961.4 8963.6 42207.0 42605.4 42606.6 42647.4 42657.1 3472.6 3582.5 3674.4 3674.7 4191.7 32405.4 32767.5 33048.2 33096.5 34069.1 4384.3 4480.1 4483.3 4558.4 4577.7 319819.0 320073.0 320974.0 321542.0 321577.0 51035.5 56539.2 58533.4 58592.4 58955.0 56314.4 56348.7 56351.0 56374.0 56406.4 15865.8 16054.0 16066.8 16071.3 16094.2 11936.4 11965.9 12060.5 12083.2 12085.5 16849.7 19055.9 19108.9 19129.7 19207.1 6389.2 6635.8 6838.2 6899.4 7023.2 1024.1 1028.3 1037.9 1044.3 1116.5 31596.7 32168.2 32444.2 32495.5 32886.7 1124.8 1149.2 1162.3 1179.3 1204.8 16661.9 16808.2 17066.7 17143.2 17465.8 541709.0 547407.0 549086.0 920631.0 924669.0 57124.7 58163.7 58366.0 58497.4 58547.7 1297.7 1304.2 1319.9 1322.1 1328.8 30425.8 31770.8 32360.0 32784.2 32967.7 50849.5 51622.0 51638.7 51758.7 51793.2 494377.0 498852.5 500104.0 500372.0 500390.0 27739.3 28719.0 28826.9 28834.0 28878.6 47766.8 48466.8 48818.5 48842.3 49952.3 40237.2 40959.4 41351.2 41785.6 41950.8 40014.4 40115.6 40971.8 40992.8 41153.2 39690.8 40599.8 40786.2 41351.4 41524.6 34162.6 35420.0 36248.5 36702.8 36833.3 26710.0 27301.9 27361.0 27455.3 27484.3 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#2] jquery.html Cycles:180 Average:28403.97 Median:382.37 stddev:81606.15 (21342.3%) stddev-sans-first:81807.92 13:21:50 INFO - PROCESS | 28285 | Values: 367.9 381.2 383.5 385.1 404.9 17029.2 18747.8 18849.6 18874.4 19559.4 17171.3 18253.5 18376.9 18570.0 18575.3 5494.2 5509.7 5687.6 5688.0 5746.2 5643.5 5646.9 5686.8 5701.1 5722.6 5229.1 5655.7 5660.0 5667.8 5669.2 5504.4 5585.7 5622.6 5626.3 5629.4 5259.5 5438.9 5444.4 5567.6 5571.3 12859.1 12899.5 12967.7 13064.2 19196.0 2171.0 2214.8 2247.4 2371.3 2713.8 9618.3 9867.8 10137.6 12127.7 14203.4 1944.1 1978.8 1983.5 1989.0 2015.7 80196.6 83524.0 85443.6 86178.0 86795.0 10282.1 10318.6 10411.4 10565.5 10690.3 13728.5 13832.4 13852.6 13852.9 13871.0 7293.5 7570.9 7645.4 7672.1 7738.3 7167.6 7222.9 7263.4 7308.6 7354.2 4313.0 4321.3 4352.5 4390.8 4507.2 1791.4 1808.5 1829.6 1893.7 1918.0 951.3 963.0 981.2 1032.1 1032.5 17614.6 18863.3 18887.8 18980.6 19401.2 948.9 964.4 965.0 1005.6 1045.5 10158.8 10664.7 10692.0 10709.5 10757.5 482050.0 489049.0 498983.0 501972.0 502823.0 65623.0 81172.6 94563.0 95221.5 96060.5 886.9 934.6 947.6 975.9 979.3 16371.7 16954.2 17483.9 17612.6 17827.7 29258.0 30463.5 35084.6 37491.1 43543.0 54606.7 55046.5 56682.4 56964.7 57257.0 8156.8 8363.8 8383.2 8558.8 8626.8 9557.6 13320.0 13515.5 13531.2 13546.7 11617.7 11617.9 11727.5 11761.5 11826.8 11391.5 11703.2 11720.2 11837.3 11839.7 11480.5 11724.3 11790.5 11804.6 11861.3 8368.8 8419.3 8435.3 8440.5 8488.6 8512.6 10613.6 11713.8 11895.7 11988.0 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#3] mootools.html Cycles:180 Average:5907.36 Median:5095.04 stddev:3447.66 (67.7%) stddev-sans-first:3439.67 13:21:50 INFO - PROCESS | 28285 | Values: 1263.3 1431.6 1478.1 1575.5 1722.4 8456.2 8929.3 8981.2 9241.3 9268.5 8995.5 9177.6 9190.0 9200.2 9209.8 2292.0 2310.7 2315.7 2316.5 2319.3 2157.5 2203.4 2291.6 2308.3 2313.8 2276.9 2282.1 2302.3 2345.2 2348.8 2216.8 2218.2 2234.2 2234.8 2235.0 2234.2 2239.2 2243.5 2244.9 2245.4 8795.7 9009.6 9144.4 9165.9 9181.5 5167.7 5301.1 5306.6 5310.5 5315.9 3180.2 3257.5 3304.8 3355.4 3357.2 1051.5 1058.7 1059.0 1060.7 1083.2 12114.3 12175.5 12221.6 12227.9 12281.5 4285.5 4364.7 4438.1 4465.8 4469.9 9723.6 9726.5 9728.5 9737.8 9788.2 5124.1 5144.1 5144.6 5155.8 5156.1 4058.3 4076.8 4115.0 4614.1 4655.4 3609.7 3638.5 3703.7 3725.4 3736.6 1072.3 1104.7 1111.8 1115.0 1126.4 819.5 896.1 912.6 919.8 987.7 6181.2 6210.6 6333.7 6392.9 6587.0 896.4 910.7 916.3 919.3 929.8 4211.4 4272.8 4297.6 4353.2 4372.7 11171.8 11552.5 11571.4 11693.9 11731.1 10602.3 11482.6 11503.1 11507.5 11508.9 8102.1 8448.4 8515.4 8519.2 8522.9 5878.3 6150.9 6557.0 6593.7 6606.1 10702.9 10728.2 10754.2 10770.3 10782.2 10112.7 10247.5 10921.6 11051.2 11083.6 7184.8 7838.2 7858.6 8146.3 8173.6 9028.4 9029.0 9155.0 9161.2 9169.9 7561.5 7959.0 8011.8 8105.5 8193.7 7549.8 7616.5 7716.5 7829.3 8091.8 6905.9 7291.5 7351.0 7414.6 7436.3 5065.9 5224.1 5446.9 5504.9 5522.3 5484.8 5504.4 5556.8 5619.4 5666.0 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#4] prototype.html Cycles:180 Average:4650.17 Median:5384.88 stddev:1370.98 (25.5%) stddev-sans-first:1335.65 13:21:50 INFO - PROCESS | 28285 | Values: 314.7 329.7 330.0 337.4 338.3 5287.1 5297.6 5301.3 5304.9 5392.8 5219.4 5306.3 5309.7 5343.4 5348.8 3901.6 4019.5 4138.3 4144.1 4189.2 4106.0 4149.2 4151.6 4173.5 4175.5 3927.9 4114.5 4121.8 4128.3 4142.5 3937.9 3976.2 4008.4 4069.5 4133.2 3667.8 3674.7 3676.5 3684.9 3690.6 5050.7 5175.4 5184.9 5188.4 5190.7 4442.2 4673.5 4689.1 4690.4 4697.2 5512.5 5513.6 5523.9 5549.6 5554.4 3939.1 3939.3 3941.3 3943.5 3947.3 5458.5 5773.9 5782.3 5800.0 5820.1 3995.7 4016.8 4040.2 4040.3 4045.3 4075.3 4088.8 4088.9 4099.9 4136.8 4583.8 4696.0 4700.2 4719.1 4727.5 5466.6 5517.5 5586.3 5591.3 5595.7 1417.2 1424.0 1425.6 1433.3 1434.8 862.1 873.1 913.0 914.8 955.6 5378.2 5391.6 5402.4 5402.4 5424.5 5516.7 5526.4 5562.5 5664.5 5698.8 5150.7 5274.5 5288.7 5296.5 5343.4 2948.8 2983.3 2983.6 2996.1 2996.2 5782.5 5799.3 5813.1 5816.5 5817.1 5486.4 5711.8 5734.9 5788.4 5795.0 5783.6 5833.8 5834.9 5854.7 5877.0 5480.8 5531.9 5640.6 5646.7 5681.3 5587.3 5595.7 5604.3 5610.0 5617.5 5836.6 5856.2 5859.2 5866.6 5896.9 3860.7 3968.6 3989.7 4011.0 4016.2 5551.7 5602.9 5610.1 5679.5 5693.3 5439.1 5495.5 5540.3 5570.7 5619.6 5483.6 5514.9 5523.2 5532.4 5549.2 5247.7 5433.5 5435.0 5480.3 5491.2 5557.5 5575.2 5582.2 5591.0 5597.9 5393.5 5439.8 5441.3 5463.8 5466.4 13:21:50 INFO - PROCESS | 28285 | 13:21:50 INFO - PROCESS | 28285 | [#5] yui.html Cycles:180 Average:19503.77 Median:4701.97 stddev:26453.45 (562.6%) stddev-sans-first:26490.01 13:21:50 INFO - PROCESS | 28285 | Values: 710.3 726.5 754.8 771.3 822.9 15278.5 15771.9 15787.2 15813.0 15817.0 14616.7 14664.0 14671.0 14672.7 14711.0 654.2 760.3 775.3 776.4 777.9 781.5 786.0 786.2 786.7 787.6 833.6 835.6 836.9 837.6 837.7 685.3 701.7 801.6 822.5 828.4 601.6 601.9 602.0 602.2 602.2 14706.1 14736.3 14741.6 14759.6 14785.2 13528.5 13961.7 14063.3 14186.6 14759.4 12158.0 12426.6 12494.5 12639.4 12674.4 4293.5 4318.4 4355.2 4393.7 4470.7 67507.0 68397.0 68821.0 70185.3 70261.6 10975.5 11032.5 11205.2 11209.4 11335.9 19281.8 19387.2 19426.9 19665.8 19727.2 8052.5 8468.0 8773.0 8882.8 8911.4 4559.4 4690.7 4721.9 4956.6 4969.5 3598.8 3735.6 3744.9 3745.7 3747.3 672.8 677.5 677.8 684.2 694.6 628.2 687.0 713.2 734.8 773.2 9181.4 9425.2 9473.5 9669.4 10082.8 696.6 697.0 702.3 710.6 737.4 4367.2 4713.2 4715.8 4743.7 4756.7 91870.5 94387.5 95957.0 106125.5 117383.4 57416.4 58855.0 59158.0 61357.0 88544.0 80610.6 84443.6 86831.7 87086.6 87622.0 10253.6 10376.2 10608.6 10672.7 10676.9 51883.7 52106.7 52283.5 52590.7 54046.0 71203.0 78257.6 78792.0 79080.0 79506.0 12603.8 12987.4 13057.7 13072.2 13270.5 14852.3 15166.5 15318.5 15508.1 15539.1 13779.8 14630.0 14938.7 15007.3 15610.9 14189.6 14521.2 15369.6 15594.7 15780.4 14122.6 14243.1 14244.3 14355.6 14712.4 11181.7 11724.6 11888.6 12031.9 12146.8 12015.4 12068.8 12248.9 12282.1 12288.8 13:21:50 INFO - PROCESS | 28285 | -------- Summary: end -------- 13:21:50 INFO - PROCESS | 28285 | 13:21:51 INFO - TEST-INFO | 28285: exit 0 13:21:51 INFO - TEST-OK | dromaeo_css | took 1113095ms 13:21:51 INFO - TEST-START | kraken 13:21:51 INFO - operating with platform_type : linux_ 13:21:51 INFO - Initialising browser for kraken test... 13:21:51 INFO - TEST-INFO | started process 28473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9Aeys/profile http://localhost:48077/getInfo.html) 13:21:54 INFO - PROCESS | 28473 | __metrics Screen width/height:1600/1200 13:21:54 INFO - PROCESS | 28473 | colorDepth:24 13:21:54 INFO - PROCESS | 28473 | Browser inner width/height: 1024/697 13:21:54 INFO - PROCESS | 28473 | __metrics 13:21:55 INFO - PROCESS | 28473 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:56 INFO - TEST-INFO | 28473: exit 0 13:21:56 INFO - Browser initialized. 13:21:56 INFO - Running cycle 1/1 for kraken test... 13:21:56 INFO - TEST-INFO | started process 28560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9Aeys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:08 INFO - PROCESS | 28560 | RSS: Main: 174141440 13:22:08 INFO - PROCESS | 28560 | 13:22:11 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48077/tests/kraken/driver.html?testName=audio-beat-detection) 13:22:11 INFO - PROCESS | 28560 | RSS: Main: 232792064 13:22:11 INFO - PROCESS | 28560 | 13:22:14 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48077/tests/kraken/driver.html?testName=audio-dft) 13:22:15 INFO - PROCESS | 28560 | RSS: Main: 221728768 13:22:15 INFO - PROCESS | 28560 | 13:22:18 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48077/tests/kraken/driver.html?testName=audio-fft) 13:22:18 INFO - PROCESS | 28560 | RSS: Main: 286982144 13:22:18 INFO - PROCESS | 28560 | 13:22:21 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48077/tests/kraken/driver.html?testName=audio-oscillator) 13:22:21 INFO - PROCESS | 28560 | RSS: Main: 198692864 13:22:21 INFO - PROCESS | 28560 | 13:22:23 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:24 INFO - PROCESS | 28560 | RSS: Main: 202199040 13:22:24 INFO - PROCESS | 28560 | 13:22:27 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48077/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:27 INFO - PROCESS | 28560 | RSS: Main: 238116864 13:22:27 INFO - PROCESS | 28560 | 13:22:31 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48077/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:31 INFO - PROCESS | 28560 | RSS: Main: 238596096 13:22:31 INFO - PROCESS | 28560 | 13:22:34 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48077/tests/kraken/driver.html?testName=json-parse-financial) 13:22:35 INFO - PROCESS | 28560 | RSS: Main: 238735360 13:22:35 INFO - PROCESS | 28560 | 13:22:36 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:37 INFO - PROCESS | 28560 | RSS: Main: 226443264 13:22:37 INFO - PROCESS | 28560 | 13:22:39 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:39 INFO - PROCESS | 28560 | RSS: Main: 230129664 13:22:39 INFO - PROCESS | 28560 | 13:22:41 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:42 INFO - PROCESS | 28560 | RSS: Main: 237088768 13:22:42 INFO - PROCESS | 28560 | 13:22:45 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:45 INFO - PROCESS | 28560 | RSS: Main: 239165440 13:22:45 INFO - PROCESS | 28560 | 13:22:48 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:48 INFO - PROCESS | 28560 | RSS: Main: 238129152 13:22:48 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | Cycle 1(1): loaded http://localhost:48077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48077/tests/kraken/driver.html?testName=ai-astar) 13:22:50 INFO - PROCESS | 28560 | RSS: Main: 281128960 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | __start_tp_report 13:22:50 INFO - PROCESS | 28560 | _x_x_mozilla_page_load 13:22:50 INFO - PROCESS | 28560 | _x_x_mozilla_page_load_details 13:22:50 INFO - PROCESS | 28560 | |i|pagename|runs| 13:22:50 INFO - PROCESS | 28560 | |0;ai-astar;100;111;110;109;110;110;111;109;109;109 13:22:50 INFO - PROCESS | 28560 | |1;audio-beat-detection;151;123;126;188;125;127;149;124;161;124 13:22:50 INFO - PROCESS | 28560 | |2;audio-dft;160;161;160;160;160;162;161;163;161;161 13:22:50 INFO - PROCESS | 28560 | |3;audio-fft;74;74;74;126;85;76;76;75;110;76 13:22:50 INFO - PROCESS | 28560 | |4;audio-oscillator;86;85;109;86;85;86;111;85;86;124 13:22:50 INFO - PROCESS | 28560 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 13:22:50 INFO - PROCESS | 28560 | |6;imaging-darkroom;146;147;147;146;147;146;147;146;146;147 13:22:50 INFO - PROCESS | 28560 | |7;imaging-desaturate;94;95;95;95;95;95;94;94;95;94 13:22:50 INFO - PROCESS | 28560 | |8;json-parse-financial;54;53;54;53;54;54;54;54;53;54 13:22:50 INFO - PROCESS | 28560 | |9;json-stringify-tinderbox;62;62;62;63;62;62;62;62;62;62 13:22:50 INFO - PROCESS | 28560 | |10;stanford-crypto-aes;81;84;78;79;78;79;82;80;116;78 13:22:50 INFO - PROCESS | 28560 | |11;stanford-crypto-ccm;120;121;119;120;121;119;119;127;131;128 13:22:50 INFO - PROCESS | 28560 | |12;stanford-crypto-pbkdf2;162;159;158;157;158;160;158;155;157;156 13:22:50 INFO - PROCESS | 28560 | |13;stanford-crypto-sha256-iterative;65;63;62;62;65;61;60;60;65;61 13:22:50 INFO - PROCESS | 28560 | __end_tp_report 13:22:50 INFO - PROCESS | 28560 | __start_cc_report 13:22:50 INFO - PROCESS | 28560 | _x_x_mozilla_cycle_collect,1623 13:22:50 INFO - PROCESS | 28560 | __end_cc_report 13:22:50 INFO - PROCESS | 28560 | __startTimestamp1466626970799__endTimestamp 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | ------- Summary: start ------- 13:22:50 INFO - PROCESS | 28560 | Number of tests: 14 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.19 (2.9%) stddev-sans-first:0.83 13:22:50 INFO - PROCESS | 28560 | Values: 100.0 111.0 110.0 109.0 110.0 110.0 111.0 109.0 109.0 109.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:138.00 stddev:21.95 (15.9%) stddev-sans-first:22.91 13:22:50 INFO - PROCESS | 28560 | Values: 151.0 123.0 126.0 188.0 125.0 127.0 149.0 124.0 161.0 124.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 13:22:50 INFO - PROCESS | 28560 | Values: 160.0 161.0 160.0 160.0 160.0 162.0 161.0 163.0 161.0 161.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.50 stddev:18.29 (24.2%) stddev-sans-first:18.99 13:22:50 INFO - PROCESS | 28560 | Values: 74.0 74.0 74.0 126.0 85.0 76.0 76.0 75.0 110.0 76.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:85.50 stddev:14.58 (17.0%) stddev-sans-first:15.15 13:22:50 INFO - PROCESS | 28560 | Values: 86.0 85.0 109.0 86.0 85.0 86.0 111.0 85.0 86.0 124.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:22:50 INFO - PROCESS | 28560 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:22:50 INFO - PROCESS | 28560 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:22:50 INFO - PROCESS | 28560 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 13:22:50 INFO - PROCESS | 28560 | Values: 54.0 53.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 13:22:50 INFO - PROCESS | 28560 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:79.50 stddev:11.59 (14.6%) stddev-sans-first:12.26 13:22:50 INFO - PROCESS | 28560 | Values: 81.0 84.0 78.0 79.0 78.0 79.0 82.0 80.0 116.0 78.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:121.00 stddev:4.43 (3.7%) stddev-sans-first:4.60 13:22:50 INFO - PROCESS | 28560 | Values: 120.0 121.0 119.0 120.0 121.0 119.0 119.0 127.0 131.0 128.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:2.00 (1.3%) stddev-sans-first:1.51 13:22:50 INFO - PROCESS | 28560 | Values: 162.0 159.0 158.0 157.0 158.0 160.0 158.0 155.0 157.0 156.0 13:22:50 INFO - PROCESS | 28560 | 13:22:50 INFO - PROCESS | 28560 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:2.01 (3.2%) stddev-sans-first:1.90 13:22:50 INFO - PROCESS | 28560 | Values: 65.0 63.0 62.0 62.0 65.0 61.0 60.0 60.0 65.0 61.0 13:22:50 INFO - PROCESS | 28560 | -------- Summary: end -------- 13:22:50 INFO - PROCESS | 28560 | 13:22:51 INFO - TEST-INFO | 28560: exit 0 13:22:51 INFO - TEST-OK | kraken | took 60632ms 13:22:51 INFO - SUITE-END | took 1173s 13:22:51 INFO - Completed test suite (00:19:33) 13:22:51 INFO - javascript benchmark 13:22:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.2163298358914, 3074.6617872034076, 3093.226693326669, 3099.7365223955962, 3140.764442666799, 5202.167653175493, 5260.395054568726, 5305.230741542484, 5359.91960120598, 5396.676199428032, 5206.687598744078, 5308.150695888658, 5373.731313434332, 5399.325084364455, 5457.727113644321, 4737.0525894821, 4796.3045358423005, 4798.040391921612, 4826.227803551433, 4956.107900577895, 4878.802838322347, 4893.1926232171645, 4912.582430493412, 4931.630127740415, 4944.678595891273, 4771.737554434505, 4800.49594792547, 4841.080194763002, 4856.660033797635, 4904.705717656952, 4744.051189762062, 4757.310190022462, 4776.47458779534, 4779.235322348408, 4886.071646387175, 4780.259059845729, 4806.519348065165, 4813.205821039524, 4830.0, 4859.198232291703, 5143.074246635604, 5235.502627250406, 5296.470352964711, 5313.362396512404, 5316.787328506855, 5681.573881958829, 5744.052231381817, 5769.913451298234, 5782.190493330937, 5784.0, 5779.797707080274, 5793.246877905887, 5800.4489573490455, 5802.62282951611, 5806.680632565207, 5227.947720522822, 5250.159974404115, 5309.123994540934, 5311.734413279282, 5381.919271210935, 5863.853403664857, 5873.676947767828, 5874.353821079678, 5875.177475153482, 5876.794312199053, 5480.506754392044, 5626.099824028136, 5646.0, 5650.491455769001, 5654.095344744821, 5577.888442231133, 5629.155626656035, 5690.231818704505, 5730.398308177665, 5734.369219385864, 5675.318961724537, 5676.035074037423, 5676.403977582295, 5687.658740475585, 5689.68706721126, 5491.807786727445, 5565.638233514808, 5707.286589176353, 5714.457126572969, 5718.857028574319, 4282.700210985201, 4296.7851607420125, 4311.331743579687, 4349.391085248068, 4349.695521313541, 3858.3247931611854, 3864.7294689371474, 3878.3600705883778, 3903.6096390361304, 3918.7844668542934, 5221.530062294411, 5226.425093239741, 5278.102722537178, 5282.339707536558, 5309.0, 5617.41017193197, 5662.603617746719, 5676.631018983753, 5699.572532060112, 5759.366469688331, 5354.973225133927, 5365.731713414314, 5367.221752845893, 5368.731563421813, 5369.4362091980565, 4830.903381932412, 4844.806207751651, 4882.438519570223, 4930.975345123252, 4963.057019166346, 5865.472107510344, 5866.178734977107, 5868.09044598088, 5875.618084824473, 5910.290765108129, 5692.629979051514, 5697.800576979786, 5700.401457847032, 5702.173184888085, 5706.087026075808, 5737.110747834093, 5745.2818397700285, 5784.2769653793275, 5841.32824725162, 5853.912191317048, 5562.916556251578, 5575.2473416088305, 5588.580856435702, 5589.217509548747, 5591.04952158126, 5630.971845140748, 5672.631278966854, 5690.687012214368, 5691.0, 5693.914591281051, 5398.1902714593125, 5584.246126772996, 5601.971990140023, 5665.065264231521, 5669.149627555899, 5653.095504719389, 5663.8867222656145, 5664.461876121762, 5666.575006874418, 5669.007923613269, 5325.866853328698, 5527.419620939743, 5555.916661250004, 5577.330720313426, 5583.944160558342, 5541.5843811715085, 5618.4662457066515, 5623.971880140573, 5702.2016917630735, 5703.543716502752, 5509.146082357241, 5514.862128446821, 5519.199716041071, 5524.613277070566, 5526.06056970308], "value": 5245.804412600081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.221930380853, 626.8182227154125, 630.193352508789, 634.7048622390589, 645.6900687669919, 41353.0, 43433.0, 43487.56512434879, 47260.76369618147, 47321.0, 45423.31865022027, 46142.53857461424, 46152.53847461524, 46219.53780462194, 46235.0, 8873.822523549541, 8904.154105359981, 8972.05793391691, 8976.730698079067, 8978.910210897873, 8777.517236551987, 8857.689980850671, 8860.601272942733, 8900.109989001114, 8929.55352232389, 8949.328800339968, 8964.058773828752, 8965.058668839776, 8971.596278167466, 8985.415947963395, 8916.063813299608, 8943.910560894374, 8957.955210223907, 8958.68644597436, 8964.551772411354, 8889.288856891433, 8918.955405222932, 8953.731388058368, 8961.372703910729, 8963.596638151299, 42207.0, 42605.36091958623, 42606.573934260574, 42647.36028959568, 42657.146857062995, 3472.5659292588425, 3582.498450216972, 3674.4488326750934, 3674.650908163747, 4191.685623578243, 32405.351892962244, 32767.50848737271, 33048.173795655064, 33096.50355244673, 34069.14827129317, 4384.298512238027, 4480.103979204139, 4483.349914262414, 4558.430196225472, 4577.702449340783, 319819.0, 320073.0, 320973.9999999977, 321542.0, 321577.0, 51035.489645103815, 56539.15191272134, 58533.4146658528, 58592.414075859546, 58955.0, 56314.43685563174, 56348.71825640927, 56351.0, 56374.0, 56406.43593564012, 15865.762013569805, 16054.036757794569, 16066.839331606534, 16071.27679254413, 16094.19529023544, 11936.403179840972, 11965.940170299093, 12060.457279422448, 12083.21459105173, 12085.516579336903, 16849.747253791204, 19055.90472047631, 19108.904455477634, 19129.713054304197, 19207.135678894483, 6389.201349831271, 6635.834104147339, 6838.213605435439, 6899.448044156556, 7023.157221133497, 1024.0834453164375, 1028.290479569095, 1037.9377237365782, 1044.253358848427, 1116.4529380603446, 31596.684033159832, 32168.19579510531, 32444.188895277806, 32495.51256731151, 32886.671133288364, 1124.7694222684331, 1149.1553708024596, 1162.2968104296947, 1179.262960649594, 1204.8493938257718, 16661.916690416714, 16808.243629036722, 17066.743998840026, 17143.228554715068, 17465.825341746673, 541709.0, 547407.0, 549086.0, 920631.0, 924669.0, 57124.71628120903, 58163.709181454666, 58366.0, 58497.41502584919, 58547.70726146342, 1297.695041665208, 1304.230504002624, 1319.8944084473412, 1322.1009713394983, 1328.8206092177625, 30425.847870760503, 31770.841145795046, 32360.0, 32784.1803954903, 32967.67032329742, 50849.49150508447, 51622.0, 51638.74180629223, 51758.74120629373, 51793.22310165275, 494377.0, 498852.5401610926, 500104.0, 500372.0, 500390.0, 27739.306517337227, 28719.0, 28826.855865720536, 28834.0, 28878.566821497276, 47766.761166193945, 48466.757666211444, 48818.5118148814, 48842.26736599025, 49952.25071623856, 40237.1952560953, 40959.36162553464, 41351.1729765409, 41785.582144178166, 41950.79024604857, 40014.39978400268, 40115.59884401118, 40971.79514102411, 40992.79503602463, 41153.176936460506, 39690.83496542591, 40599.797001014806, 40786.18427631372, 41351.37972930469, 41524.58475415207, 34162.608617396545, 35420.0, 36248.456273155396, 36702.8164859174, 36833.26333473369, 26710.0, 27301.863490683216, 27361.0, 27455.313617159733, 27484.312892177855], "value": 20306.205627042684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.93377192105413, 381.2185020707549, 383.51676887122215, 385.1468996173475, 404.92913740095474, 17029.233684484196, 18747.812521874777, 18849.623007539874, 18874.43376698698, 19559.413217603458, 17171.313147474088, 18253.452396428096, 18376.90811545944, 18570.0, 18575.256989720394, 5494.1758736189595, 5509.724513774316, 5687.601867869251, 5687.971560142214, 5746.224259724946, 5643.5203007744185, 5646.858828529299, 5686.829395118132, 5701.0878259478495, 5722.628029178111, 5229.137192363255, 5655.660660360371, 5659.971700141494, 5667.801626943058, 5669.206311116447, 5504.394516603171, 5585.720713964326, 5622.606417550773, 5626.324841019084, 5629.408912064236, 5259.474052594748, 5438.91841622376, 5444.428335024805, 5567.638103523299, 5571.303587051619, 12859.099863009593, 12899.484020639256, 12967.67580810478, 13064.150830196102, 19196.0, 2170.959298259631, 2214.7563767985507, 2247.381969958258, 2371.33602591273, 2713.7693296069856, 9618.326717129803, 9867.753306167331, 10137.594496220143, 12127.696807579792, 14203.431862725478, 1944.1057113727702, 1978.792226816178, 1983.464464594566, 1989.0, 2015.737954065962, 80196.59901700512, 83524.0, 85443.57278213631, 86177.99999999937, 86795.0, 10282.126019288444, 10318.587256509656, 10411.427371494641, 10565.471726413649, 10690.251682382159, 13728.51950181759, 13832.377543010589, 13852.58442246714, 13852.861471385359, 13871.0, 7293.52592081513, 7570.924290757132, 7645.388368930472, 7672.117706463717, 7738.264864837832, 7167.641617919187, 7222.855542889113, 7263.3826124778925, 7308.598027108454, 7354.227806080285, 4312.972009147538, 4321.286987647003, 4352.521222665504, 4390.846320378771, 4507.233770259064, 1791.4177892185091, 1808.5026617680244, 1829.6249268899844, 1893.7159426086198, 1917.9904100479687, 951.3245595627183, 962.9518524073768, 981.249344251648, 1032.1175395037285, 1032.5250384822916, 17614.647707046042, 18863.339783107524, 18887.81112188888, 18980.62038759217, 19401.2239510418, 948.9193418559362, 964.392432767352, 964.9903500965041, 1005.6027868991707, 1045.4824861693357, 10158.796824063626, 10664.680059598224, 10692.0, 10709.53788765639, 10757.515911783988, 482050.0, 489049.0, 498983.0, 501972.0, 502823.0, 65623.0, 81172.59413703012, 94563.0, 95221.5238923801, 96060.51969740246, 886.8980067292215, 934.5934518484481, 947.6020071569819, 975.9414435133915, 979.3389462113046, 16371.672566548365, 16954.152292385086, 17483.912580437525, 17612.64774704473, 17827.732584011508, 29258.0, 30463.543046853873, 35084.64915350916, 37491.06272343213, 43543.0, 54606.72696636491, 55046.511859777995, 56682.43317566771, 56964.71517642551, 57257.0, 8156.755297341089, 8363.790905227417, 8383.203595658402, 8558.78603034929, 8626.78433039154, 9557.61769529211, 13320.0, 13515.526956556867, 13531.188128712309, 13546.72906541844, 11617.709557261136, 11617.883821162019, 11727.47226374798, 11761.470733816828, 11826.82259766087, 11391.54433822671, 11703.23928944616, 11720.238184517979, 11837.289762614271, 11839.704007399883, 11480.483378248166, 11724.296542207494, 11790.469428875893, 11804.645860624196, 11861.288322700666, 8368.83262334762, 8419.326453883798, 8435.27950310559, 8440.451370660887, 8488.575571221538, 8512.616932237941, 10613.628523001658, 11713.765724685289, 11895.702607434883, 11988.0], "value": 8846.446548211848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.3493750718376, 1431.606308265227, 1478.13529085485, 1575.4643421236776, 1722.4143791111028, 8456.154384561542, 8929.330300227477, 8981.236594889426, 9241.306901982345, 9268.536573171332, 8995.460272383662, 9177.587008584613, 9189.954050229757, 9200.217981471566, 9209.815803683923, 2292.0373443153917, 2310.7111611048617, 2315.6989591353185, 2316.4672125411166, 2319.3273950554317, 2157.514559224178, 2203.449137715571, 2291.59897018022, 2308.272894038381, 2313.7570555091725, 2276.8633881967053, 2282.109977108929, 2302.26327575176, 2345.2143531916827, 2348.7886090251873, 2216.8448208625405, 2218.223621732397, 2234.20685656592, 2234.7653496382973, 2234.999999999992, 2234.1733558583264, 2239.1603148819195, 2243.495213576932, 2244.8540844845197, 2245.4498647831388, 8795.736127916172, 9009.639614415415, 9144.405613635092, 9165.908340916572, 9181.540922953825, 5167.664101833407, 5301.072312345363, 5306.575473962073, 5310.468953104697, 5315.893682126336, 3180.204948762809, 3257.511373294025, 3304.7686661933676, 3355.4128027595075, 3357.244619960514, 1051.526812934175, 1058.7300238439225, 1059.046857827961, 1060.734816295926, 1083.2363183955372, 12114.333711645855, 12175.45210465531, 12221.572244971472, 12227.877721222763, 12281.508739650404, 4285.485741711014, 4364.650827933758, 4438.068005718771, 4465.754383508938, 4469.932951005738, 9723.562439690231, 9726.465044422624, 9728.513574321256, 9737.756556086155, 9788.168005719594, 5124.128898087334, 5144.125498665236, 5144.588432925357, 5155.793768249228, 5156.123459011977, 4058.330375488011, 4076.8369265229057, 4115.0, 4614.054118905617, 4655.37152484417, 3609.7112231021456, 3638.5269914911423, 3703.685186759156, 3725.385311423585, 3736.5889752127246, 1072.2922870905165, 1104.7127746785734, 1111.8109921313396, 1115.041064684387, 1126.4255229832681, 819.4673462249585, 896.1441823058963, 912.5665308978182, 919.7700574856286, 987.7333120057544, 6181.196444462191, 6210.627362358183, 6333.65164915934, 6392.904106438407, 6587.0, 896.4442045931564, 910.6994691751706, 916.2761418479326, 919.2921450483091, 929.8326301265702, 4211.36829475575, 4272.829086836554, 4297.59172878576, 4353.172897149531, 4372.6501879850175, 11171.776564468664, 11552.480138393792, 11571.363575003455, 11693.941530292293, 11731.120165987584, 10602.257841951143, 11482.598109066143, 11503.137264705014, 11507.482163302671, 11508.88491115078, 8102.149274326229, 8448.366372522085, 8515.40392172542, 8519.19067688581, 8522.87215691765, 5878.3239927408895, 6150.907736383869, 6556.967215163893, 6593.670316484061, 6606.141201643755, 10702.89297107019, 10728.195385346286, 10754.193435492212, 10770.299930504492, 10782.1913356497, 10112.747181320527, 10247.48762561854, 10921.617743378943, 11051.171162163031, 11083.556657733601, 7184.784456466315, 7838.216178382344, 7858.60706964638, 8146.348292136733, 8173.5504547250475, 9028.413153145024, 9029.0, 9155.0, 9161.175494205554, 9169.862452063091, 7561.546307221584, 7958.960205198937, 8011.839763204586, 8105.513669179868, 8193.67225310981, 7549.811254718676, 7616.466847320635, 7716.498427602188, 7829.256220659028, 8091.83816323682, 6905.861882762417, 7291.52605080668, 7350.96324518374, 7414.592197429193, 7436.256374362521, 5065.949340506695, 5224.085784987688, 5446.918296225639, 5504.862378440571, 5522.337319521683, 5484.808031719031, 5504.394516603091, 5556.833295001156, 5619.353774316006, 5666.008448521575], "value": 4643.983417021125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6617386309717, 329.67526985918863, 329.97030267275943, 337.364068730443, 338.28452822280855, 5287.101192797224, 5297.576193904488, 5301.3373328333955, 5304.867378315539, 5392.811251606195, 5219.373675158977, 5306.336707911511, 5309.654872433289, 5343.370272067018, 5348.786048558063, 3901.5513215980172, 4019.477467929165, 4138.296489596776, 4144.088300573869, 4189.245935731567, 4105.979470102645, 4149.170165966803, 4151.584841515854, 4173.457450531427, 4175.519815221242, 3927.9214415711667, 4114.506259248894, 4121.814518346667, 4128.298189307825, 4142.502899652046, 3937.8818635440985, 3976.2047590481875, 4008.358662613997, 4069.491313585802, 4133.152703695735, 3667.7615954963107, 3674.65090816372, 3676.5036720042717, 3684.889453316405, 3690.6493883081334, 5050.671706339076, 5175.430702622709, 5184.896302073975, 5188.351456067991, 5190.662606930538, 4442.200403927324, 4673.485916549177, 4689.132510485537, 4690.437147542282, 4697.154512187805, 5512.503874651301, 5513.636681624206, 5523.944760552383, 5549.639273447213, 5554.416786237427, 3939.1333906540517, 3939.251542207, 3941.2708648900043, 3943.4873466449467, 3947.2500224957166, 5458.536024437927, 5773.913391299134, 5782.306123265193, 5800.0, 5820.148127417578, 3995.680345572347, 4016.758994460342, 4040.1919616076902, 4040.2929487339597, 4045.3325201342036, 4075.347944328893, 4088.8160032798596, 4088.9386659200136, 4099.868068604369, 4136.793160342031, 4583.770811459413, 4695.95304046962, 4700.177468942989, 4719.10337035962, 4727.463574338354, 5466.644668096561, 5517.503424691797, 5586.301712285965, 5591.30108736408, 5595.720213989284, 1417.248858105206, 1423.9715205696036, 1425.600831767107, 1433.2976841347665, 1434.7776094705337, 862.0948004595275, 873.0701802580231, 912.9908700913039, 914.8124634449922, 955.5843208204453, 5378.1663842104535, 5391.595630327741, 5402.432744561843, 5402.433294344674, 5424.538914192259, 5516.668999860021, 5526.392096869341, 5562.471565201299, 5664.49019588239, 5698.777476784057, 5150.742462876841, 5274.472552744772, 5288.65623734456, 5296.523312901857, 5343.3587969443915, 2948.764098872085, 2983.254186453387, 2983.582798170895, 2996.146098362, 2996.1760515857877, 5782.537397008229, 5799.3040835100055, 5813.09896965971, 5816.476517113396, 5817.0983497557945, 5486.423925487767, 5711.828645140569, 5734.856628584235, 5788.363280039276, 5794.971025144847, 5783.624064435799, 5833.766649333979, 5834.912476312858, 5854.736536855852, 5877.031194549873, 5480.780768769205, 5531.8893622126525, 5640.633358831663, 5646.71766411686, 5681.261436013292, 5587.273654424899, 5595.747232103712, 5604.299462567179, 5609.971950140223, 5617.522510586646, 5836.620619659709, 5856.150858125633, 5859.20900678403, 5866.6480011199465, 5896.852578685567, 3860.6680695160126, 3968.6229808168177, 3989.6808255340084, 4010.979945100256, 4016.2328575427887, 5551.694656793915, 5602.915956260741, 5610.074337734228, 5679.460451257124, 5693.259876216065, 5439.0753571893665, 5495.450454954473, 5540.279763630702, 5570.6657600544095, 5619.550435965031, 5483.643563168382, 5514.944850551443, 5523.199136125159, 5532.3637781655625, 5549.223108764695, 5247.658902171346, 5433.5277448759925, 5434.972825135849, 5480.314960629921, 5491.176323551339, 5557.527610153183, 5575.219469274224, 5582.190582365615, 5591.0, 5597.888042239051, 5393.541548968382, 5439.809606663748, 5441.2654291670115, 5463.808766693147, 5466.3713672928125], "value": 4210.61416256817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.318094629156, 726.5204964723283, 754.8339365339626, 771.3366504805863, 822.8560001999653, 15278.465253716122, 15771.92114039431, 15787.210639468023, 15813.0, 15816.971896826713, 14616.707665846676, 14664.0, 14671.046381985163, 14672.706545869076, 14711.0, 654.1822721598003, 760.3233122520961, 775.3061010395693, 776.421565933379, 777.9455438119334, 781.4803155901319, 785.9842803143933, 786.1823703348539, 786.728578640371, 787.5510958753513, 833.6248688090353, 835.5822088955522, 836.861917783565, 837.5519097282955, 837.660747397305, 685.3009929871528, 701.7193122750889, 801.5951944268165, 822.5270469480013, 828.3869936247194, 601.6149664214906, 601.8645804693953, 601.9759209631653, 602.220124938206, 602.2231321595137, 14706.117632942058, 14736.263186840722, 14741.55775326742, 14759.557213283619, 14785.186814725186, 13528.526501572496, 13961.720765584632, 14063.2968351582, 14186.574402767934, 14759.409623615042, 12158.0, 12426.62720118398, 12494.500219991189, 12639.431225594779, 12674.429650665743, 4293.506246781629, 4318.373835793793, 4355.1725172217175, 4393.692441529094, 4470.709403888737, 67507.0, 68396.97404538887, 68821.0, 70185.2981470189, 70261.64869175621, 10975.50610222542, 11032.50353734084, 11205.159613029055, 11209.383483908463, 11335.886641133648, 19281.807181928, 19387.22451101968, 19426.902865485583, 19665.8033419664, 19727.210911563376, 8052.516848989079, 8467.95766021166, 8772.956135219283, 8882.777930551658, 8911.384830199893, 4559.4072770539615, 4690.718556886598, 4721.881952951135, 4956.628252881048, 4969.453360130383, 3598.766080204831, 3735.5704094028993, 3744.8876533704033, 3745.700343972476, 3747.34421476246, 672.7645324136611, 677.4986509982577, 677.7864972533636, 684.1619016704597, 694.5971336624746, 628.2429672244934, 687.0244253160424, 713.1549114299571, 734.8273155808381, 773.2190487607556, 9181.35730498872, 9425.245980321557, 9473.478958657202, 9669.371490853073, 10082.848757268646, 696.6098984568657, 696.9721211151599, 702.3398005874461, 710.6482291265753, 737.3806002957541, 4367.213901497697, 4713.222318317439, 4715.811367545329, 4743.739094349844, 4756.6908150970075, 91870.54064729634, 94387.52806236062, 95957.0, 106125.46937265265, 117383.41308293404, 57416.425835741946, 58855.0, 59158.0, 61357.0, 88544.0, 80610.59694701488, 84443.57778211069, 86831.69752453719, 87086.56456717676, 87622.0, 10253.58985640566, 10376.190571274583, 10608.575656973635, 10672.733181670521, 10676.89323106759, 51883.74058129685, 52106.739466302424, 52283.47716522786, 52590.737046316055, 54046.0, 71203.0, 78257.60871195607, 78792.0, 79080.0, 79506.0, 12603.810942835682, 12987.350632468528, 13057.723238220036, 13072.169896214347, 13270.46918123303, 14852.331645076214, 15166.469173578871, 15318.463853765064, 15508.147051912254, 15539.145347006022, 13779.793303100261, 14630.0, 14938.701225975203, 15007.32467038964, 15610.9219453902, 14189.574312770634, 14521.198575120452, 15369.615759606098, 15594.688106238038, 15780.447684330993, 14122.646933826736, 14243.145411275356, 14244.287785610884, 14355.56933292003, 14712.411503539739, 11181.664550063511, 11724.648260552198, 11888.643340699793, 12031.885245082902, 12146.817797733218, 12015.434135028634, 12068.818967715666, 12248.938755306166, 12282.14025018276, 12288.834054286013], "value": 7518.784478008656, "unit": "score"}], "name": "dromaeo_css", "value": 7193.492894368931, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0, 109.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 126.0, 188.0, 125.0, 127.0, 149.0, 124.0, 161.0, 124.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 163.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 126.0, 85.0, 76.0, 76.0, 75.0, 110.0, 76.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 109.0, 86.0, 85.0, 86.0, 111.0, 85.0, 86.0, 124.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 78.0, 79.0, 78.0, 79.0, 82.0, 80.0, 116.0, 78.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 119.0, 120.0, 121.0, 119.0, 119.0, 127.0, 131.0, 128.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 158.0, 157.0, 158.0, 160.0, 158.0, 155.0, 157.0, 156.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 62.0, 65.0, 61.0, 60.0, 60.0, 65.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1488.3000000000002, "alertThreshold": 2.0}]} 13:22:52 INFO - Return code: 0 13:22:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:22:52 INFO - # TBPL SUCCESS # 13:22:52 INFO - Running post-action listener: _resource_record_post_action 13:22:52 INFO - ##### 13:22:52 INFO - ##### Finished run-tests step (success) 13:22:52 INFO - ##### 13:22:52 INFO - Running post-run listener: _resource_record_post_run 13:22:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554336256; Read time: 8; Write time: 434260 13:22:52 INFO - TinderboxPrint: CPU usage
13.2% 13:22:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:22:52 INFO - TinderboxPrint: I/O write bytes / time
554,336,256 / 434,260 13:22:52 INFO - TinderboxPrint: CPU idle
8,258.4 (86.8%) 13:22:52 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 13:22:52 INFO - TinderboxPrint: Swap in / out
0 / 0 13:22:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256978944; Read time: 0; Write time: 251452 13:22:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297357312; Read time: 8; Write time: 182808 13:22:52 INFO - Running post-run listener: _upload_blobber_files 13:22:52 INFO - Blob upload gear active. 13:22:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:22:52 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 13:22:52 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'] 13:22:52 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 13:22:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:22:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:53 INFO - (blobuploader) - INFO - Done attempting. 13:22:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:22:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:58 INFO - (blobuploader) - INFO - Done attempting. 13:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:59 INFO - (blobuploader) - INFO - Done attempting. 13:22:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:59 INFO - Return code: 0 13:22:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:22:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c50714093aeb47b5d389a487a9671c283bb9fbbbbd7e2a804fc90bb9c5dd1bc9587034f53fde549a8c61dd620dac1a31d0a9a05a365ea8c30660bcc4f6a888d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/272343ce7ebf2ff75a96b62a6ad545040e3f63476b8df554315e1ebdde1d2fa4bb41091af0dd4bde5dc6bcef58b21aea4d7f36a4c8114252d27f201533b248c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ab5d62c13b950580fb6d60eec4be64173dce74f8105590a430bb9c4169b1dff9d1887f3de6319e5371b395ab8b2f831efae165e063243adf473ebe222300a60"} 13:22:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:22:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:22:59 INFO - Contents: 13:22:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c50714093aeb47b5d389a487a9671c283bb9fbbbbd7e2a804fc90bb9c5dd1bc9587034f53fde549a8c61dd620dac1a31d0a9a05a365ea8c30660bcc4f6a888d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/272343ce7ebf2ff75a96b62a6ad545040e3f63476b8df554315e1ebdde1d2fa4bb41091af0dd4bde5dc6bcef58b21aea4d7f36a4c8114252d27f201533b248c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ab5d62c13b950580fb6d60eec4be64173dce74f8105590a430bb9c4169b1dff9d1887f3de6319e5371b395ab8b2f831efae165e063243adf473ebe222300a60"} 13:22:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:59 INFO - Copying logs to upload dir... 13:22:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:22:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.745102 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-22 13:22:59.581225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:22:59.584502) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 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/c50714093aeb47b5d389a487a9671c283bb9fbbbbd7e2a804fc90bb9c5dd1bc9587034f53fde549a8c61dd620dac1a31d0a9a05a365ea8c30660bcc4f6a888d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/272343ce7ebf2ff75a96b62a6ad545040e3f63476b8df554315e1ebdde1d2fa4bb41091af0dd4bde5dc6bcef58b21aea4d7f36a4c8114252d27f201533b248c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ab5d62c13b950580fb6d60eec4be64173dce74f8105590a430bb9c4169b1dff9d1887f3de6319e5371b395ab8b2f831efae165e063243adf473ebe222300a60"} build_url:https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c50714093aeb47b5d389a487a9671c283bb9fbbbbd7e2a804fc90bb9c5dd1bc9587034f53fde549a8c61dd620dac1a31d0a9a05a365ea8c30660bcc4f6a888d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/272343ce7ebf2ff75a96b62a6ad545040e3f63476b8df554315e1ebdde1d2fa4bb41091af0dd4bde5dc6bcef58b21aea4d7f36a4c8114252d27f201533b248c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ab5d62c13b950580fb6d60eec4be64173dce74f8105590a430bb9c4169b1dff9d1887f3de6319e5371b395ab8b2f831efae165e063243adf473ebe222300a60"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:22:59.609827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:22:59.610188) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466625735.959189-1877071422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:22:59.693387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:22:59.693745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:22:59.694078) ========= ========= Total master_lag: 0.18 =========