builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1466626243.52 results: success (0) buildid: 20160622103005 builduid: 10836223ccf84b2a8620c7f04f7b2919 revision: fdd1161f445604e720214966a7eaed8e7833ad9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.519087) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.519554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.519835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.551327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.551670) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 13:10:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2016-06-22 13:10:43 (21.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171367 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.925782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.926072) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.976887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:43.977252) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 13:10:44,157 truncating revision to first 12 chars 2016-06-22 13:10:44,157 Setting DEBUG logging. 2016-06-22 13:10:44,157 attempt 1/10 2016-06-22 13:10:44,157 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:10:44,470 unpacking tar archive at: mozilla-inbound-fdd1161f4456/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638594 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:44.648715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:44.649005) ========= script_repo_revision: fdd1161f445604e720214966a7eaed8e7833ad9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:44.649383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:44.652689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 13:10:44.665968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-22 13:10:44.666269) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:10:44 INFO - MultiFileLogger online at 20160622 13:10:44 in /builds/slave/test 13:10:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:10:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:10:44 INFO - {'append_to_log': False, 13:10:44 INFO - 'base_work_dir': '/builds/slave/test', 13:10:44 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:10:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:10:44 INFO - 'branch': 'Mozilla-Inbound', 13:10:44 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:44 INFO - 'config_files': ('talos/linux_config.py',), 13:10:44 INFO - 'default_actions': ('clobber', 13:10:44 INFO - 'read-buildbot-config', 13:10:44 INFO - 'download-and-extract', 13:10:44 INFO - 'populate-webroot', 13:10:44 INFO - 'create-virtualenv', 13:10:44 INFO - 'install', 13:10:44 INFO - 'run-tests'), 13:10:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:44 INFO - 'download_minidump_stackwalk': True, 13:10:44 INFO - 'download_symbols': 'ondemand', 13:10:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:44 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:44 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:44 INFO - 'installer_path': 'installer.exe', 13:10:44 INFO - 'log_level': 'info', 13:10:44 INFO - 'log_name': 'talos', 13:10:44 INFO - 'log_to_console': True, 13:10:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:10:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:10:44 INFO - 'opt_config_files': (), 13:10:44 INFO - 'pip_index': False, 13:10:44 INFO - 'sps_profile': False, 13:10:44 INFO - 'sps_profile_interval': 0, 13:10:44 INFO - 'suite': 'dromaeojs-e10s', 13:10:44 INFO - 'system_bits': '32', 13:10:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:44 INFO - 'title': 'talos-linux64-ix-036', 13:10:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:44 INFO - 'use_talos_json': True, 13:10:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:10:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:44 INFO - 'work_dir': 'build'} 13:10:44 INFO - ##### 13:10:44 INFO - ##### Running clobber step. 13:10:44 INFO - ##### 13:10:44 INFO - Running pre-action listener: _resource_record_pre_action 13:10:44 INFO - Running main action method: clobber 13:10:44 INFO - rmtree: /builds/slave/test/build 13:10:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:45 INFO - Running post-action listener: _resource_record_post_action 13:10:45 INFO - ##### 13:10:45 INFO - ##### Finished clobber step (success) 13:10:45 INFO - ##### 13:10:45 INFO - ##### 13:10:45 INFO - ##### Running read-buildbot-config step. 13:10:45 INFO - ##### 13:10:45 INFO - Running pre-action listener: _resource_record_pre_action 13:10:45 INFO - Running main action method: read_buildbot_config 13:10:45 INFO - Using buildbot properties: 13:10:45 INFO - { 13:10:45 INFO - "project": "", 13:10:45 INFO - "product": "firefox", 13:10:45 INFO - "script_repo_revision": "production", 13:10:45 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:10:45 INFO - "repository": "", 13:10:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:10:45 INFO - "buildid": "20160622103005", 13:10:45 INFO - "pgo_build": "True", 13:10:45 INFO - "basedir": "/builds/slave/test", 13:10:45 INFO - "buildnumber": 754, 13:10:45 INFO - "slavename": "talos-linux64-ix-036", 13:10:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:10:45 INFO - "platform": "ubuntu64_hw", 13:10:45 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:10:45 INFO - "branch": "mozilla-inbound", 13:10:45 INFO - "repo_path": "integration/mozilla-inbound", 13:10:45 INFO - "revision": "fdd1161f445604e720214966a7eaed8e7833ad9e", 13:10:45 INFO - "stage_platform": "linux64-pgo", 13:10:45 INFO - "builduid": "10836223ccf84b2a8620c7f04f7b2919", 13:10:45 INFO - "slavebuilddir": "test" 13:10:45 INFO - } 13:10:45 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:10:45 INFO - Running post-action listener: _resource_record_post_action 13:10:45 INFO - ##### 13:10:45 INFO - ##### Finished read-buildbot-config step (success) 13:10:45 INFO - ##### 13:10:45 INFO - ##### 13:10:45 INFO - ##### Running download-and-extract step. 13:10:45 INFO - ##### 13:10:45 INFO - Running pre-action listener: _resource_record_pre_action 13:10:45 INFO - Running main action method: download_and_extract 13:10:45 INFO - mkdir: /builds/slave/test/build/tests 13:10: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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:49 INFO - Downloaded 1361 bytes. 13:10:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:10:49 INFO - Using the following test package requirements: 13:10:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:10:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:10:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'jsshell-linux-x86_64.zip'], 13:10:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:10:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:10:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:10:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:10:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:10:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:10:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:10:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:57 INFO - Downloaded 24269733 bytes. 13:10:57 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:10:57 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:10:58 INFO - Return code: 0 13:10:58 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:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:11:00 INFO - Downloaded 24269733 bytes. 13:11:00 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:11:00 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:11:01 INFO - Return code: 0 13:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:03 INFO - Downloaded 14405384 bytes. 13:11:03 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:11:03 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:11:03 INFO - Return code: 0 13:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:03 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:11:03 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:11:03 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:11:03 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:11:03 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:11:05 INFO - Downloaded 60136571 bytes. 13:11:05 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:11:05 INFO - mkdir: /builds/slave/test/properties 13:11:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:05 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:05 INFO - Contents: 13:11:05 INFO - build_url:https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:11:05 INFO - Running post-action listener: _resource_record_post_action 13:11:05 INFO - Running post-action listener: set_extra_try_arguments 13:11:05 INFO - ##### 13:11:05 INFO - ##### Finished download-and-extract step (success) 13:11:05 INFO - ##### 13:11:05 INFO - ##### 13:11:05 INFO - ##### Running populate-webroot step. 13:11:05 INFO - ##### 13:11:05 INFO - Running pre-action listener: _resource_record_pre_action 13:11:05 INFO - Running main action method: populate_webroot 13:11:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:05 INFO - '--tppagecycles', 13:11:05 INFO - '7'], 13:11:05 INFO - 'tests': ['tsvgm']}}, 13:11:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['damp', 'tps']}, 13:11:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'tests': ['damp', 'tps']}, 13:11:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['dromaeo_dom']}, 13:11:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['basic_compositor_video']}, 13:11:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:11:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['a11yr', 13:11:05 INFO - 'ts_paint', 13:11:05 INFO - 'tpaint', 13:11:05 INFO - 'sessionrestore', 13:11:05 INFO - 'sessionrestore_no_auto_restore', 13:11:05 INFO - 'tabpaint']}, 13:11:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['tsvgx', 13:11:05 INFO - 'tsvgr_opacity', 13:11:05 INFO - 'tart', 13:11:05 INFO - 'tscrollx', 13:11:05 INFO - 'cart']}, 13:11:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:05 INFO - 'tsvgr_opacity', 13:11:05 INFO - 'tart', 13:11:05 INFO - 'tscrollx', 13:11:05 INFO - 'cart']}, 13:11:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'talos_options': ['--disable-e10s'], 13:11:05 INFO - 'tests': ['tp5o']}, 13:11:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'tests': ['tp5o']}, 13:11:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'talos_options': ['--disable-e10s', 13:11:05 INFO - '--xperf_path', 13:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:05 INFO - 'tests': ['tp5n']}, 13:11:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:05 INFO - 'talos_options': ['--xperf_path', 13:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:05 INFO - 'tests': ['tp5n']}}, 13:11:05 INFO - 'talos.zip': {'path': '', 13:11:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:05 INFO - Running post-action listener: _resource_record_post_action 13:11:05 INFO - ##### 13:11:05 INFO - ##### Finished populate-webroot step (success) 13:11:05 INFO - ##### 13:11:05 INFO - ##### 13:11:05 INFO - ##### Running create-virtualenv step. 13:11:05 INFO - ##### 13:11:05 INFO - Running pre-action listener: _resource_record_pre_action 13:11:05 INFO - Running main action method: create_virtualenv 13:11:05 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:05 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:11:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:06 INFO - Using real prefix '/usr' 13:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:06 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:08 INFO - Installing pip.................done. 13:11:08 INFO - Return code: 0 13:11:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:08 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:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:08 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:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:08 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:08 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:11:08 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:11:08 INFO - Using env: {'DISPLAY': ':0', 13:11:08 INFO - 'HOME': '/home/cltbld', 13:11:08 INFO - 'LANG': 'en_US.UTF-8', 13:11:08 INFO - 'LANGUAGE': 'en_US:en', 13:11:08 INFO - 'LOGNAME': 'cltbld', 13:11:08 INFO - 'MAIL': '/var/mail/cltbld', 13:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:08 INFO - 'MOZ_NO_REMOTE': '1', 13:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:08 INFO - 'NO_EM_RESTART': '1', 13:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:08 INFO - 'PWD': '/builds/slave/test', 13:11:08 INFO - 'SHELL': '/bin/bash', 13:11:08 INFO - 'SHLVL': '1', 13:11:08 INFO - 'TERM': 'linux', 13:11:08 INFO - 'TMOUT': '86400', 13:11:08 INFO - 'USER': 'cltbld', 13:11:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:08 INFO - '_': '/tools/buildbot/bin/python'} 13:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:08 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:11:08 INFO - Cleaning up... 13:11:08 INFO - Return code: 0 13:11:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:08 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:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:08 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:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:08 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:08 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:11:08 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:11:08 INFO - Using env: {'DISPLAY': ':0', 13:11:08 INFO - 'HOME': '/home/cltbld', 13:11:08 INFO - 'LANG': 'en_US.UTF-8', 13:11:08 INFO - 'LANGUAGE': 'en_US:en', 13:11:08 INFO - 'LOGNAME': 'cltbld', 13:11:08 INFO - 'MAIL': '/var/mail/cltbld', 13:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:08 INFO - 'MOZ_NO_REMOTE': '1', 13:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:08 INFO - 'NO_EM_RESTART': '1', 13:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:08 INFO - 'PWD': '/builds/slave/test', 13:11:08 INFO - 'SHELL': '/bin/bash', 13:11:08 INFO - 'SHLVL': '1', 13:11:08 INFO - 'TERM': 'linux', 13:11:08 INFO - 'TMOUT': '86400', 13:11:08 INFO - 'USER': 'cltbld', 13:11:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:08 INFO - '_': '/tools/buildbot/bin/python'} 13:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:08 INFO - Downloading/unpacking psutil>=3.1.1 13:11:08 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:11:08 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:11:08 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:11:08 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:11:08 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:11:08 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:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:10 INFO - Installing collected packages: psutil 13:11:10 INFO - Running setup.py install for psutil 13:11:10 INFO - building 'psutil._psutil_linux' extension 13:11:10 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:11:11 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:11:11 INFO - building 'psutil._psutil_posix' extension 13:11:11 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:11:11 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:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:11 INFO - Successfully installed psutil 13:11:11 INFO - Cleaning up... 13:11:11 INFO - Return code: 0 13:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:11:11 INFO - Using env: {'DISPLAY': ':0', 13:11:11 INFO - 'HOME': '/home/cltbld', 13:11:11 INFO - 'LANG': 'en_US.UTF-8', 13:11:11 INFO - 'LANGUAGE': 'en_US:en', 13:11:11 INFO - 'LOGNAME': 'cltbld', 13:11:11 INFO - 'MAIL': '/var/mail/cltbld', 13:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:11 INFO - 'MOZ_NO_REMOTE': '1', 13:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:11 INFO - 'NO_EM_RESTART': '1', 13:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:11 INFO - 'PWD': '/builds/slave/test', 13:11:11 INFO - 'SHELL': '/bin/bash', 13:11:11 INFO - 'SHLVL': '1', 13:11:11 INFO - 'TERM': 'linux', 13:11:11 INFO - 'TMOUT': '86400', 13:11:11 INFO - 'USER': 'cltbld', 13:11:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:11 INFO - '_': '/tools/buildbot/bin/python'} 13:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:13 INFO - Installing collected packages: mozsystemmonitor 13:11:13 INFO - Running setup.py install for mozsystemmonitor 13:11:13 INFO - Successfully installed mozsystemmonitor 13:11:13 INFO - Cleaning up... 13:11:13 INFO - Return code: 0 13:11:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:13 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:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:13 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:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:13 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:13 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:11:13 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:11:13 INFO - Using env: {'DISPLAY': ':0', 13:11:13 INFO - 'HOME': '/home/cltbld', 13:11:13 INFO - 'LANG': 'en_US.UTF-8', 13:11:13 INFO - 'LANGUAGE': 'en_US:en', 13:11:13 INFO - 'LOGNAME': 'cltbld', 13:11:13 INFO - 'MAIL': '/var/mail/cltbld', 13:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:13 INFO - 'MOZ_NO_REMOTE': '1', 13:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:13 INFO - 'NO_EM_RESTART': '1', 13:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:13 INFO - 'PWD': '/builds/slave/test', 13:11:13 INFO - 'SHELL': '/bin/bash', 13:11:13 INFO - 'SHLVL': '1', 13:11:13 INFO - 'TERM': 'linux', 13:11:13 INFO - 'TMOUT': '86400', 13:11:13 INFO - 'USER': 'cltbld', 13:11:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:13 INFO - '_': '/tools/buildbot/bin/python'} 13:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:16 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:16 INFO - warning: no files found matching '*.txt' 13:11:16 INFO - no previously-included directories found matching 'build' 13:11:16 INFO - no previously-included directories found matching 'dist' 13:11:16 INFO - no previously-included directories found matching '.git*' 13:11:16 INFO - Installing collected packages: jsonschema, functools32 13:11:16 INFO - Running setup.py install for functools32 13:11:16 INFO - warning: no files found matching '*.txt' 13:11:16 INFO - no previously-included directories found matching 'build' 13:11:16 INFO - no previously-included directories found matching 'dist' 13:11:16 INFO - no previously-included directories found matching '.git*' 13:11:16 INFO - Successfully installed jsonschema functools32 13:11:16 INFO - Cleaning up... 13:11:16 INFO - Return code: 0 13:11:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11: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:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:11:16 INFO - Using env: {'DISPLAY': ':0', 13:11:16 INFO - 'HOME': '/home/cltbld', 13:11:16 INFO - 'LANG': 'en_US.UTF-8', 13:11:16 INFO - 'LANGUAGE': 'en_US:en', 13:11:16 INFO - 'LOGNAME': 'cltbld', 13:11:16 INFO - 'MAIL': '/var/mail/cltbld', 13:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:16 INFO - 'MOZ_NO_REMOTE': '1', 13:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:16 INFO - 'NO_EM_RESTART': '1', 13:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:16 INFO - 'PWD': '/builds/slave/test', 13:11:16 INFO - 'SHELL': '/bin/bash', 13:11:16 INFO - 'SHLVL': '1', 13:11:16 INFO - 'TERM': 'linux', 13:11:16 INFO - 'TMOUT': '86400', 13:11:16 INFO - 'USER': 'cltbld', 13:11:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:16 INFO - '_': '/tools/buildbot/bin/python'} 13:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:18 INFO - Downloading blobuploader-1.2.4.tar.gz 13:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:11:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:11:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:19 INFO - Downloading docopt-0.6.1.tar.gz 13:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:11:19 INFO - Installing collected packages: blobuploader, requests, docopt 13:11:19 INFO - Running setup.py install for blobuploader 13:11:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:11:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:11:19 INFO - Running setup.py install for requests 13:11:19 INFO - Running setup.py install for docopt 13:11:19 INFO - Successfully installed blobuploader requests docopt 13:11:19 INFO - Cleaning up... 13:11:19 INFO - Return code: 0 13:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11: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:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:20 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:20 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:11:20 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:11:20 INFO - Using env: {'DISPLAY': ':0', 13:11:20 INFO - 'HOME': '/home/cltbld', 13:11:20 INFO - 'LANG': 'en_US.UTF-8', 13:11:20 INFO - 'LANGUAGE': 'en_US:en', 13:11:20 INFO - 'LOGNAME': 'cltbld', 13:11:20 INFO - 'MAIL': '/var/mail/cltbld', 13:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:20 INFO - 'MOZ_NO_REMOTE': '1', 13:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:20 INFO - 'NO_EM_RESTART': '1', 13:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:20 INFO - 'PWD': '/builds/slave/test', 13:11:20 INFO - 'SHELL': '/bin/bash', 13:11:20 INFO - 'SHLVL': '1', 13:11:20 INFO - 'TERM': 'linux', 13:11:20 INFO - 'TMOUT': '86400', 13:11:20 INFO - 'USER': 'cltbld', 13:11:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:20 INFO - '_': '/tools/buildbot/bin/python'} 13:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:20 INFO - Running setup.py (path:/tmp/pip-TdYWvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:20 INFO - Running setup.py (path:/tmp/pip-MXzGES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:20 INFO - Running setup.py (path:/tmp/pip-lD9ver-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:20 INFO - Running setup.py (path:/tmp/pip-yi20dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:20 INFO - Running setup.py (path:/tmp/pip-0scPoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:20 INFO - Running setup.py (path:/tmp/pip-tm9lpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:20 INFO - Running setup.py (path:/tmp/pip-Cfs1dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:20 INFO - Running setup.py (path:/tmp/pip-ZA3FoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:20 INFO - Running setup.py (path:/tmp/pip-elBoxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:20 INFO - Running setup.py (path:/tmp/pip-3TBPyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:20 INFO - Running setup.py (path:/tmp/pip-azOPQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:21 INFO - Running setup.py (path:/tmp/pip-nTqiNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:21 INFO - Running setup.py (path:/tmp/pip-MpGkdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:21 INFO - Running setup.py (path:/tmp/pip-R2aC4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:21 INFO - Running setup.py (path:/tmp/pip-j2an4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:21 INFO - Running setup.py (path:/tmp/pip-8PaDGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:21 INFO - Running setup.py (path:/tmp/pip-4Nv8PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:11:21 INFO - Running setup.py install for manifestparser 13:11:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:11:21 INFO - Running setup.py install for mozcrash 13:11:21 INFO - Running setup.py install for mozdebug 13:11:21 INFO - Running setup.py install for mozdevice 13:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:11:21 INFO - Running setup.py install for mozfile 13:11:21 INFO - Running setup.py install for mozhttpd 13:11:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozinfo 13:11:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozInstall 13:11:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozleak 13:11:22 INFO - Running setup.py install for mozlog 13:11:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for moznetwork 13:11:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozprocess 13:11:22 INFO - Running setup.py install for mozprofile 13:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozrunner 13:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:11:22 INFO - Running setup.py install for mozscreenshot 13:11:22 INFO - Running setup.py install for moztest 13:11:23 INFO - Running setup.py install for mozversion 13:11:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:11:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:11:23 INFO - Cleaning up... 13:11:23 INFO - Return code: 0 13:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11: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:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:23 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:23 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:11:23 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:11:23 INFO - Using env: {'DISPLAY': ':0', 13:11:23 INFO - 'HOME': '/home/cltbld', 13:11:23 INFO - 'LANG': 'en_US.UTF-8', 13:11:23 INFO - 'LANGUAGE': 'en_US:en', 13:11:23 INFO - 'LOGNAME': 'cltbld', 13:11:23 INFO - 'MAIL': '/var/mail/cltbld', 13:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:23 INFO - 'MOZ_NO_REMOTE': '1', 13:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:23 INFO - 'NO_EM_RESTART': '1', 13:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:23 INFO - 'PWD': '/builds/slave/test', 13:11:23 INFO - 'SHELL': '/bin/bash', 13:11:23 INFO - 'SHLVL': '1', 13:11:23 INFO - 'TERM': 'linux', 13:11:23 INFO - 'TMOUT': '86400', 13:11:23 INFO - 'USER': 'cltbld', 13:11:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:23 INFO - '_': '/tools/buildbot/bin/python'} 13:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:23 INFO - Running setup.py (path:/tmp/pip-iK5CxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:23 INFO - Running setup.py (path:/tmp/pip-4a5nJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:23 INFO - Running setup.py (path:/tmp/pip-vhyR0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:23 INFO - Running setup.py (path:/tmp/pip-clYKzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:23 INFO - Running setup.py (path:/tmp/pip-HwPK00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:23 INFO - Running setup.py (path:/tmp/pip-7ntydw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:23 INFO - Running setup.py (path:/tmp/pip-FW8dwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:23 INFO - Running setup.py (path:/tmp/pip-McZfWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:24 INFO - Running setup.py (path:/tmp/pip-_b3HML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:24 INFO - Running setup.py (path:/tmp/pip-D1xi0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:24 INFO - Running setup.py (path:/tmp/pip-I22Lxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:24 INFO - Running setup.py (path:/tmp/pip-Hk6XBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:24 INFO - Running setup.py (path:/tmp/pip-eKjdBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:24 INFO - Running setup.py (path:/tmp/pip-AbrRek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:24 INFO - Running setup.py (path:/tmp/pip-4YSrNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:24 INFO - Running setup.py (path:/tmp/pip-8yZ8Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:24 INFO - Running setup.py (path:/tmp/pip-iHdHJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:26 INFO - Downloading blessings-1.6.tar.gz 13:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:26 INFO - Installing collected packages: blessings 13:11:26 INFO - Running setup.py install for blessings 13:11:26 INFO - Successfully installed blessings 13:11:26 INFO - Cleaning up... 13:11:26 INFO - Return code: 0 13:11:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:27 INFO - Reading from file tmpfile_stdout 13:11:27 INFO - Current package versions: 13:11:27 INFO - argparse == 1.2.1 13:11:27 INFO - blessings == 1.6 13:11:27 INFO - blobuploader == 1.2.4 13:11:27 INFO - docopt == 0.6.1 13:11:27 INFO - functools32 == 3.2.3-2 13:11:27 INFO - jsonschema == 2.5.1 13:11:27 INFO - manifestparser == 1.1 13:11:27 INFO - mozInstall == 1.12 13:11:27 INFO - mozcrash == 0.17 13:11:27 INFO - mozdebug == 0.1 13:11:27 INFO - mozdevice == 0.48 13:11:27 INFO - mozfile == 1.2 13:11:27 INFO - mozhttpd == 0.7 13:11:27 INFO - mozinfo == 0.9 13:11:27 INFO - mozleak == 0.1 13:11:27 INFO - mozlog == 3.2 13:11:27 INFO - moznetwork == 0.27 13:11:27 INFO - mozprocess == 0.22 13:11:27 INFO - mozprofile == 0.28 13:11:27 INFO - mozrunner == 6.11 13:11:27 INFO - mozscreenshot == 0.1 13:11:27 INFO - mozsystemmonitor == 0.3 13:11:27 INFO - moztest == 0.7 13:11:27 INFO - mozversion == 1.4 13:11:27 INFO - psutil == 3.1.1 13:11:27 INFO - requests == 1.2.3 13:11:27 INFO - wsgiref == 0.1.2 13:11:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:27 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:11:27 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:11:27 INFO - Using env: {'DISPLAY': ':0', 13:11:27 INFO - 'HOME': '/home/cltbld', 13:11:27 INFO - 'LANG': 'en_US.UTF-8', 13:11:27 INFO - 'LANGUAGE': 'en_US:en', 13:11:27 INFO - 'LOGNAME': 'cltbld', 13:11:27 INFO - 'MAIL': '/var/mail/cltbld', 13:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:27 INFO - 'MOZ_NO_REMOTE': '1', 13:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:27 INFO - 'NO_EM_RESTART': '1', 13:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:27 INFO - 'PWD': '/builds/slave/test', 13:11:27 INFO - 'SHELL': '/bin/bash', 13:11:27 INFO - 'SHLVL': '1', 13:11:27 INFO - 'TERM': 'linux', 13:11:27 INFO - 'TMOUT': '86400', 13:11:27 INFO - 'USER': 'cltbld', 13:11:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:27 INFO - '_': '/tools/buildbot/bin/python'} 13:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 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:11:27 INFO - Cleaning up... 13:11:27 INFO - Return code: 0 13:11:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:27 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:11:27 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:11:27 INFO - Using env: {'DISPLAY': ':0', 13:11:27 INFO - 'HOME': '/home/cltbld', 13:11:27 INFO - 'LANG': 'en_US.UTF-8', 13:11:27 INFO - 'LANGUAGE': 'en_US:en', 13:11:27 INFO - 'LOGNAME': 'cltbld', 13:11:27 INFO - 'MAIL': '/var/mail/cltbld', 13:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:27 INFO - 'MOZ_NO_REMOTE': '1', 13:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:27 INFO - 'NO_EM_RESTART': '1', 13:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:27 INFO - 'PWD': '/builds/slave/test', 13:11:27 INFO - 'SHELL': '/bin/bash', 13:11:27 INFO - 'SHLVL': '1', 13:11:27 INFO - 'TERM': 'linux', 13:11:27 INFO - 'TMOUT': '86400', 13:11:27 INFO - 'USER': 'cltbld', 13:11:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:27 INFO - '_': '/tools/buildbot/bin/python'} 13:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:11:27 INFO - Cleaning up... 13:11:27 INFO - Return code: 0 13:11:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:27 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 0x7f6c01c38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', '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:11:27 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:11:27 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:11:27 INFO - Using env: {'DISPLAY': ':0', 13:11:27 INFO - 'HOME': '/home/cltbld', 13:11:27 INFO - 'LANG': 'en_US.UTF-8', 13:11:27 INFO - 'LANGUAGE': 'en_US:en', 13:11:27 INFO - 'LOGNAME': 'cltbld', 13:11:27 INFO - 'MAIL': '/var/mail/cltbld', 13:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:27 INFO - 'MOZ_NO_REMOTE': '1', 13:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:27 INFO - 'NO_EM_RESTART': '1', 13:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:27 INFO - 'PWD': '/builds/slave/test', 13:11:27 INFO - 'SHELL': '/bin/bash', 13:11:27 INFO - 'SHLVL': '1', 13:11:27 INFO - 'TERM': 'linux', 13:11:27 INFO - 'TMOUT': '86400', 13:11:27 INFO - 'USER': 'cltbld', 13:11:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:27 INFO - '_': '/tools/buildbot/bin/python'} 13:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:27 INFO - Downloading/unpacking flake8 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:11:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:11:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:11:30 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:11:30 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:11:30 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:11:30 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:11:30 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:11:30 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:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:30 INFO - no previously-included directories found matching 'docs/_build' 13:11:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:11:30 INFO - Running setup.py install for pep8 13:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:30 INFO - no previously-included directories found matching 'docs/_build' 13:11:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:11:30 INFO - Cleaning up... 13:11:30 INFO - Return code: 0 13:11:30 INFO - Running post-action listener: _resource_record_post_action 13:11:30 INFO - Running post-action listener: _start_resource_monitoring 13:11:30 INFO - Starting resource monitoring. 13:11:30 INFO - ##### 13:11:30 INFO - ##### Finished create-virtualenv step (success) 13:11:30 INFO - ##### 13:11:30 INFO - ##### 13:11:30 INFO - ##### Running install step. 13:11:30 INFO - ##### 13:11:30 INFO - Running pre-action listener: _resource_record_pre_action 13:11:30 INFO - Running main action method: install 13:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:30 INFO - Reading from file tmpfile_stdout 13:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:11:30 INFO - Reading from file tmpfile_stdout 13:11:30 INFO - Output received: 13:11:30 INFO - Usage: mozinstall [options] installer 13:11:30 INFO - Options: 13:11:30 INFO - -h, --help show this help message and exit 13:11:30 INFO - -d DEST, --destination=DEST 13:11:30 INFO - Directory to install application into. [default: 13:11:30 INFO - "/builds/slave/test"] 13:11:30 INFO - --app=APP Application being installed. [default: firefox] 13:11:30 INFO - mkdir: /builds/slave/test/build/application 13:11:30 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:11:30 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:11:47 INFO - Reading from file tmpfile_stdout 13:11:47 INFO - Output received: 13:11:47 INFO - /builds/slave/test/build/application/firefox/firefox 13:11:47 INFO - Running post-action listener: _resource_record_post_action 13:11:47 INFO - ##### 13:11:47 INFO - ##### Finished install step (success) 13:11:47 INFO - ##### 13:11:47 INFO - ##### 13:11:47 INFO - ##### Running run-tests step. 13:11:47 INFO - ##### 13:11:47 INFO - Running pre-action listener: _resource_record_pre_action 13:11:47 INFO - Running main action method: run_tests 13:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:47 INFO - Python 2.7.3 13:11:47 INFO - Return code: 0 13:11:47 INFO - grabbing minidump binary from tooltool 13:11:47 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:11:47 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 0x18752e0>, '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 0x17e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e15d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:47 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:11:47 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:11:47 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:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:48 INFO - Return code: 0 13:11:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:11:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:11:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:11:48 INFO - Return code: 0 13:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:11:48 INFO - Using env: {'DISPLAY': ':0', 13:11:48 INFO - 'HOME': '/home/cltbld', 13:11:48 INFO - 'LANG': 'en_US.UTF-8', 13:11:48 INFO - 'LANGUAGE': 'en_US:en', 13:11:48 INFO - 'LOGNAME': 'cltbld', 13:11:48 INFO - 'MAIL': '/var/mail/cltbld', 13:11:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:48 INFO - 'MOZ_NO_REMOTE': '1', 13:11:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:48 INFO - 'NO_EM_RESTART': '1', 13:11:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:48 INFO - 'PWD': '/builds/slave/test', 13:11:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:48 INFO - 'SHELL': '/bin/bash', 13:11:48 INFO - 'SHLVL': '1', 13:11:48 INFO - 'TERM': 'linux', 13:11:48 INFO - 'TMOUT': '86400', 13:11:48 INFO - 'USER': 'cltbld', 13:11:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860', 13:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:48 INFO - '_': '/tools/buildbot/bin/python'} 13:11:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLgF9l18TOGmAk7Wh3nDjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:11:49 INFO - mozversion application_buildid: 20160622103005 13:11:49 INFO - mozversion application_changeset: fdd1161f445604e720214966a7eaed8e7833ad9e 13:11:49 INFO - mozversion application_display_name: Nightly 13:11:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:49 INFO - mozversion application_name: Firefox 13:11:49 INFO - mozversion application_remotingname: firefox 13:11:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:11:49 INFO - mozversion application_vendor: Mozilla 13:11:49 INFO - mozversion application_version: 50.0a1 13:11:49 INFO - mozversion platform_buildid: 20160622103005 13:11:49 INFO - mozversion platform_changeset: fdd1161f445604e720214966a7eaed8e7833ad9e 13:11:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:11:49 INFO - mozversion platform_version: 50.0a1 13:11:49 INFO - using testdate: 1466626309 13:11:49 INFO - actual date: 1466626309 13:11:49 INFO - starting webserver on 'localhost:36199' 13:11:49 INFO - SUITE-START | Running 2 tests 13:11:49 INFO - TEST-START | dromaeo_css 13:11:49 INFO - operating with platform_type : linux_ 13:11:49 INFO - Initialising browser for dromaeo_css test... 13:11:49 INFO - TEST-INFO | started process 20696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeufPvG/profile http://localhost:36199/getInfo.html) 13:11:54 INFO - PROCESS | 20696 | __metrics Screen width/height:1600/1200 13:11:54 INFO - PROCESS | 20696 | colorDepth:24 13:11:54 INFO - PROCESS | 20696 | Browser inner width/height: 1024/697 13:11:54 INFO - PROCESS | 20696 | __metrics 13:11:54 ERROR - PROCESS | 20696 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:11:55 INFO - TEST-INFO | 20696: exit 0 13:11:55 INFO - Browser initialized. 13:11:55 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:55 INFO - TEST-INFO | started process 20814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeufPvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:07 INFO - PROCESS | 20814 | RSS: Main: 184717312 13:12:07 INFO - PROCESS | 20814 | 13:12:57 INFO - PROCESS | 20814 | 1466626377043 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:15:05 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36199/tests/dromaeo/cssquery-ext.html) 13:15:06 INFO - PROCESS | 20814 | RSS: Main: 188620800 13:15:06 INFO - PROCESS | 20814 | 13:18:08 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-ext.html (next: http://localhost:36199/tests/dromaeo/cssquery-jquery.html) 13:18:09 INFO - PROCESS | 20814 | RSS: Main: 188014592 13:18:09 INFO - PROCESS | 20814 | 13:21:11 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36199/tests/dromaeo/cssquery-mootools.html) 13:21:11 INFO - PROCESS | 20814 | RSS: Main: 189378560 13:21:11 INFO - PROCESS | 20814 | 13:24:13 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36199/tests/dromaeo/cssquery-prototype.html) 13:24:13 INFO - PROCESS | 20814 | RSS: Main: 187219968 13:24:13 INFO - PROCESS | 20814 | 13:27:16 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36199/tests/dromaeo/cssquery-yui.html) 13:27:17 INFO - PROCESS | 20814 | RSS: Main: 188719104 13:27:17 INFO - PROCESS | 20814 | 13:30:19 INFO - PROCESS | 20814 | Cycle 1(1): loaded http://localhost:36199/tests/dromaeo/cssquery-yui.html (next: http://localhost:36199/tests/dromaeo/cssquery-dojo.html) 13:30:20 INFO - PROCESS | 20814 | RSS: Main: 189562880 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | __start_tp_report 13:30:20 INFO - PROCESS | 20814 | _x_x_mozilla_page_load 13:30:20 INFO - PROCESS | 20814 | _x_x_mozilla_page_load_details 13:30:20 INFO - PROCESS | 20814 | |i|pagename|runs| 13:30:20 INFO - PROCESS | 20814 | |0;dojo.html;3099.1942095055288;3114.314850732838;3126.1559378967695;3130.5930229070223;3131.2171957010746;5321.361436627605;5354.812581559641;5413.26920865683;5446.782128714856;5506.64206826556;5323.148296272597;5339.439358867312;5407.405185429599;5409.513143817056;5424.620276580631;4873.171560834667;4909.042736666333;4943.6539442239055;5059.3169922060415;5093.286939828427;4826.565609095181;5006.824761133361;5045.848624541251;5049.823256186034;5077.187649976005;4875.780589873447;4908.01839632075;4942.9011419771405;4967.925481117786;4970.428400733889;4960.70235785854;4961.05739909416;4964.578010869081;4966.87582810429;5009.348784658007;4789.233722604366;4953.925691114636;4960.23116416956;4979.875503112415;4981;5276.287701160371;5298.92051619226;5384.084705600018;5406.378266499363;5421.810236641699;5779.797707080232;5793.797217097382;5804.042333015047;5805.709714514257;5812.88374232513;5523.116301391758;5789.160571717078;5822.0684690449325;5834.124881267801;5841.883162336772;5427.701476418795;5482.753276102585;5485.341758988907;5496.065668836308;5531.3362396512675;5898.203742494708;5934.851628709231;5937.762489500458;5973.581849270509;5987.9101813472835;5544.889102217933;5549.556035517149;5619.943800562024;5694.117411801095;5716.485516303553;5667.914981275284;5674.290713660793;5679.6876171810945;5695.259616249944;5716.514096301861;5508.669479831223;5633.042382794934;5679.914801277984;5683.857903552362;5729.455701708331;5541.2796336476;5675.829725108253;5695.772169113272;5806.390329015477;5816.2148110005455;4429.623482004065;4436.6672499562665;4444.822207111744;4447.555244475527;4487.842925497657;3943.11279962012;3945.934597658616;3953.1105501261986;3977.7016723745833;3992.0219546211365;5376.78492860289;5446.754896029688;5450.182472629137;5489.725513724298;5512.6968016758665;5705.62913410627;5739.622490602225;5742.684152371576;5745.85082983405;5810.651360918274;5497.5601951843755;5515.889682206333;5519.668819870821;5520.089185284463;5528.308961379827;4872.82945096927;4951.356323677971;4955.529224723646;4998.2502624606595;5026.421961474404;5965.105234214902;5991.340952495222;6042.395760423922;6043.516518678495;6051.152838602599;5684.204211410323;5857.150713146485;5863.442972917566;5867.618604790675;5880.94119058804;5948.8810223796145;5961.314448838266;5973.402659733992;6067.4539291462215;6075.696215189311;5711.543076553782;5740.483356497935;5756.079027355603;5760.135979603093;5761.164631128547;5652.293463317085;5709.172170035238;5869.090291004901;5870.354261031198;5870.559708022;5457;5532.6680399176175;5564.33228012641;5665;5706.857328566819;5506.339239291311;5511.200875872896;5517.117261238182;5539.7784088636;5583.050881350099;5431.239626452379;5450.945490545044;5471.5896307777875;5480.821623350998;5491.313585801775;5577.637453565505;5627.21219029328;5692.48767610917;5711.314642242957;5724.942750572608;5562.888742225052;5575.219469274386;5597.104463286018;5600.215969764317;5609.691466969192 13:30:20 INFO - PROCESS | 20814 | |1;ext.html;577.4687287695319;629.3109045595074;632.2065807411698;636.5925807483209;644.5101722690754;39831.40252896209;41596.79201603988;41669;41683.374749378745;45326.54673453265;43533;43854;44902.10195796082;44981.55018449815;45123.09753804922;8635.395522313425;8858.202761751441;8862;8862.86705699415;8865.202131808135;8681.392302538825;8782.297416206688;8803.251723603502;8826.735197944072;8833.911660883405;8762.956185219065;8880.067592902717;8891.822163556724;8927.776805579848;8927.821443571125;8099.716509922183;8104.797380065486;8131.227533384319;8150.307223885947;8871.600777965006;8761.299096072298;8863.290936725047;8866.246369058637;8866.778330541723;8879.822403551892;41035.794821026;41395;41498.37752433716;41529.1694166118;41539.584604153875;3319.026325890707;3349.698527132545;3372.800158860193;3468.3756923753713;3653.5433070866143;31398;31483.212919676964;31657.52513712296;31792.682073179436;32359.35281294361;3716.479692843004;3729.272791805599;3750.5686846012786;3792.58281589025;3825.101101241206;312285;313853;314135;314221;314534;56163.71918140383;56577.71711141418;56686.433135668114;56860.43139568551;56878;31265;31900.521492177635;31901;58481.415185847596;58763.412365875796;15211.467598634215;15454.459093931659;15514.844851551567;15534.766978495332;15547.378104875905;11993.88006119945;12001.099917506222;12016.699582510333;12089.214201076902;12102.092343074304;19059.809401905804;19075.61848763017;19168.424947251606;19206;19270.71093933592;6755.480016996136;6775.559588626724;6893.448524118058;6895.724171033103;6946.479014073863;912.9774652389366;1038.7299302181486;1088.385062439719;1097.5719469406938;1134.954601815918;31718.524222136686;31810.522842157385;31934.68065319317;31994.36011279808;32024.839875800473;1068.4230515521688;1075.833245846895;1134.9319040857574;1159.8608167019843;1245.912786104964;16302.429414970418;16613.169341532874;16849.831501685072;16901.577460563585;17029.829701702824;495432;499636;501967;502496;507534;56252;56252.71873640606;56401.43598564044;56562;56859.14711279334;1280.705437749323;1296.429570988762;1296.7730647136714;1315.3949183375755;1323.1597935311147;29856.25359366033;30328.241793955327;30918.845405772827;31766;31884;43733;43836.780816095714;43890.12219755523;43957.340639889786;44005.33991990059;328031;330894;331641;332269;333057;26997.325066873484;28463.146105616866;28512.85743571269;28524.286892827844;28610.570841437813;46329.3050604248;46365.304520432896;47473;47696.284555731;48577;40652.3902141474;40777;41289.1742165149;41362.79318603388;42191.57808421877;40366.59633403629;41250;41502.792486037375;41565.37651935284;41786.58213417827;39978.400323995746;40207.1958560833;40330.73949295845;40503;40875;34526.309473810885;36592.63407365892;36809.447858282685;37068;37131.25737485181;27280.59079113775;27597.31006724848;27787.722122778512;27829.44341113207;27847.58228626532 13:30:20 INFO - PROCESS | 20814 | |2;jquery.html;363.74901318090514;373.40628400842655;383.9500864887564;384.85760268700585;391.8080140731043;17337.21982510787;18565.90717046416;18620.53448663784;19227;19254.133563989635;11387.259828111168;11535.480903359348;11713.355765432898;11803.763924721501;11847.46686399112;4524.97737511312;5208.635395522315;5208.817691380802;5231.346081739783;5249.658772179815;5056.039352523027;5092.770825312869;5123.871903202413;5129.769160387791;5132.178851383779;5059.595232381401;5078.5937125029905;5150.459201783815;5174.974125129369;5225.477452254763;5085.389753229618;5088.465711100355;5115.693058416507;5153.098207813637;5168.819091331823;4825.420949486049;4963.950360496385;4977.601791856643;4997.450280469146;5011.6241281904;13036.152650077714;13392.665183370396;13412;22119.668204976937;22396.552068958692;2302.700648915647;2419.903203871843;2633.710291867893;2910.665273493554;2959.9260018499494;9408.247340212834;9891.851622225673;9934.403935763878;10003.549840257134;10069.748256293651;1830.1489807239564;1920.2702972870359;1974.3287282323936;1985.9772217308098;2010.6280338137492;80369.59815200887;81666;82574.58712706459;83087.5845620774;84092.57953710253;9926.702198934043;10186.745331366776;10641.574337026432;10642.893571064345;10653.57385704563;13952.093113947562;13970.930145349412;13978;14048.929755351362;14231.217283049531;7383.926160738324;7698.80668496384;7704.807379815437;7841.529508229524;7891.723789667334;7333.376662983599;7432.368248698813;7522.172561018284;7642.770716878391;7705.961470192613;4256.127493863751;4306.246406878784;4335.523092459827;4346.913061738811;4440.22296098188;1830.2678928428736;1864.3847530314963;1871.288910214137;1875.0905810681809;1894.488488108203;866.8786369908217;953.7472569769017;974.2352253480983;990.6285143071204;1045.8357038612778;18450.169742361624;19010.33463828787;19163.904180479007;19398.70901936472;19789.10949007298;978.7553111722069;992.5533509920565;1005.648023191877;1028.3469996552094;1034.6689059500889;10352.378857268588;10754.89245107539;10781.838272425919;10934.507947142398;10938.890611093946;426339;436179;452874;472353;479878;92711;95449.52275238579;96674;96788.51605742067;97412.51293743486;956.7799406136628;964.4984608003939;969.7866469376726;973.5764942250144;980.8283550378655;16551.91724041372;16898.23957921872;17173.141342933053;17222.483325500256;17641.29434822644;40157.598424015385;41825.79087104545;41972;42134.36798448087;43420.56579434165;53973.73013134909;54221.72889135529;56149;63043.369566305584;63862.68068659627;8284.875726864222;8352.958235208785;8480.660773568989;8537.31701463869;8620.224179823846;12095.929101088946;13092;13149.73700525965;13161.53934612284;13278.933605331911;11349.886501134883;11526.711832203926;11607.30356178632;11730.648080557597;12133.332666703416;11379.374134422686;11434.313941163557;11741.17811753169;11945.581904633644;12047.819282710941;10965.725856853642;11550.133739969704;11751.059915206592;11857.525698971944;11881.940590296994;8199.549024803693;8253.422260441712;8269.421140520106;8342.332613390792;8537.82924341522;8746.300295976434;11165.88834111681;11343.319400835977;11546.711332216762;11708.414579271173 13:30:20 INFO - PROCESS | 20814 | |3;mootools.html;1384.7161331926952;1437.8274607047156;1482.199612209407;1604.5908293385178;1626.292562735211;7225.169105552863;7948.205179482049;8346.582670866448;8503.107173746761;8513.063563008063;8382.245597896188;8416.83166336673;8448.535330556817;8476.025257095436;8494.490330580154;2264.852784569002;2305.6656784766283;2311.5492478966607;2315.2012555668266;2315.536892621474;2190.233418303597;2231.9888400557975;2244.461329280977;2244.674522194281;2250.2011785816044;2172.750133734617;2182.2689399051255;2185.530111026129;2220.755716871143;2250.85369450986;2171.554831259588;2182.639864422368;2201.4276288165192;2218.678291647718;2220.4670878989086;2196.0556960506974;2228.74369447514;2228.843980921336;2236.2955668964223;2241.2827895073583;8336.708215212439;8380.706675266398;8467.407281490297;8471.915280847174;8483.066862645166;4784.067106914154;4864.708117512961;4899.412070551521;4902.313676085351;4904.6321525885705;2947.9263018424494;3069.600951876264;3133.138386943586;3158.8578513966927;3172.682731726832;998.236349192868;1034.4000479721744;1045.8117538843005;1049.13446406714;1064.2337516987757;11136.109111271078;11172.162087843362;11202.607908723156;11231.719207019809;11240.606578769704;4282.250606143974;4300.225959327288;4315.805788739514;4357.586029327209;4387.956120438818;9529.332946693803;9533.90466095344;9542.379745316672;9597.896241932267;9613.51932403377;4838.03239352131;4854.975725121422;4870.464248932614;4874.171390863491;4878.341423907798;4032.9111139992037;4394.2969124939855;4498.415206023196;4533.138703646297;4697.671163018625;3833.9041523961564;3841.154945911895;3870.5161854768153;3911.041794760302;3960;1160.2168536238005;1216.8478940132484;1222.9449674764478;1228.121892846619;1235.9073069519643;775.3642013548948;893.6246776353947;913.4062859141611;933.1741408853078;937.2221056523069;5847.44449277318;5914.58597898143;6026.487748541335;6032.577719559588;6145.016797312409;402.48280958967587;428.8113230178774;437.65206660704814;440.7730019040197;440.9911801764011;4118.135191609736;4172.332426811696;4180.937285940713;4232.809523571385;4304.4834619845815;10331.94834025825;10572.101371383365;10597.682069537927;10627.202959778047;10677.9466102669;9937.80124397508;10359.482025898675;10534.736631584272;10593.788124237471;10625;7858.17489163641;7972.242636949481;8004.839903201903;8033.277005069572;8052.275295223458;6022.066579680157;6138.447539721446;6306.085617585516;6307.337729538516;6364.077208804605;9604.567794449127;9825.263105267277;9838.655647052605;9863.901360986298;9934.850977235492;9915;10019.799604008025;10028.398296102258;10028.899711002796;10095.646652367132;6258.374162583706;7433.442491813027;7622.237776222333;7723.806904827199;7883.093444253984;8210.794730131794;8266.380021498291;8275.213854683796;8329.875051874347;8374.413791034569;7058.188308344606;7368.336849683555;7440.516366436164;7472;7765.339946104645;7048.506604537633;7234.74678386254;7290.416766658548;7300.744473943387;7303.634818259172;6302.401271879165;6329.430351268408;6393.104965304768;6396.32838551964;6409.615423074631;4858.514148585114;4945.604351651931;5048.293238946624;5067.46791586878;5127.92308115386;4958.752062396794;5081.822136225214;5096.872578185575;5097.362829646294;5153.7165455900285 13:30:20 INFO - PROCESS | 20814 | |4;prototype.html;312.2599439328791;317.6601036890527;319.33100155174907;325.06057493842786;327.60196361420867;5477.287952566171;5531.25328080709;5716.942830571687;5741.626794258375;5742.770289188433;5551.77792888285;5587.161925711145;5649.887002259962;5687.090065589507;5694.5729070319685;4348.956510434895;4352.998810273639;4377.321515165155;4383.145286669101;4392.516823149451;4093.4678491796176;4314.525402205771;4334;4408.845690400836;4411.139827733593;4249.21389542934;4272.957270427302;4275.914481710364;4289.077848262623;4290.69965102443;4298.226319262531;4307.633851122659;4335.479742430913;4336.111097225062;4337.436133302682;3529.9294014119573;3786.5456145262747;3789.7157713171346;3799.525059367579;3807.9619203807883;5448.291722076145;5459.69971651563;5495.230667706524;5526.58550608706;5538.47384498472;4918.926216106761;4931.65478416511;4956.950430495721;4966.8758281043265;4982.77577509013;5574.470425309589;5886.352501224862;5925.73334199962;5959.135925290809;5959.374265702126;4091.672666186698;4110.561303543735;4124.628783409477;4132.380142978547;4137.482814648169;6107.786227482017;6137.202163718733;6144.938550614482;6182.814515564541;6211.658358790265;4017.738846974996;4154.605312495308;4157.937630935538;4168.812403441852;4180.728252663567;4192.182524407711;4203.159368126387;4210.410542524049;4212;4224.78876056196;4829.975850120727;4834.661573689808;4885.047415753965;4885.926711099336;4906.650671065486;5750.597458177887;5970.492508136857;5988.951933411636;6001.5198784097165;6026.186464827279;1439.8984776645875;1460.2114857976785;1461.8013229151993;1462.3638717158071;1468.2291796806549;890.9287257019553;922.2161163011386;925.5233554719325;951.1534734086669;953.7901661634429;5045.268436076748;5099.235114732745;5106.948930510722;5125.770764418393;5162.683515703547;5404.919016196776;5430.343745157686;5460.672359658353;5464.9453505465235;5525.281713377235;4945.455999840015;5005.776272248447;5168.8966220675375;5206.687598744087;5239.004589128053;2903.6080129182715;2956.654722101439;2960.6676995352177;2961.208468876299;2980.1953472562286;5540.612157149041;5560.888782224414;5572.247746554163;5594.440555944454;5610.775568977277;5329.360476742816;5344.040954697813;5460.426655201226;5488.7530061147345;5544.667319960815;5492.313460817398;5498.882930071871;5539.058360078716;5547;5584.274044374287;5382.67703937765;5402.513773760224;5412.404635490172;5444.727763611882;5654.717264136694;6036.909446358396;6129.2032035835055;6137.40427488865;6138.969305153446;6139.894818932635;5978.581499295007;6269.937300626935;6330.683465826783;6382.68086595659;6384.808455746335;4088.2232375848494;4204.768737719332;4206.768627725382;4210.59999300066;4224.619784219435;6053.576249662658;6063.696815159313;6102.9694851525455;6111;6134.325224225242;5836.824895253149;5933.813237352633;5970.194023806905;6003.90994135097;6035.698215089315;5751.913721294268;5793.623414478046;5856.824295271149;5886.23478947734;5946.235000724684;5719.942800571941;5727.627704199213;5739.311282646109;5752.597318187687;5807.274090738658;5668.688222147822;5889.350981725124;5907.616004959664;5910.497607703393;5929.229200203946;5701.061639042746;5720.11338242573;5722.828315150386;5730.656160630376;5747.453991870766 13:30:20 INFO - PROCESS | 20814 | |5;yui.html;632.4371309534514;737.9926200737991;770.6917233106757;821.4947807098632;821.5399376349249;13974.161550306975;16455.01269923804;16466.42367517134;16472.09403482808;16474.75287870683;14141;14168.149911005321;14189.858101418982;14228.217448040354;14271.643208919782;658.5982550644103;765.2729906588735;772.1043589436255;774.9535027898316;783.0994356490054;776.5379599138504;778.0313509680456;778.1518145221708;778.9844203115935;779.4310153587884;821.7616891101603;822.2394285286116;823.2919689067397;825.3108654273689;825.8100636853527;817.6034623207739;817.9468334558235;819.3895547816885;820.1798201798201;821.876718492225;592.7421571616361;596.1088173181079;596.4184919703255;598.0222336479886;599.143225187981;13709.45162193511;13822.654433639138;13860;13886.236257005861;13929.442822287096;14545.418183272657;14656.70686586273;15060.849391506054;15260.771088433683;15261.160636165117;12445.813312800316;12528.310942898137;12710.682232944158;12740;12802.16785908913;3785.9242815143816;3834.5398552173638;3848.7690738555775;3917.7257591968573;3930.1157239620857;78425.21574784236;78693.21306786916;78755.60622196853;78872.21127788763;79178;11173.497192626352;11175.666097651108;11224.887751122547;11656.88343116575;11865.466054027589;21558.353249402542;21580;21584.78415215859;21658.566828663337;21723.67414488784;8394;8403.495790252482;8576.571171441403;8664.523451210243;8756.25571826402;4514.210013247734;4770.427548694179;4780.737059461693;4853.19922212838;4977.527134922249;3269.199046233688;3409.914752131167;3424.092615456906;3430.2453460238708;3438.914027149291;582.7144699097412;586.296444266873;587.6386022596073;593.3799179856974;606.535999960031;730.397422126737;752.1680871518736;753.2693287511105;772.8106613879636;776.4021703288437;9748.9025109748;10012.599496020222;10044.698659040241;10183.643572474928;10233.897661023444;600.343053173245;648.7632014314742;678.8201126701429;680.4318394140848;704.5209257704707;4646.976765116153;4850.95149048505;4897.1674815281485;4909.828156014594;4911.703335101072;69192.6540367295;69480;105057;109005;112973;100439.80373384383;100615;100705.49647251863;100952;101218.46953826066;87505.12494875098;89171.55414222888;90184;91665.54167229254;92790.72092790801;9276.25789936817;9464.023677469208;9496.382735122195;9496.667616633385;9549.385570988816;50267.24599131089;52104.218436722724;52278.21582676339;53040;53181.734091329294;72233.63883180551;77601;78196;78254.21745782469;79483.60258198672;11157.410163303346;11248.325100493996;11263.605773797877;11296.152788540729;11749.765004699688;13439.260840653467;13452.663683407993;13622.523211687543;13713.451461941411;13764.242966636932;14373.64065898361;14597.635059123182;15034.924825375803;15688.294026768595;15701.607459813597;13804.585862424143;13921.58235252944;14085.929570352082;14134.363953622318;14161.221132837793;13621.523246686318;14139.293035347986;14313.427462901784;14767.113973161644;15074.321655525748;11064.557417703523;11345;11545.711357216136;11595.594154204562;11677.76644467089;11938.52245910154;11992.940035299767;12097.697557561132;12105.092118091003;12209.938950305546 13:30:20 INFO - PROCESS | 20814 | __end_tp_report 13:30:20 INFO - PROCESS | 20814 | __start_cc_report 13:30:20 INFO - PROCESS | 20814 | _x_x_mozilla_cycle_collect,342 13:30:20 INFO - PROCESS | 20814 | __end_cc_report 13:30:20 INFO - PROCESS | 20814 | __startTimestamp1466627420078__endTimestamp 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | ------- Summary: start ------- 13:30:20 INFO - PROCESS | 20814 | Number of tests: 6 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#0] dojo.html Cycles:165 Average:5365.64 Median:5520.09 stddev:599.43 (10.9%) stddev-sans-first:574.30 13:30:20 INFO - PROCESS | 20814 | Values: 3099.2 3114.3 3126.2 3130.6 3131.2 5321.4 5354.8 5413.3 5446.8 5506.6 5323.1 5339.4 5407.4 5409.5 5424.6 4873.2 4909.0 4943.7 5059.3 5093.3 4826.6 5006.8 5045.8 5049.8 5077.2 4875.8 4908.0 4942.9 4967.9 4970.4 4960.7 4961.1 4964.6 4966.9 5009.3 4789.2 4953.9 4960.2 4979.9 4981.0 5276.3 5298.9 5384.1 5406.4 5421.8 5779.8 5793.8 5804.0 5805.7 5812.9 5523.1 5789.2 5822.1 5834.1 5841.9 5427.7 5482.8 5485.3 5496.1 5531.3 5898.2 5934.9 5937.8 5973.6 5987.9 5544.9 5549.6 5619.9 5694.1 5716.5 5667.9 5674.3 5679.7 5695.3 5716.5 5508.7 5633.0 5679.9 5683.9 5729.5 5541.3 5675.8 5695.8 5806.4 5816.2 4429.6 4436.7 4444.8 4447.6 4487.8 3943.1 3945.9 3953.1 3977.7 3992.0 5376.8 5446.8 5450.2 5489.7 5512.7 5705.6 5739.6 5742.7 5745.9 5810.7 5497.6 5515.9 5519.7 5520.1 5528.3 4872.8 4951.4 4955.5 4998.3 5026.4 5965.1 5991.3 6042.4 6043.5 6051.2 5684.2 5857.2 5863.4 5867.6 5880.9 5948.9 5961.3 5973.4 6067.5 6075.7 5711.5 5740.5 5756.1 5760.1 5761.2 5652.3 5709.2 5869.1 5870.4 5870.6 5457.0 5532.7 5564.3 5665.0 5706.9 5506.3 5511.2 5517.1 5539.8 5583.1 5431.2 5450.9 5471.6 5480.8 5491.3 5577.6 5627.2 5692.5 5711.3 5724.9 5562.9 5575.2 5597.1 5600.2 5609.7 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#1] ext.html Cycles:180 Average:54333.73 Median:40348.67 stddev:103528.27 (256.6%) stddev-sans-first:103740.02 13:30:20 INFO - PROCESS | 20814 | Values: 577.5 629.3 632.2 636.6 644.5 39831.4 41596.8 41669.0 41683.4 45326.5 43533.0 43854.0 44902.1 44981.6 45123.1 8635.4 8858.2 8862.0 8862.9 8865.2 8681.4 8782.3 8803.3 8826.7 8833.9 8763.0 8880.1 8891.8 8927.8 8927.8 8099.7 8104.8 8131.2 8150.3 8871.6 8761.3 8863.3 8866.2 8866.8 8879.8 41035.8 41395.0 41498.4 41529.2 41539.6 3319.0 3349.7 3372.8 3468.4 3653.5 31398.0 31483.2 31657.5 31792.7 32359.4 3716.5 3729.3 3750.6 3792.6 3825.1 312285.0 313853.0 314135.0 314221.0 314534.0 56163.7 56577.7 56686.4 56860.4 56878.0 31265.0 31900.5 31901.0 58481.4 58763.4 15211.5 15454.5 15514.8 15534.8 15547.4 11993.9 12001.1 12016.7 12089.2 12102.1 19059.8 19075.6 19168.4 19206.0 19270.7 6755.5 6775.6 6893.4 6895.7 6946.5 913.0 1038.7 1088.4 1097.6 1135.0 31718.5 31810.5 31934.7 31994.4 32024.8 1068.4 1075.8 1134.9 1159.9 1245.9 16302.4 16613.2 16849.8 16901.6 17029.8 495432.0 499636.0 501967.0 502496.0 507534.0 56252.0 56252.7 56401.4 56562.0 56859.1 1280.7 1296.4 1296.8 1315.4 1323.2 29856.3 30328.2 30918.8 31766.0 31884.0 43733.0 43836.8 43890.1 43957.3 44005.3 328031.0 330894.0 331641.0 332269.0 333057.0 26997.3 28463.1 28512.9 28524.3 28610.6 46329.3 46365.3 47473.0 47696.3 48577.0 40652.4 40777.0 41289.2 41362.8 42191.6 40366.6 41250.0 41502.8 41565.4 41786.6 39978.4 40207.2 40330.7 40503.0 40875.0 34526.3 36592.6 36809.4 37068.0 37131.3 27280.6 27597.3 27787.7 27829.4 27847.6 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#2] jquery.html Cycles:180 Average:27518.37 Median:41898.90 stddev:75312.96 (179.7%) stddev-sans-first:75496.63 13:30:20 INFO - PROCESS | 20814 | Values: 363.7 373.4 384.0 384.9 391.8 17337.2 18565.9 18620.5 19227.0 19254.1 11387.3 11535.5 11713.4 11803.8 11847.5 4525.0 5208.6 5208.8 5231.3 5249.7 5056.0 5092.8 5123.9 5129.8 5132.2 5059.6 5078.6 5150.5 5175.0 5225.5 5085.4 5088.5 5115.7 5153.1 5168.8 4825.4 4964.0 4977.6 4997.5 5011.6 13036.2 13392.7 13412.0 22119.7 22396.6 2302.7 2419.9 2633.7 2910.7 2959.9 9408.2 9891.9 9934.4 10003.5 10069.7 1830.1 1920.3 1974.3 1986.0 2010.6 80369.6 81666.0 82574.6 83087.6 84092.6 9926.7 10186.7 10641.6 10642.9 10653.6 13952.1 13970.9 13978.0 14048.9 14231.2 7383.9 7698.8 7704.8 7841.5 7891.7 7333.4 7432.4 7522.2 7642.8 7706.0 4256.1 4306.2 4335.5 4346.9 4440.2 1830.3 1864.4 1871.3 1875.1 1894.5 866.9 953.7 974.2 990.6 1045.8 18450.2 19010.3 19163.9 19398.7 19789.1 978.8 992.6 1005.6 1028.3 1034.7 10352.4 10754.9 10781.8 10934.5 10938.9 426339.0 436179.0 452874.0 472353.0 479878.0 92711.0 95449.5 96674.0 96788.5 97412.5 956.8 964.5 969.8 973.6 980.8 16551.9 16898.2 17173.1 17222.5 17641.3 40157.6 41825.8 41972.0 42134.4 43420.6 53973.7 54221.7 56149.0 63043.4 63862.7 8284.9 8353.0 8480.7 8537.3 8620.2 12095.9 13092.0 13149.7 13161.5 13278.9 11349.9 11526.7 11607.3 11730.6 12133.3 11379.4 11434.3 11741.2 11945.6 12047.8 10965.7 11550.1 11751.1 11857.5 11881.9 8199.5 8253.4 8269.4 8342.3 8537.8 8746.3 11165.9 11343.3 11546.7 11708.4 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#3] mootools.html Cycles:180 Average:5540.25 Median:4861.61 stddev:3156.39 (64.9%) stddev-sans-first:3149.79 13:30:20 INFO - PROCESS | 20814 | Values: 1384.7 1437.8 1482.2 1604.6 1626.3 7225.2 7948.2 8346.6 8503.1 8513.1 8382.2 8416.8 8448.5 8476.0 8494.5 2264.9 2305.7 2311.5 2315.2 2315.5 2190.2 2232.0 2244.5 2244.7 2250.2 2172.8 2182.3 2185.5 2220.8 2250.9 2171.6 2182.6 2201.4 2218.7 2220.5 2196.1 2228.7 2228.8 2236.3 2241.3 8336.7 8380.7 8467.4 8471.9 8483.1 4784.1 4864.7 4899.4 4902.3 4904.6 2947.9 3069.6 3133.1 3158.9 3172.7 998.2 1034.4 1045.8 1049.1 1064.2 11136.1 11172.2 11202.6 11231.7 11240.6 4282.3 4300.2 4315.8 4357.6 4388.0 9529.3 9533.9 9542.4 9597.9 9613.5 4838.0 4855.0 4870.5 4874.2 4878.3 4032.9 4394.3 4498.4 4533.1 4697.7 3833.9 3841.2 3870.5 3911.0 3960.0 1160.2 1216.8 1222.9 1228.1 1235.9 775.4 893.6 913.4 933.2 937.2 5847.4 5914.6 6026.5 6032.6 6145.0 402.5 428.8 437.7 440.8 441.0 4118.1 4172.3 4180.9 4232.8 4304.5 10331.9 10572.1 10597.7 10627.2 10677.9 9937.8 10359.5 10534.7 10593.8 10625.0 7858.2 7972.2 8004.8 8033.3 8052.3 6022.1 6138.4 6306.1 6307.3 6364.1 9604.6 9825.3 9838.7 9863.9 9934.9 9915.0 10019.8 10028.4 10028.9 10095.6 6258.4 7433.4 7622.2 7723.8 7883.1 8210.8 8266.4 8275.2 8329.9 8374.4 7058.2 7368.3 7440.5 7472.0 7765.3 7048.5 7234.7 7290.4 7300.7 7303.6 6302.4 6329.4 6393.1 6396.3 6409.6 4858.5 4945.6 5048.3 5067.5 5127.9 4958.8 5081.8 5096.9 5097.4 5153.7 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#4] prototype.html Cycles:180 Average:4810.74 Median:5460.55 stddev:1429.35 (26.2%) stddev-sans-first:1392.91 13:30:20 INFO - PROCESS | 20814 | Values: 312.3 317.7 319.3 325.1 327.6 5477.3 5531.3 5716.9 5741.6 5742.8 5551.8 5587.2 5649.9 5687.1 5694.6 4349.0 4353.0 4377.3 4383.1 4392.5 4093.5 4314.5 4334.0 4408.8 4411.1 4249.2 4273.0 4275.9 4289.1 4290.7 4298.2 4307.6 4335.5 4336.1 4337.4 3529.9 3786.5 3789.7 3799.5 3808.0 5448.3 5459.7 5495.2 5526.6 5538.5 4918.9 4931.7 4957.0 4966.9 4982.8 5574.5 5886.4 5925.7 5959.1 5959.4 4091.7 4110.6 4124.6 4132.4 4137.5 6107.8 6137.2 6144.9 6182.8 6211.7 4017.7 4154.6 4157.9 4168.8 4180.7 4192.2 4203.2 4210.4 4212.0 4224.8 4830.0 4834.7 4885.0 4885.9 4906.7 5750.6 5970.5 5989.0 6001.5 6026.2 1439.9 1460.2 1461.8 1462.4 1468.2 890.9 922.2 925.5 951.2 953.8 5045.3 5099.2 5106.9 5125.8 5162.7 5404.9 5430.3 5460.7 5464.9 5525.3 4945.5 5005.8 5168.9 5206.7 5239.0 2903.6 2956.7 2960.7 2961.2 2980.2 5540.6 5560.9 5572.2 5594.4 5610.8 5329.4 5344.0 5460.4 5488.8 5544.7 5492.3 5498.9 5539.1 5547.0 5584.3 5382.7 5402.5 5412.4 5444.7 5654.7 6036.9 6129.2 6137.4 6139.0 6139.9 5978.6 6269.9 6330.7 6382.7 6384.8 4088.2 4204.8 4206.8 4210.6 4224.6 6053.6 6063.7 6103.0 6111.0 6134.3 5836.8 5933.8 5970.2 6003.9 6035.7 5751.9 5793.6 5856.8 5886.2 5946.2 5719.9 5727.6 5739.3 5752.6 5807.3 5668.7 5889.4 5907.6 5910.5 5929.2 5701.1 5720.1 5722.8 5730.7 5747.5 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - PROCESS | 20814 | [#5] yui.html Cycles:180 Average:20565.93 Median:3923.92 stddev:29056.48 (740.5%) stddev-sans-first:29099.44 13:30:20 INFO - PROCESS | 20814 | Values: 632.4 738.0 770.7 821.5 821.5 13974.2 16455.0 16466.4 16472.1 16474.8 14141.0 14168.1 14189.9 14228.2 14271.6 658.6 765.3 772.1 775.0 783.1 776.5 778.0 778.2 779.0 779.4 821.8 822.2 823.3 825.3 825.8 817.6 817.9 819.4 820.2 821.9 592.7 596.1 596.4 598.0 599.1 13709.5 13822.7 13860.0 13886.2 13929.4 14545.4 14656.7 15060.8 15260.8 15261.2 12445.8 12528.3 12710.7 12740.0 12802.2 3785.9 3834.5 3848.8 3917.7 3930.1 78425.2 78693.2 78755.6 78872.2 79178.0 11173.5 11175.7 11224.9 11656.9 11865.5 21558.4 21580.0 21584.8 21658.6 21723.7 8394.0 8403.5 8576.6 8664.5 8756.3 4514.2 4770.4 4780.7 4853.2 4977.5 3269.2 3409.9 3424.1 3430.2 3438.9 582.7 586.3 587.6 593.4 606.5 730.4 752.2 753.3 772.8 776.4 9748.9 10012.6 10044.7 10183.6 10233.9 600.3 648.8 678.8 680.4 704.5 4647.0 4851.0 4897.2 4909.8 4911.7 69192.7 69480.0 105057.0 109005.0 112973.0 100439.8 100615.0 100705.5 100952.0 101218.5 87505.1 89171.6 90184.0 91665.5 92790.7 9276.3 9464.0 9496.4 9496.7 9549.4 50267.2 52104.2 52278.2 53040.0 53181.7 72233.6 77601.0 78196.0 78254.2 79483.6 11157.4 11248.3 11263.6 11296.2 11749.8 13439.3 13452.7 13622.5 13713.5 13764.2 14373.6 14597.6 15034.9 15688.3 15701.6 13804.6 13921.6 14085.9 14134.4 14161.2 13621.5 14139.3 14313.4 14767.1 15074.3 11064.6 11345.0 11545.7 11595.6 11677.8 11938.5 11992.9 12097.7 12105.1 12209.9 13:30:20 INFO - PROCESS | 20814 | -------- Summary: end -------- 13:30:20 INFO - PROCESS | 20814 | 13:30:20 INFO - TEST-INFO | 20814: exit 0 13:30:20 INFO - TEST-OK | dromaeo_css | took 1111760ms 13:30:20 INFO - TEST-START | kraken 13:30:20 INFO - operating with platform_type : linux_ 13:30:20 INFO - Initialising browser for kraken test... 13:30:20 INFO - TEST-INFO | started process 21046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8RtHbE/profile http://localhost:36199/getInfo.html) 13:30:25 INFO - PROCESS | 21046 | __metrics Screen width/height:1600/1200 13:30:25 INFO - PROCESS | 21046 | colorDepth:24 13:30:25 INFO - PROCESS | 21046 | Browser inner width/height: 1024/697 13:30:25 INFO - PROCESS | 21046 | __metrics 13:30:26 ERROR - PROCESS | 21046 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:30:27 INFO - TEST-INFO | 21046: exit 0 13:30:27 INFO - Browser initialized. 13:30:27 INFO - Running cycle 1/1 for kraken test... 13:30:27 INFO - TEST-INFO | started process 21166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8RtHbE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:39 INFO - PROCESS | 21166 | RSS: Main: 185069568 13:30:39 INFO - PROCESS | 21166 | 13:30:41 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36199/tests/kraken/driver.html?testName=audio-beat-detection) 13:30:42 INFO - PROCESS | 21166 | RSS: Main: 191520768 13:30:42 INFO - PROCESS | 21166 | 13:30:45 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36199/tests/kraken/driver.html?testName=audio-dft) 13:30:45 INFO - PROCESS | 21166 | RSS: Main: 190496768 13:30:45 INFO - PROCESS | 21166 | 13:30:48 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36199/tests/kraken/driver.html?testName=audio-fft) 13:30:49 INFO - PROCESS | 21166 | RSS: Main: 185044992 13:30:49 INFO - PROCESS | 21166 | 13:30:51 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36199/tests/kraken/driver.html?testName=audio-oscillator) 13:30:52 INFO - PROCESS | 21166 | RSS: Main: 186368000 13:30:52 INFO - PROCESS | 21166 | 13:30:54 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:30:54 INFO - PROCESS | 21166 | RSS: Main: 186261504 13:30:54 INFO - PROCESS | 21166 | 13:30:58 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36199/tests/kraken/driver.html?testName=imaging-darkroom) 13:30:58 INFO - PROCESS | 21166 | RSS: Main: 186417152 13:30:58 INFO - PROCESS | 21166 | 13:31:02 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36199/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:02 INFO - PROCESS | 21166 | RSS: Main: 183668736 13:31:02 INFO - PROCESS | 21166 | 13:31:05 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36199/tests/kraken/driver.html?testName=json-parse-financial) 13:31:06 INFO - PROCESS | 21166 | RSS: Main: 184705024 13:31:06 INFO - PROCESS | 21166 | 13:31:07 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:08 INFO - PROCESS | 21166 | RSS: Main: 185372672 13:31:08 INFO - PROCESS | 21166 | 13:31:10 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:31:10 INFO - PROCESS | 21166 | RSS: Main: 185909248 13:31:10 INFO - PROCESS | 21166 | 13:31:12 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:31:13 INFO - PROCESS | 21166 | RSS: Main: 186368000 13:31:13 INFO - PROCESS | 21166 | 13:31:16 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:31:16 INFO - PROCESS | 21166 | RSS: Main: 186572800 13:31:16 INFO - PROCESS | 21166 | 13:31:19 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:31:20 INFO - PROCESS | 21166 | RSS: Main: 186568704 13:31:20 INFO - PROCESS | 21166 | 13:31:21 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:36199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36199/tests/kraken/driver.html?testName=ai-astar) 13:31:22 INFO - PROCESS | 21166 | RSS: Main: 187645952 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | __start_tp_report 13:31:22 INFO - PROCESS | 21166 | _x_x_mozilla_page_load 13:31:22 INFO - PROCESS | 21166 | _x_x_mozilla_page_load_details 13:31:22 INFO - PROCESS | 21166 | |i|pagename|runs| 13:31:22 INFO - PROCESS | 21166 | |0;ai-astar;104;112;108;112;113;112;112;110;110;111 13:31:22 INFO - PROCESS | 21166 | |1;audio-beat-detection;157;131;161;175;130;161;165;133;190;133 13:31:22 INFO - PROCESS | 21166 | |2;audio-dft;162;163;161;163;164;171;164;161;163;162 13:31:22 INFO - PROCESS | 21166 | |3;audio-fft;76;76;77;172;75;75;75;76;172;76 13:31:22 INFO - PROCESS | 21166 | |4;audio-oscillator;85;86;158;87;87;87;150;88;85;140 13:31:22 INFO - PROCESS | 21166 | |5;imaging-gaussian-blur;117;118;118;118;117;118;118;119;118;118 13:31:22 INFO - PROCESS | 21166 | |6;imaging-darkroom;147;147;148;149;148;147;149;146;148;148 13:31:22 INFO - PROCESS | 21166 | |7;imaging-desaturate;96;96;95;96;97;97;100;95;96;95 13:31:22 INFO - PROCESS | 21166 | |8;json-parse-financial;55;55;54;57;55;55;54;57;55;55 13:31:22 INFO - PROCESS | 21166 | |9;json-stringify-tinderbox;62;63;63;63;64;63;63;64;63;64 13:31:22 INFO - PROCESS | 21166 | |10;stanford-crypto-aes;79;78;78;79;86;79;80;81;90;79 13:31:22 INFO - PROCESS | 21166 | |11;stanford-crypto-ccm;135;138;134;136;131;133;131;131;126;124 13:31:22 INFO - PROCESS | 21166 | |12;stanford-crypto-pbkdf2;162;159;166;160;165;156;156;158;163;162 13:31:22 INFO - PROCESS | 21166 | |13;stanford-crypto-sha256-iterative;65;64;62;65;66;64;62;63;62;62 13:31:22 INFO - PROCESS | 21166 | __end_tp_report 13:31:22 INFO - PROCESS | 21166 | __start_cc_report 13:31:22 INFO - PROCESS | 21166 | _x_x_mozilla_cycle_collect,893 13:31:22 INFO - PROCESS | 21166 | __end_cc_report 13:31:22 INFO - PROCESS | 21166 | __startTimestamp1466627482140__endTimestamp 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | ------- Summary: start ------- 13:31:22 INFO - PROCESS | 21166 | Number of tests: 14 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:1.54 13:31:22 INFO - PROCESS | 21166 | Values: 104.0 112.0 108.0 112.0 113.0 112.0 112.0 110.0 110.0 111.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:161.00 stddev:20.95 (13.0%) stddev-sans-first:22.19 13:31:22 INFO - PROCESS | 21166 | Values: 157.0 131.0 161.0 175.0 130.0 161.0 165.0 133.0 190.0 133.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 13:31:22 INFO - PROCESS | 21166 | Values: 162.0 163.0 161.0 163.0 164.0 171.0 164.0 161.0 163.0 162.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.59 (53.4%) stddev-sans-first:42.46 13:31:22 INFO - PROCESS | 21166 | Values: 76.0 76.0 77.0 172.0 75.0 75.0 75.0 76.0 172.0 76.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:86.50 stddev:30.70 (35.5%) stddev-sans-first:31.67 13:31:22 INFO - PROCESS | 21166 | Values: 85.0 86.0 158.0 87.0 87.0 87.0 150.0 88.0 85.0 140.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:31:22 INFO - PROCESS | 21166 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 118.0 119.0 118.0 118.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 13:31:22 INFO - PROCESS | 21166 | Values: 147.0 147.0 148.0 149.0 148.0 147.0 149.0 146.0 148.0 148.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 13:31:22 INFO - PROCESS | 21166 | Values: 96.0 96.0 95.0 96.0 97.0 97.0 100.0 95.0 96.0 95.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 13:31:22 INFO - PROCESS | 21166 | Values: 55.0 55.0 54.0 57.0 55.0 55.0 54.0 57.0 55.0 55.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 13:31:22 INFO - PROCESS | 21166 | Values: 62.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 64.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:79.50 stddev:3.96 (5.0%) stddev-sans-first:4.14 13:31:22 INFO - PROCESS | 21166 | Values: 79.0 78.0 78.0 79.0 86.0 79.0 80.0 81.0 90.0 79.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:133.50 stddev:4.33 (3.2%) stddev-sans-first:4.45 13:31:22 INFO - PROCESS | 21166 | Values: 135.0 138.0 134.0 136.0 131.0 133.0 131.0 131.0 126.0 124.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:162.00 stddev:3.50 (2.2%) stddev-sans-first:3.68 13:31:22 INFO - PROCESS | 21166 | Values: 162.0 159.0 166.0 160.0 165.0 156.0 156.0 158.0 163.0 162.0 13:31:22 INFO - PROCESS | 21166 | 13:31:22 INFO - PROCESS | 21166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.51 (2.4%) stddev-sans-first:1.50 13:31:22 INFO - PROCESS | 21166 | Values: 65.0 64.0 62.0 65.0 66.0 64.0 62.0 63.0 62.0 62.0 13:31:22 INFO - PROCESS | 21166 | -------- Summary: end -------- 13:31:22 INFO - PROCESS | 21166 | 13:31:23 INFO - TEST-INFO | 21166: exit 0 13:31:23 INFO - TEST-OK | kraken | took 62267ms 13:31:23 INFO - SUITE-END | took 1174s 13:31:23 INFO - Completed test suite (00:19:34) 13:31:23 INFO - javascript benchmark 13:31:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7092.6181017955705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.1942095055288, 3114.314850732838, 3126.1559378967695, 3130.5930229070223, 3131.2171957010746, 5321.361436627605, 5354.812581559641, 5413.26920865683, 5446.782128714856, 5506.64206826556, 5323.148296272597, 5339.439358867312, 5407.405185429599, 5409.513143817056, 5424.620276580631, 4873.171560834667, 4909.042736666333, 4943.6539442239055, 5059.3169922060415, 5093.286939828427, 4826.565609095181, 5006.824761133361, 5045.848624541251, 5049.823256186034, 5077.187649976005, 4875.780589873447, 4908.01839632075, 4942.9011419771405, 4967.925481117786, 4970.428400733889, 4960.70235785854, 4961.05739909416, 4964.578010869081, 4966.87582810429, 5009.348784658007, 4789.233722604366, 4953.925691114636, 4960.23116416956, 4979.875503112415, 4981.0, 5276.287701160371, 5298.92051619226, 5384.084705600018, 5406.378266499363, 5421.810236641699, 5779.797707080232, 5793.797217097382, 5804.042333015047, 5805.709714514257, 5812.88374232513, 5523.116301391758, 5789.160571717078, 5822.0684690449325, 5834.124881267801, 5841.883162336772, 5427.701476418795, 5482.753276102585, 5485.341758988907, 5496.065668836308, 5531.3362396512675, 5898.203742494708, 5934.851628709231, 5937.762489500458, 5973.581849270509, 5987.9101813472835, 5544.889102217933, 5549.556035517149, 5619.943800562024, 5694.117411801095, 5716.485516303553, 5667.914981275284, 5674.290713660793, 5679.6876171810945, 5695.259616249944, 5716.514096301861, 5508.669479831223, 5633.042382794934, 5679.914801277984, 5683.857903552362, 5729.455701708331, 5541.2796336476, 5675.829725108253, 5695.772169113272, 5806.390329015477, 5816.2148110005455, 4429.623482004065, 4436.6672499562665, 4444.822207111744, 4447.555244475527, 4487.842925497657, 3943.11279962012, 3945.934597658616, 3953.1105501261986, 3977.7016723745833, 3992.0219546211365, 5376.78492860289, 5446.754896029688, 5450.182472629137, 5489.725513724298, 5512.6968016758665, 5705.62913410627, 5739.622490602225, 5742.684152371576, 5745.85082983405, 5810.651360918274, 5497.5601951843755, 5515.889682206333, 5519.668819870821, 5520.089185284463, 5528.308961379827, 4872.82945096927, 4951.356323677971, 4955.529224723646, 4998.2502624606595, 5026.421961474404, 5965.105234214902, 5991.340952495222, 6042.395760423922, 6043.516518678495, 6051.152838602599, 5684.204211410323, 5857.150713146485, 5863.442972917566, 5867.618604790675, 5880.94119058804, 5948.8810223796145, 5961.314448838266, 5973.402659733992, 6067.4539291462215, 6075.696215189311, 5711.543076553782, 5740.483356497935, 5756.079027355603, 5760.135979603093, 5761.164631128547, 5652.293463317085, 5709.172170035238, 5869.090291004901, 5870.354261031198, 5870.559708022, 5457.0, 5532.6680399176175, 5564.33228012641, 5665.0, 5706.857328566819, 5506.339239291311, 5511.200875872896, 5517.117261238182, 5539.7784088636, 5583.050881350099, 5431.239626452379, 5450.945490545044, 5471.5896307777875, 5480.821623350998, 5491.313585801775, 5577.637453565505, 5627.21219029328, 5692.48767610917, 5711.314642242957, 5724.942750572608, 5562.888742225052, 5575.219469274386, 5597.104463286018, 5600.215969764317, 5609.691466969192], "value": 5325.735413897812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4687287695319, 629.3109045595074, 632.2065807411698, 636.5925807483209, 644.5101722690754, 39831.40252896209, 41596.79201603988, 41669.0, 41683.374749378745, 45326.54673453265, 43533.0, 43854.0, 44902.10195796082, 44981.55018449815, 45123.09753804922, 8635.395522313425, 8858.202761751441, 8862.0, 8862.86705699415, 8865.202131808135, 8681.392302538825, 8782.297416206688, 8803.251723603502, 8826.735197944072, 8833.911660883405, 8762.956185219065, 8880.067592902717, 8891.822163556724, 8927.776805579848, 8927.821443571125, 8099.716509922183, 8104.797380065486, 8131.227533384319, 8150.307223885947, 8871.600777965006, 8761.299096072298, 8863.290936725047, 8866.246369058637, 8866.778330541723, 8879.822403551892, 41035.794821026, 41395.0, 41498.37752433716, 41529.1694166118, 41539.584604153875, 3319.026325890707, 3349.698527132545, 3372.800158860193, 3468.3756923753713, 3653.5433070866143, 31398.0, 31483.212919676964, 31657.52513712296, 31792.682073179436, 32359.35281294361, 3716.479692843004, 3729.272791805599, 3750.5686846012786, 3792.58281589025, 3825.101101241206, 312285.0, 313853.0, 314135.0, 314221.0, 314534.0, 56163.71918140383, 56577.71711141418, 56686.433135668114, 56860.43139568551, 56878.0, 31265.0, 31900.521492177635, 31901.0, 58481.415185847596, 58763.412365875796, 15211.467598634215, 15454.459093931659, 15514.844851551567, 15534.766978495332, 15547.378104875905, 11993.88006119945, 12001.099917506222, 12016.699582510333, 12089.214201076902, 12102.092343074304, 19059.809401905804, 19075.61848763017, 19168.424947251606, 19206.0, 19270.71093933592, 6755.480016996136, 6775.559588626724, 6893.448524118058, 6895.724171033103, 6946.479014073863, 912.9774652389366, 1038.7299302181486, 1088.385062439719, 1097.5719469406938, 1134.954601815918, 31718.524222136686, 31810.522842157385, 31934.68065319317, 31994.36011279808, 32024.839875800473, 1068.4230515521688, 1075.833245846895, 1134.9319040857574, 1159.8608167019843, 1245.912786104964, 16302.429414970418, 16613.169341532874, 16849.831501685072, 16901.577460563585, 17029.829701702824, 495432.0, 499636.0, 501967.0, 502496.0, 507534.0, 56252.0, 56252.71873640606, 56401.43598564044, 56562.0, 56859.14711279334, 1280.705437749323, 1296.429570988762, 1296.7730647136714, 1315.3949183375755, 1323.1597935311147, 29856.25359366033, 30328.241793955327, 30918.845405772827, 31766.0, 31884.0, 43733.0, 43836.780816095714, 43890.12219755523, 43957.340639889786, 44005.33991990059, 328031.0, 330894.0, 331641.0, 332269.0, 333057.0, 26997.325066873484, 28463.146105616866, 28512.85743571269, 28524.286892827844, 28610.570841437813, 46329.3050604248, 46365.304520432896, 47473.0, 47696.284555731, 48577.0, 40652.3902141474, 40777.0, 41289.1742165149, 41362.79318603388, 42191.57808421877, 40366.59633403629, 41250.0, 41502.792486037375, 41565.37651935284, 41786.58213417827, 39978.400323995746, 40207.1958560833, 40330.73949295845, 40503.0, 40875.0, 34526.309473810885, 36592.63407365892, 36809.447858282685, 37068.0, 37131.25737485181, 27280.59079113775, 27597.31006724848, 27787.722122778512, 27829.44341113207, 27847.58228626532], "value": 19272.96656260433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.74901318090514, 373.40628400842655, 383.9500864887564, 384.85760268700585, 391.8080140731043, 17337.21982510787, 18565.90717046416, 18620.53448663784, 19227.0, 19254.133563989635, 11387.259828111168, 11535.480903359348, 11713.355765432898, 11803.763924721501, 11847.46686399112, 4524.97737511312, 5208.635395522315, 5208.817691380802, 5231.346081739783, 5249.658772179815, 5056.039352523027, 5092.770825312869, 5123.871903202413, 5129.769160387791, 5132.178851383779, 5059.595232381401, 5078.5937125029905, 5150.459201783815, 5174.974125129369, 5225.477452254763, 5085.389753229618, 5088.465711100355, 5115.693058416507, 5153.098207813637, 5168.819091331823, 4825.420949486049, 4963.950360496385, 4977.601791856643, 4997.450280469146, 5011.6241281904, 13036.152650077714, 13392.665183370396, 13412.0, 22119.668204976937, 22396.552068958692, 2302.700648915647, 2419.903203871843, 2633.710291867893, 2910.665273493554, 2959.9260018499494, 9408.247340212834, 9891.851622225673, 9934.403935763878, 10003.549840257134, 10069.748256293651, 1830.1489807239564, 1920.2702972870359, 1974.3287282323936, 1985.9772217308098, 2010.6280338137492, 80369.59815200887, 81666.0, 82574.58712706459, 83087.5845620774, 84092.57953710253, 9926.702198934043, 10186.745331366776, 10641.574337026432, 10642.893571064345, 10653.57385704563, 13952.093113947562, 13970.930145349412, 13978.0, 14048.929755351362, 14231.217283049531, 7383.926160738324, 7698.80668496384, 7704.807379815437, 7841.529508229524, 7891.723789667334, 7333.376662983599, 7432.368248698813, 7522.172561018284, 7642.770716878391, 7705.961470192613, 4256.127493863751, 4306.246406878784, 4335.523092459827, 4346.913061738811, 4440.22296098188, 1830.2678928428736, 1864.3847530314963, 1871.288910214137, 1875.0905810681809, 1894.488488108203, 866.8786369908217, 953.7472569769017, 974.2352253480983, 990.6285143071204, 1045.8357038612778, 18450.169742361624, 19010.33463828787, 19163.904180479007, 19398.70901936472, 19789.10949007298, 978.7553111722069, 992.5533509920565, 1005.648023191877, 1028.3469996552094, 1034.6689059500889, 10352.378857268588, 10754.89245107539, 10781.838272425919, 10934.507947142398, 10938.890611093946, 426339.0, 436179.0, 452874.0, 472353.0, 479878.0, 92711.0, 95449.52275238579, 96674.0, 96788.51605742067, 97412.51293743486, 956.7799406136628, 964.4984608003939, 969.7866469376726, 973.5764942250144, 980.8283550378655, 16551.91724041372, 16898.23957921872, 17173.141342933053, 17222.483325500256, 17641.29434822644, 40157.598424015385, 41825.79087104545, 41972.0, 42134.36798448087, 43420.56579434165, 53973.73013134909, 54221.72889135529, 56149.0, 63043.369566305584, 63862.68068659627, 8284.875726864222, 8352.958235208785, 8480.660773568989, 8537.31701463869, 8620.224179823846, 12095.929101088946, 13092.0, 13149.73700525965, 13161.53934612284, 13278.933605331911, 11349.886501134883, 11526.711832203926, 11607.30356178632, 11730.648080557597, 12133.332666703416, 11379.374134422686, 11434.313941163557, 11741.17811753169, 11945.581904633644, 12047.819282710941, 10965.725856853642, 11550.133739969704, 11751.059915206592, 11857.525698971944, 11881.940590296994, 8199.549024803693, 8253.422260441712, 8269.421140520106, 8342.332613390792, 8537.82924341522, 8746.300295976434, 11165.88834111681, 11343.319400835977, 11546.711332216762, 11708.414579271173], "value": 8730.199385725504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.7161331926952, 1437.8274607047156, 1482.199612209407, 1604.5908293385178, 1626.292562735211, 7225.169105552863, 7948.205179482049, 8346.582670866448, 8503.107173746761, 8513.063563008063, 8382.245597896188, 8416.83166336673, 8448.535330556817, 8476.025257095436, 8494.490330580154, 2264.852784569002, 2305.6656784766283, 2311.5492478966607, 2315.2012555668266, 2315.536892621474, 2190.233418303597, 2231.9888400557975, 2244.461329280977, 2244.674522194281, 2250.2011785816044, 2172.750133734617, 2182.2689399051255, 2185.530111026129, 2220.755716871143, 2250.85369450986, 2171.554831259588, 2182.639864422368, 2201.4276288165192, 2218.678291647718, 2220.4670878989086, 2196.0556960506974, 2228.74369447514, 2228.843980921336, 2236.2955668964223, 2241.2827895073583, 8336.708215212439, 8380.706675266398, 8467.407281490297, 8471.915280847174, 8483.066862645166, 4784.067106914154, 4864.708117512961, 4899.412070551521, 4902.313676085351, 4904.6321525885705, 2947.9263018424494, 3069.600951876264, 3133.138386943586, 3158.8578513966927, 3172.682731726832, 998.236349192868, 1034.4000479721744, 1045.8117538843005, 1049.13446406714, 1064.2337516987757, 11136.109111271078, 11172.162087843362, 11202.607908723156, 11231.719207019809, 11240.606578769704, 4282.250606143974, 4300.225959327288, 4315.805788739514, 4357.586029327209, 4387.956120438818, 9529.332946693803, 9533.90466095344, 9542.379745316672, 9597.896241932267, 9613.51932403377, 4838.03239352131, 4854.975725121422, 4870.464248932614, 4874.171390863491, 4878.341423907798, 4032.9111139992037, 4394.2969124939855, 4498.415206023196, 4533.138703646297, 4697.671163018625, 3833.9041523961564, 3841.154945911895, 3870.5161854768153, 3911.041794760302, 3960.0, 1160.2168536238005, 1216.8478940132484, 1222.9449674764478, 1228.121892846619, 1235.9073069519643, 775.3642013548948, 893.6246776353947, 913.4062859141611, 933.1741408853078, 937.2221056523069, 5847.44449277318, 5914.58597898143, 6026.487748541335, 6032.577719559588, 6145.016797312409, 402.48280958967587, 428.8113230178774, 437.65206660704814, 440.7730019040197, 440.9911801764011, 4118.135191609736, 4172.332426811696, 4180.937285940713, 4232.809523571385, 4304.4834619845815, 10331.94834025825, 10572.101371383365, 10597.682069537927, 10627.202959778047, 10677.9466102669, 9937.80124397508, 10359.482025898675, 10534.736631584272, 10593.788124237471, 10625.0, 7858.17489163641, 7972.242636949481, 8004.839903201903, 8033.277005069572, 8052.275295223458, 6022.066579680157, 6138.447539721446, 6306.085617585516, 6307.337729538516, 6364.077208804605, 9604.567794449127, 9825.263105267277, 9838.655647052605, 9863.901360986298, 9934.850977235492, 9915.0, 10019.799604008025, 10028.398296102258, 10028.899711002796, 10095.646652367132, 6258.374162583706, 7433.442491813027, 7622.237776222333, 7723.806904827199, 7883.093444253984, 8210.794730131794, 8266.380021498291, 8275.213854683796, 8329.875051874347, 8374.413791034569, 7058.188308344606, 7368.336849683555, 7440.516366436164, 7472.0, 7765.339946104645, 7048.506604537633, 7234.74678386254, 7290.416766658548, 7300.744473943387, 7303.634818259172, 6302.401271879165, 6329.430351268408, 6393.104965304768, 6396.32838551964, 6409.615423074631, 4858.514148585114, 4945.604351651931, 5048.293238946624, 5067.46791586878, 5127.92308115386, 4958.752062396794, 5081.822136225214, 5096.872578185575, 5097.362829646294, 5153.7165455900285], "value": 4352.028974460173, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.2599439328791, 317.6601036890527, 319.33100155174907, 325.06057493842786, 327.60196361420867, 5477.287952566171, 5531.25328080709, 5716.942830571687, 5741.626794258375, 5742.770289188433, 5551.77792888285, 5587.161925711145, 5649.887002259962, 5687.090065589507, 5694.5729070319685, 4348.956510434895, 4352.998810273639, 4377.321515165155, 4383.145286669101, 4392.516823149451, 4093.4678491796176, 4314.525402205771, 4334.0, 4408.845690400836, 4411.139827733593, 4249.21389542934, 4272.957270427302, 4275.914481710364, 4289.077848262623, 4290.69965102443, 4298.226319262531, 4307.633851122659, 4335.479742430913, 4336.111097225062, 4337.436133302682, 3529.9294014119573, 3786.5456145262747, 3789.7157713171346, 3799.525059367579, 3807.9619203807883, 5448.291722076145, 5459.69971651563, 5495.230667706524, 5526.58550608706, 5538.47384498472, 4918.926216106761, 4931.65478416511, 4956.950430495721, 4966.8758281043265, 4982.77577509013, 5574.470425309589, 5886.352501224862, 5925.73334199962, 5959.135925290809, 5959.374265702126, 4091.672666186698, 4110.561303543735, 4124.628783409477, 4132.380142978547, 4137.482814648169, 6107.786227482017, 6137.202163718733, 6144.938550614482, 6182.814515564541, 6211.658358790265, 4017.738846974996, 4154.605312495308, 4157.937630935538, 4168.812403441852, 4180.728252663567, 4192.182524407711, 4203.159368126387, 4210.410542524049, 4212.0, 4224.78876056196, 4829.975850120727, 4834.661573689808, 4885.047415753965, 4885.926711099336, 4906.650671065486, 5750.597458177887, 5970.492508136857, 5988.951933411636, 6001.5198784097165, 6026.186464827279, 1439.8984776645875, 1460.2114857976785, 1461.8013229151993, 1462.3638717158071, 1468.2291796806549, 890.9287257019553, 922.2161163011386, 925.5233554719325, 951.1534734086669, 953.7901661634429, 5045.268436076748, 5099.235114732745, 5106.948930510722, 5125.770764418393, 5162.683515703547, 5404.919016196776, 5430.343745157686, 5460.672359658353, 5464.9453505465235, 5525.281713377235, 4945.455999840015, 5005.776272248447, 5168.8966220675375, 5206.687598744087, 5239.004589128053, 2903.6080129182715, 2956.654722101439, 2960.6676995352177, 2961.208468876299, 2980.1953472562286, 5540.612157149041, 5560.888782224414, 5572.247746554163, 5594.440555944454, 5610.775568977277, 5329.360476742816, 5344.040954697813, 5460.426655201226, 5488.7530061147345, 5544.667319960815, 5492.313460817398, 5498.882930071871, 5539.058360078716, 5547.0, 5584.274044374287, 5382.67703937765, 5402.513773760224, 5412.404635490172, 5444.727763611882, 5654.717264136694, 6036.909446358396, 6129.2032035835055, 6137.40427488865, 6138.969305153446, 6139.894818932635, 5978.581499295007, 6269.937300626935, 6330.683465826783, 6382.68086595659, 6384.808455746335, 4088.2232375848494, 4204.768737719332, 4206.768627725382, 4210.59999300066, 4224.619784219435, 6053.576249662658, 6063.696815159313, 6102.9694851525455, 6111.0, 6134.325224225242, 5836.824895253149, 5933.813237352633, 5970.194023806905, 6003.90994135097, 6035.698215089315, 5751.913721294268, 5793.623414478046, 5856.824295271149, 5886.23478947734, 5946.235000724684, 5719.942800571941, 5727.627704199213, 5739.311282646109, 5752.597318187687, 5807.274090738658, 5668.688222147822, 5889.350981725124, 5907.616004959664, 5910.497607703393, 5929.229200203946, 5701.061639042746, 5720.11338242573, 5722.828315150386, 5730.656160630376, 5747.453991870766], "value": 4345.315029415943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.4371309534514, 737.9926200737991, 770.6917233106757, 821.4947807098632, 821.5399376349249, 13974.161550306975, 16455.01269923804, 16466.42367517134, 16472.09403482808, 16474.75287870683, 14141.0, 14168.149911005321, 14189.858101418982, 14228.217448040354, 14271.643208919782, 658.5982550644103, 765.2729906588735, 772.1043589436255, 774.9535027898316, 783.0994356490054, 776.5379599138504, 778.0313509680456, 778.1518145221708, 778.9844203115935, 779.4310153587884, 821.7616891101603, 822.2394285286116, 823.2919689067397, 825.3108654273689, 825.8100636853527, 817.6034623207739, 817.9468334558235, 819.3895547816885, 820.1798201798201, 821.876718492225, 592.7421571616361, 596.1088173181079, 596.4184919703255, 598.0222336479886, 599.143225187981, 13709.45162193511, 13822.654433639138, 13860.0, 13886.236257005861, 13929.442822287096, 14545.418183272657, 14656.70686586273, 15060.849391506054, 15260.771088433683, 15261.160636165117, 12445.813312800316, 12528.310942898137, 12710.682232944158, 12740.0, 12802.16785908913, 3785.9242815143816, 3834.5398552173638, 3848.7690738555775, 3917.7257591968573, 3930.1157239620857, 78425.21574784236, 78693.21306786916, 78755.60622196853, 78872.21127788763, 79178.0, 11173.497192626352, 11175.666097651108, 11224.887751122547, 11656.88343116575, 11865.466054027589, 21558.353249402542, 21580.0, 21584.78415215859, 21658.566828663337, 21723.67414488784, 8394.0, 8403.495790252482, 8576.571171441403, 8664.523451210243, 8756.25571826402, 4514.210013247734, 4770.427548694179, 4780.737059461693, 4853.19922212838, 4977.527134922249, 3269.199046233688, 3409.914752131167, 3424.092615456906, 3430.2453460238708, 3438.914027149291, 582.7144699097412, 586.296444266873, 587.6386022596073, 593.3799179856974, 606.535999960031, 730.397422126737, 752.1680871518736, 753.2693287511105, 772.8106613879636, 776.4021703288437, 9748.9025109748, 10012.599496020222, 10044.698659040241, 10183.643572474928, 10233.897661023444, 600.343053173245, 648.7632014314742, 678.8201126701429, 680.4318394140848, 704.5209257704707, 4646.976765116153, 4850.95149048505, 4897.1674815281485, 4909.828156014594, 4911.703335101072, 69192.6540367295, 69480.0, 105057.0, 109005.0, 112973.0, 100439.80373384383, 100615.0, 100705.49647251863, 100952.0, 101218.46953826066, 87505.12494875098, 89171.55414222888, 90184.0, 91665.54167229254, 92790.72092790801, 9276.25789936817, 9464.023677469208, 9496.382735122195, 9496.667616633385, 9549.385570988816, 50267.24599131089, 52104.218436722724, 52278.21582676339, 53040.0, 53181.734091329294, 72233.63883180551, 77601.0, 78196.0, 78254.21745782469, 79483.60258198672, 11157.410163303346, 11248.325100493996, 11263.605773797877, 11296.152788540729, 11749.765004699688, 13439.260840653467, 13452.663683407993, 13622.523211687543, 13713.451461941411, 13764.242966636932, 14373.64065898361, 14597.635059123182, 15034.924825375803, 15688.294026768595, 15701.607459813597, 13804.585862424143, 13921.58235252944, 14085.929570352082, 14134.363953622318, 14161.221132837793, 13621.523246686318, 14139.293035347986, 14313.427462901784, 14767.113973161644, 15074.321655525748, 11064.557417703523, 11345.0, 11545.711357216136, 11595.594154204562, 11677.76644467089, 11938.52245910154, 11992.940035299767, 12097.697557561132, 12105.092118091003, 12209.938950305546], "value": 7511.559597199895, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 108.0, 112.0, 113.0, 112.0, 112.0, 110.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 161.0, 175.0, 130.0, 161.0, 165.0, 133.0, 190.0, 133.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 164.0, 171.0, 164.0, 161.0, 163.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 172.0, 75.0, 75.0, 75.0, 76.0, 172.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 158.0, 87.0, 87.0, 87.0, 150.0, 88.0, 85.0, 140.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 149.0, 146.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 100.0, 95.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 57.0, 55.0, 55.0, 54.0, 57.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 86.0, 79.0, 80.0, 81.0, 90.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 134.0, 136.0, 131.0, 133.0, 131.0, 131.0, 126.0, 124.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 166.0, 160.0, 165.0, 156.0, 156.0, 158.0, 163.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 65.0, 66.0, 64.0, 62.0, 63.0, 62.0, 62.0], "value": 63.5, "unit": "score"}]}]} 13:31:23 INFO - Return code: 0 13:31:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:31:23 ERROR - # TBPL SUCCESS # 13:31:23 INFO - Running post-action listener: _resource_record_post_action 13:31:23 INFO - ##### 13:31:23 INFO - ##### Finished run-tests step (success) 13:31:23 INFO - ##### 13:31:23 INFO - Running post-run listener: _resource_record_post_run 13:31:23 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 4096; Write bytes: 550924288; Read time: 8; Write time: 581888 13:31:23 INFO - TinderboxPrint: CPU usage
13.5% 13:31:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:31:23 INFO - TinderboxPrint: I/O write bytes / time
550,924,288 / 581,888 13:31:23 INFO - TinderboxPrint: CPU idle
8,220.2 (86.5%) 13:31:23 INFO - TinderboxPrint: CPU user
1,227.6 (12.9%) 13:31:23 INFO - TinderboxPrint: Swap in / out
0 / 0 13:31:23 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256294912; Read time: 0; Write time: 394736 13:31:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294629376; Read time: 8; Write time: 187152 13:31:24 INFO - Running post-run listener: _upload_blobber_files 13:31:24 INFO - Blob upload gear active. 13:31:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:31:24 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:31:24 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:31:24 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:31:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:25 INFO - (blobuploader) - INFO - Done attempting. 13:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:26 INFO - (blobuploader) - INFO - Done attempting. 13:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:31:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:29 INFO - (blobuploader) - INFO - Done attempting. 13:31:29 INFO - (blobuploader) - INFO - Iteration through files over. 13:31:29 INFO - Return code: 0 13:31:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:31:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:31:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcfc7a8079f54304da0b24925c825e33356ff6c1c594a0c15ac13c7b69f861e330c16235a8bc6d2e885ce2010cd21bdf18a1342328ab07356d70fb757ce07d9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f84af7d0558d0fa6de5c2d20de6296fa96283b5abba39d9f0c0f9b01be0750ce6ae8c72cb48b3e9f20558ffb2855451c3b0638fbe6e21073aa933583de723360", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b450a870a6054878534500d4f2999e6054e78d4b4b19702af197ce99617752790484f8855d64b33483f95ea87a374abbe7916226314e9a413d513d319312e376"} 13:31:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:31:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:31:29 INFO - Contents: 13:31:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcfc7a8079f54304da0b24925c825e33356ff6c1c594a0c15ac13c7b69f861e330c16235a8bc6d2e885ce2010cd21bdf18a1342328ab07356d70fb757ce07d9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f84af7d0558d0fa6de5c2d20de6296fa96283b5abba39d9f0c0f9b01be0750ce6ae8c72cb48b3e9f20558ffb2855451c3b0638fbe6e21073aa933583de723360", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b450a870a6054878534500d4f2999e6054e78d4b4b19702af197ce99617752790484f8855d64b33483f95ea87a374abbe7916226314e9a413d513d319312e376"} 13:31:29 INFO - Running post-run listener: copy_logs_to_upload_dir 13:31:29 INFO - Copying logs to upload dir... 13:31:29 INFO - mkdir: /builds/slave/test/build/upload/logs 13:31:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.855405 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-22 13:31:29.547165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:31:29.551036) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcfc7a8079f54304da0b24925c825e33356ff6c1c594a0c15ac13c7b69f861e330c16235a8bc6d2e885ce2010cd21bdf18a1342328ab07356d70fb757ce07d9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f84af7d0558d0fa6de5c2d20de6296fa96283b5abba39d9f0c0f9b01be0750ce6ae8c72cb48b3e9f20558ffb2855451c3b0638fbe6e21073aa933583de723360", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b450a870a6054878534500d4f2999e6054e78d4b4b19702af197ce99617752790484f8855d64b33483f95ea87a374abbe7916226314e9a413d513d319312e376"} 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.011257 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcfc7a8079f54304da0b24925c825e33356ff6c1c594a0c15ac13c7b69f861e330c16235a8bc6d2e885ce2010cd21bdf18a1342328ab07356d70fb757ce07d9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f84af7d0558d0fa6de5c2d20de6296fa96283b5abba39d9f0c0f9b01be0750ce6ae8c72cb48b3e9f20558ffb2855451c3b0638fbe6e21073aa933583de723360", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b450a870a6054878534500d4f2999e6054e78d4b4b19702af197ce99617752790484f8855d64b33483f95ea87a374abbe7916226314e9a413d513d319312e376"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:31:29.577258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:31:29.577628) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466624852.477968-317368860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:31:29.660542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:31:29.660872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:31:29.661163) ========= ========= Total master_lag: 0.39 =========