builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466513223.56 results: success (0) buildid: 20160621030208 builduid: 8ddb821ec98e4b8bae1f6eb562f655b2 revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.563598) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.564216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.564573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.639108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.639539) ========= 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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 05:47:03-- 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% 223M=0s 2016-06-21 05:47:03 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070417 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.724811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.725188) ========= 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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016018 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.774696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:03.775088) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 --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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 05:47:03,818 truncating revision to first 12 chars 2016-06-21 05:47:03,818 Setting DEBUG logging. 2016-06-21 05:47:03,818 attempt 1/10 2016-06-21 05:47:03,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ffa18cfc8b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 05:47:04,298 unpacking tar archive at: mozilla-central-0ffa18cfc8b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:04.611571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:04.611942) ========= script_repo_revision: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:04.612396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:04.612797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 05:47:04.623417) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 05:47:04.623760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:04 INFO - MultiFileLogger online at 20160621 05:47:04 in /builds/slave/test 05:47:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:47:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:04 INFO - {'append_to_log': False, 05:47:04 INFO - 'base_work_dir': '/builds/slave/test', 05:47:04 INFO - 'blob_upload_branch': 'Firefox', 05:47:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:04 INFO - 'branch': 'Firefox', 05:47:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:04 INFO - 'config_files': ('talos/linux_config.py',), 05:47:04 INFO - 'default_actions': ('clobber', 05:47:04 INFO - 'read-buildbot-config', 05:47:04 INFO - 'download-and-extract', 05:47:04 INFO - 'populate-webroot', 05:47:04 INFO - 'create-virtualenv', 05:47:04 INFO - 'install', 05:47:04 INFO - 'run-tests'), 05:47:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:04 INFO - 'download_minidump_stackwalk': True, 05:47:04 INFO - 'download_symbols': 'ondemand', 05:47:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:04 INFO - 'installer_path': 'installer.exe', 05:47:04 INFO - 'log_level': 'info', 05:47:04 INFO - 'log_name': 'talos', 05:47:04 INFO - 'log_to_console': True, 05:47:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:04 INFO - 'opt_config_files': (), 05:47:04 INFO - 'pip_index': False, 05:47:04 INFO - 'sps_profile': False, 05:47:04 INFO - 'sps_profile_interval': 0, 05:47:04 INFO - 'suite': 'dromaeojs', 05:47:04 INFO - 'system_bits': '32', 05:47:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:04 INFO - 'title': 'talos-linux64-ix-017', 05:47:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:04 INFO - 'use_talos_json': True, 05:47:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:04 INFO - 'work_dir': 'build'} 05:47:04 INFO - ##### 05:47:04 INFO - ##### Running clobber step. 05:47:04 INFO - ##### 05:47:04 INFO - Running pre-action listener: _resource_record_pre_action 05:47:04 INFO - Running main action method: clobber 05:47:04 INFO - rmtree: /builds/slave/test/build 05:47:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:05 INFO - Running post-action listener: _resource_record_post_action 05:47:05 INFO - ##### 05:47:05 INFO - ##### Finished clobber step (success) 05:47:05 INFO - ##### 05:47:05 INFO - ##### 05:47:05 INFO - ##### Running read-buildbot-config step. 05:47:05 INFO - ##### 05:47:05 INFO - Running pre-action listener: _resource_record_pre_action 05:47:05 INFO - Running main action method: read_buildbot_config 05:47:05 INFO - Using buildbot properties: 05:47:05 INFO - { 05:47:05 INFO - "project": "", 05:47:05 INFO - "product": "firefox", 05:47:05 INFO - "script_repo_revision": "production", 05:47:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:47:05 INFO - "repository": "", 05:47:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:47:05 INFO - "buildid": "20160621030208", 05:47:05 INFO - "stage_platform": "linux64-pgo", 05:47:05 INFO - "basedir": "/builds/slave/test", 05:47:05 INFO - "nightly_build": "True", 05:47:05 INFO - "buildnumber": 351, 05:47:05 INFO - "slavename": "talos-linux64-ix-017", 05:47:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:47:05 INFO - "platform": "ubuntu64_hw", 05:47:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:05 INFO - "branch": "mozilla-central", 05:47:05 INFO - "repo_path": "mozilla-central", 05:47:05 INFO - "revision": "0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1", 05:47:05 INFO - "pgo_build": "True", 05:47:05 INFO - "builduid": "8ddb821ec98e4b8bae1f6eb562f655b2", 05:47:05 INFO - "slavebuilddir": "test" 05:47:05 INFO - } 05:47:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:47:05 INFO - Running post-action listener: _resource_record_post_action 05:47:05 INFO - ##### 05:47:05 INFO - ##### Finished read-buildbot-config step (success) 05:47:05 INFO - ##### 05:47:05 INFO - ##### 05:47:05 INFO - ##### Running download-and-extract step. 05:47:05 INFO - ##### 05:47:05 INFO - Running pre-action listener: _resource_record_pre_action 05:47:05 INFO - Running main action method: download_and_extract 05:47:05 INFO - mkdir: /builds/slave/test/build/tests 05:47:05 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')]} 05:47:05 INFO - https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:05 INFO - Downloaded 1361 bytes. 05:47:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:47:05 INFO - Using the following test package requirements: 05:47:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'jsshell-linux-x86_64.zip'], 05:47:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:05 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')]} 05:47:05 INFO - https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:06 INFO - Downloaded 24224922 bytes. 05:47:06 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'] 05:47:06 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 05:47:08 INFO - Return code: 0 05:47:08 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 05:47: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')]} 05:47:08 INFO - https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:09 INFO - Downloaded 24224922 bytes. 05:47:09 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'] 05:47:09 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 05:47:11 INFO - Return code: 0 05:47: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')]} 05:47:11 INFO - https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:11 INFO - Downloaded 14405384 bytes. 05:47:11 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'] 05:47:11 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 05:47:12 INFO - Return code: 0 05:47:12 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')]} 05:47:12 INFO - https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmqsGYg5TiqUasGV9SVWow/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 05:47:13 INFO - Downloaded 60125928 bytes. 05:47:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:13 INFO - mkdir: /builds/slave/test/properties 05:47:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:13 INFO - Contents: 05:47:13 INFO - build_url:https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:14 INFO - Running post-action listener: _resource_record_post_action 05:47:14 INFO - Running post-action listener: set_extra_try_arguments 05:47:14 INFO - ##### 05:47:14 INFO - ##### Finished download-and-extract step (success) 05:47:14 INFO - ##### 05:47:14 INFO - ##### 05:47:14 INFO - ##### Running populate-webroot step. 05:47:14 INFO - ##### 05:47:14 INFO - Running pre-action listener: _resource_record_pre_action 05:47:14 INFO - Running main action method: populate_webroot 05:47:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:14 INFO - '--tppagecycles', 05:47:14 INFO - '7'], 05:47:14 INFO - 'tests': ['tsvgm']}}, 05:47:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['damp', 'tps']}, 05:47:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'tests': ['damp', 'tps']}, 05:47:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['dromaeo_dom']}, 05:47:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['basic_compositor_video']}, 05:47:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:47:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['a11yr', 05:47:14 INFO - 'ts_paint', 05:47:14 INFO - 'tpaint', 05:47:14 INFO - 'sessionrestore', 05:47:14 INFO - 'sessionrestore_no_auto_restore', 05:47:14 INFO - 'tabpaint']}, 05:47:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['tsvgx', 05:47:14 INFO - 'tsvgr_opacity', 05:47:14 INFO - 'tart', 05:47:14 INFO - 'tscrollx', 05:47:14 INFO - 'cart']}, 05:47:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:14 INFO - 'tsvgr_opacity', 05:47:14 INFO - 'tart', 05:47:14 INFO - 'tscrollx', 05:47:14 INFO - 'cart']}, 05:47:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'talos_options': ['--disable-e10s'], 05:47:14 INFO - 'tests': ['tp5o']}, 05:47:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'tests': ['tp5o']}, 05:47:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'talos_options': ['--disable-e10s', 05:47:14 INFO - '--xperf_path', 05:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:14 INFO - 'tests': ['tp5n']}, 05:47:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:14 INFO - 'talos_options': ['--xperf_path', 05:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:14 INFO - 'tests': ['tp5n']}}, 05:47:14 INFO - 'talos.zip': {'path': '', 05:47:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:14 INFO - Running post-action listener: _resource_record_post_action 05:47:14 INFO - ##### 05:47:14 INFO - ##### Finished populate-webroot step (success) 05:47:14 INFO - ##### 05:47:14 INFO - ##### 05:47:14 INFO - ##### Running create-virtualenv step. 05:47:14 INFO - ##### 05:47:14 INFO - Running pre-action listener: _resource_record_pre_action 05:47:14 INFO - Running main action method: create_virtualenv 05:47:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:14 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 05:47:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:14 INFO - Using real prefix '/usr' 05:47:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:16 INFO - Installing pip.................done. 05:47:16 INFO - Return code: 0 05:47:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47: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', 'pip>=1.5'] in /builds/slave/test/build 05:47: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 pip>=1.5 05:47:16 INFO - Using env: {'DISPLAY': ':0', 05:47:16 INFO - 'HOME': '/home/cltbld', 05:47:16 INFO - 'LANG': 'en_US.UTF-8', 05:47:16 INFO - 'LANGUAGE': 'en_US:en', 05:47:16 INFO - 'LOGNAME': 'cltbld', 05:47:16 INFO - 'MAIL': '/var/mail/cltbld', 05:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:16 INFO - 'MOZ_NO_REMOTE': '1', 05:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:16 INFO - 'NO_EM_RESTART': '1', 05:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:16 INFO - 'PWD': '/builds/slave/test', 05:47:16 INFO - 'SHELL': '/bin/bash', 05:47:16 INFO - 'SHLVL': '1', 05:47:16 INFO - 'TERM': 'linux', 05:47:16 INFO - 'TMOUT': '86400', 05:47:16 INFO - 'USER': 'cltbld', 05:47:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:16 INFO - '_': '/tools/buildbot/bin/python'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 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 05:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47:17 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')]} 05:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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')]} 05:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:17 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 05:47:17 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 05:47:17 INFO - Using env: {'DISPLAY': ':0', 05:47:17 INFO - 'HOME': '/home/cltbld', 05:47:17 INFO - 'LANG': 'en_US.UTF-8', 05:47:17 INFO - 'LANGUAGE': 'en_US:en', 05:47:17 INFO - 'LOGNAME': 'cltbld', 05:47:17 INFO - 'MAIL': '/var/mail/cltbld', 05:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:17 INFO - 'MOZ_NO_REMOTE': '1', 05:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:17 INFO - 'NO_EM_RESTART': '1', 05:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:17 INFO - 'PWD': '/builds/slave/test', 05:47:17 INFO - 'SHELL': '/bin/bash', 05:47:17 INFO - 'SHLVL': '1', 05:47:17 INFO - 'TERM': 'linux', 05:47:17 INFO - 'TMOUT': '86400', 05:47:17 INFO - 'USER': 'cltbld', 05:47:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:17 INFO - '_': '/tools/buildbot/bin/python'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 INFO - Downloading/unpacking psutil>=3.1.1 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:19 INFO - Installing collected packages: psutil 05:47:19 INFO - Running setup.py install for psutil 05:47:19 INFO - building 'psutil._psutil_linux' extension 05:47:19 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 05:47:19 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 05:47:19 INFO - building 'psutil._psutil_posix' extension 05:47:19 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 05:47:19 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 05:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:19 INFO - Successfully installed psutil 05:47:19 INFO - Cleaning up... 05:47:19 INFO - Return code: 0 05:47:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:47:19 INFO - Using env: {'DISPLAY': ':0', 05:47:19 INFO - 'HOME': '/home/cltbld', 05:47:19 INFO - 'LANG': 'en_US.UTF-8', 05:47:19 INFO - 'LANGUAGE': 'en_US:en', 05:47:19 INFO - 'LOGNAME': 'cltbld', 05:47:19 INFO - 'MAIL': '/var/mail/cltbld', 05:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:19 INFO - 'MOZ_NO_REMOTE': '1', 05:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:19 INFO - 'NO_EM_RESTART': '1', 05:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:19 INFO - 'PWD': '/builds/slave/test', 05:47:19 INFO - 'SHELL': '/bin/bash', 05:47:19 INFO - 'SHLVL': '1', 05:47:19 INFO - 'TERM': 'linux', 05:47:19 INFO - 'TMOUT': '86400', 05:47:19 INFO - 'USER': 'cltbld', 05:47:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:19 INFO - '_': '/tools/buildbot/bin/python'} 05:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:22 INFO - Installing collected packages: mozsystemmonitor 05:47:22 INFO - Running setup.py install for mozsystemmonitor 05:47:22 INFO - Successfully installed mozsystemmonitor 05:47:22 INFO - Cleaning up... 05:47:22 INFO - Return code: 0 05:47:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:22 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 05:47:22 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 05:47:22 INFO - Using env: {'DISPLAY': ':0', 05:47:22 INFO - 'HOME': '/home/cltbld', 05:47:22 INFO - 'LANG': 'en_US.UTF-8', 05:47:22 INFO - 'LANGUAGE': 'en_US:en', 05:47:22 INFO - 'LOGNAME': 'cltbld', 05:47:22 INFO - 'MAIL': '/var/mail/cltbld', 05:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:22 INFO - 'MOZ_NO_REMOTE': '1', 05:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:22 INFO - 'NO_EM_RESTART': '1', 05:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:22 INFO - 'PWD': '/builds/slave/test', 05:47:22 INFO - 'SHELL': '/bin/bash', 05:47:22 INFO - 'SHLVL': '1', 05:47:22 INFO - 'TERM': 'linux', 05:47:22 INFO - 'TMOUT': '86400', 05:47:22 INFO - 'USER': 'cltbld', 05:47:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:22 INFO - '_': '/tools/buildbot/bin/python'} 05:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:22 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 05:47:22 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 05:47:22 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 05:47:22 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 05:47:22 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 05:47:22 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 05:47:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:24 INFO - warning: no files found matching '*.txt' 05:47:24 INFO - no previously-included directories found matching 'build' 05:47:24 INFO - no previously-included directories found matching 'dist' 05:47:24 INFO - no previously-included directories found matching '.git*' 05:47:24 INFO - Installing collected packages: jsonschema, functools32 05:47:24 INFO - Running setup.py install for functools32 05:47:24 INFO - warning: no files found matching '*.txt' 05:47:24 INFO - no previously-included directories found matching 'build' 05:47:24 INFO - no previously-included directories found matching 'dist' 05:47:24 INFO - no previously-included directories found matching '.git*' 05:47:24 INFO - Successfully installed jsonschema functools32 05:47:24 INFO - Cleaning up... 05:47:24 INFO - Return code: 0 05:47:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:24 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 05:47:24 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 05:47:24 INFO - Using env: {'DISPLAY': ':0', 05:47:24 INFO - 'HOME': '/home/cltbld', 05:47:24 INFO - 'LANG': 'en_US.UTF-8', 05:47:24 INFO - 'LANGUAGE': 'en_US:en', 05:47:24 INFO - 'LOGNAME': 'cltbld', 05:47:24 INFO - 'MAIL': '/var/mail/cltbld', 05:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:24 INFO - 'MOZ_NO_REMOTE': '1', 05:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:24 INFO - 'NO_EM_RESTART': '1', 05:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:24 INFO - 'PWD': '/builds/slave/test', 05:47:24 INFO - 'SHELL': '/bin/bash', 05:47:24 INFO - 'SHLVL': '1', 05:47:24 INFO - 'TERM': 'linux', 05:47:24 INFO - 'TMOUT': '86400', 05:47:24 INFO - 'USER': 'cltbld', 05:47:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:24 INFO - '_': '/tools/buildbot/bin/python'} 05:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:26 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 05:47:26 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 05:47:26 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 05:47:26 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 05:47:26 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 05:47:26 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 05:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:27 INFO - Downloading docopt-0.6.1.tar.gz 05:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:27 INFO - Running setup.py install for blobuploader 05:47:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:27 INFO - Running setup.py install for requests 05:47:28 INFO - Running setup.py install for docopt 05:47:28 INFO - Successfully installed blobuploader requests docopt 05:47:28 INFO - Cleaning up... 05:47:28 INFO - Return code: 0 05:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:28 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:28 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 05:47:28 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 05:47:28 INFO - Using env: {'DISPLAY': ':0', 05:47:28 INFO - 'HOME': '/home/cltbld', 05:47:28 INFO - 'LANG': 'en_US.UTF-8', 05:47:28 INFO - 'LANGUAGE': 'en_US:en', 05:47:28 INFO - 'LOGNAME': 'cltbld', 05:47:28 INFO - 'MAIL': '/var/mail/cltbld', 05:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:28 INFO - 'MOZ_NO_REMOTE': '1', 05:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:28 INFO - 'NO_EM_RESTART': '1', 05:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:28 INFO - 'PWD': '/builds/slave/test', 05:47:28 INFO - 'SHELL': '/bin/bash', 05:47:28 INFO - 'SHLVL': '1', 05:47:28 INFO - 'TERM': 'linux', 05:47:28 INFO - 'TMOUT': '86400', 05:47:28 INFO - 'USER': 'cltbld', 05:47:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:28 INFO - '_': '/tools/buildbot/bin/python'} 05:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:28 INFO - Running setup.py (path:/tmp/pip-rods6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:28 INFO - Running setup.py (path:/tmp/pip-m1kYWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:28 INFO - Running setup.py (path:/tmp/pip-65VgSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:28 INFO - Running setup.py (path:/tmp/pip-IzIf3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:28 INFO - Running setup.py (path:/tmp/pip-vp9FSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:28 INFO - Running setup.py (path:/tmp/pip-3mgLUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:28 INFO - Running setup.py (path:/tmp/pip-NyPbHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:28 INFO - Running setup.py (path:/tmp/pip-9rW7zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:28 INFO - Running setup.py (path:/tmp/pip-JZRGV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:29 INFO - Running setup.py (path:/tmp/pip-8j3qZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:29 INFO - Running setup.py (path:/tmp/pip-Z6NOAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:29 INFO - Running setup.py (path:/tmp/pip-sBaqVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:29 INFO - Running setup.py (path:/tmp/pip-7LJZdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:29 INFO - Running setup.py (path:/tmp/pip-s5xmgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:29 INFO - Running setup.py (path:/tmp/pip-Y7gokz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:29 INFO - Running setup.py (path:/tmp/pip-2UMDdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:29 INFO - Running setup.py (path:/tmp/pip-dxv5nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:29 INFO - Running setup.py install for manifestparser 05:47:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:29 INFO - Running setup.py install for mozcrash 05:47:29 INFO - Running setup.py install for mozdebug 05:47:29 INFO - Running setup.py install for mozdevice 05:47:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozfile 05:47:30 INFO - Running setup.py install for mozhttpd 05:47:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozinfo 05:47:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozInstall 05:47:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozleak 05:47:30 INFO - Running setup.py install for mozlog 05:47:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for moznetwork 05:47:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozprocess 05:47:30 INFO - Running setup.py install for mozprofile 05:47:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:30 INFO - Running setup.py install for mozrunner 05:47:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:31 INFO - Running setup.py install for mozscreenshot 05:47:31 INFO - Running setup.py install for moztest 05:47:31 INFO - Running setup.py install for mozversion 05:47:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:31 INFO - Cleaning up... 05:47:31 INFO - Return code: 0 05:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:31 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:31 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 05:47:31 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 05:47:31 INFO - Using env: {'DISPLAY': ':0', 05:47:31 INFO - 'HOME': '/home/cltbld', 05:47:31 INFO - 'LANG': 'en_US.UTF-8', 05:47:31 INFO - 'LANGUAGE': 'en_US:en', 05:47:31 INFO - 'LOGNAME': 'cltbld', 05:47:31 INFO - 'MAIL': '/var/mail/cltbld', 05:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:31 INFO - 'MOZ_NO_REMOTE': '1', 05:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:31 INFO - 'NO_EM_RESTART': '1', 05:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:31 INFO - 'PWD': '/builds/slave/test', 05:47:31 INFO - 'SHELL': '/bin/bash', 05:47:31 INFO - 'SHLVL': '1', 05:47:31 INFO - 'TERM': 'linux', 05:47:31 INFO - 'TMOUT': '86400', 05:47:31 INFO - 'USER': 'cltbld', 05:47:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:31 INFO - '_': '/tools/buildbot/bin/python'} 05:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:31 INFO - Running setup.py (path:/tmp/pip-fAc1d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:31 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)) 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:31 INFO - Running setup.py (path:/tmp/pip-sLg4Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:31 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)) 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:31 INFO - Running setup.py (path:/tmp/pip-EovZ4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:31 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)) 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:31 INFO - Running setup.py (path:/tmp/pip-MBgIrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:31 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)) 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:31 INFO - Running setup.py (path:/tmp/pip-0V9jDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:32 INFO - Running setup.py (path:/tmp/pip-lc8rhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:32 INFO - Running setup.py (path:/tmp/pip-DoAeue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:32 INFO - Running setup.py (path:/tmp/pip-upo3Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:32 INFO - Running setup.py (path:/tmp/pip-TmnqC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:32 INFO - Running setup.py (path:/tmp/pip-VO3Ej8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:32 INFO - Running setup.py (path:/tmp/pip-i3ScMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:32 INFO - Running setup.py (path:/tmp/pip-kNyM7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:32 INFO - Running setup.py (path:/tmp/pip-QCoULg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:32 INFO - Running setup.py (path:/tmp/pip-GCETze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:32 INFO - Running setup.py (path:/tmp/pip-9XrTV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:32 INFO - Running setup.py (path:/tmp/pip-Zis8eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:32 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)) 05:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:32 INFO - Running setup.py (path:/tmp/pip-gPkJpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:32 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)) 05:47:32 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)) 05:47:32 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)) 05:47:32 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)) 05:47:32 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)) 05:47:32 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)) 05:47:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:34 INFO - Downloading blessings-1.6.tar.gz 05:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:34 INFO - Installing collected packages: blessings 05:47:34 INFO - Running setup.py install for blessings 05:47:34 INFO - Successfully installed blessings 05:47:34 INFO - Cleaning up... 05:47:35 INFO - Return code: 0 05:47:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:35 INFO - Reading from file tmpfile_stdout 05:47:35 INFO - Current package versions: 05:47:35 INFO - argparse == 1.2.1 05:47:35 INFO - blessings == 1.6 05:47:35 INFO - blobuploader == 1.2.4 05:47:35 INFO - docopt == 0.6.1 05:47:35 INFO - functools32 == 3.2.3-2 05:47:35 INFO - jsonschema == 2.5.1 05:47:35 INFO - manifestparser == 1.1 05:47:35 INFO - mozInstall == 1.12 05:47:35 INFO - mozcrash == 0.17 05:47:35 INFO - mozdebug == 0.1 05:47:35 INFO - mozdevice == 0.48 05:47:35 INFO - mozfile == 1.2 05:47:35 INFO - mozhttpd == 0.7 05:47:35 INFO - mozinfo == 0.9 05:47:35 INFO - mozleak == 0.1 05:47:35 INFO - mozlog == 3.2 05:47:35 INFO - moznetwork == 0.27 05:47:35 INFO - mozprocess == 0.22 05:47:35 INFO - mozprofile == 0.28 05:47:35 INFO - mozrunner == 6.11 05:47:35 INFO - mozscreenshot == 0.1 05:47:35 INFO - mozsystemmonitor == 0.3 05:47:35 INFO - moztest == 0.7 05:47:35 INFO - mozversion == 1.4 05:47:35 INFO - psutil == 3.1.1 05:47:35 INFO - requests == 1.2.3 05:47:35 INFO - wsgiref == 0.1.2 05:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:35 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 05:47:35 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 05:47:35 INFO - Using env: {'DISPLAY': ':0', 05:47:35 INFO - 'HOME': '/home/cltbld', 05:47:35 INFO - 'LANG': 'en_US.UTF-8', 05:47:35 INFO - 'LANGUAGE': 'en_US:en', 05:47:35 INFO - 'LOGNAME': 'cltbld', 05:47:35 INFO - 'MAIL': '/var/mail/cltbld', 05:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:35 INFO - 'MOZ_NO_REMOTE': '1', 05:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:35 INFO - 'NO_EM_RESTART': '1', 05:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:35 INFO - 'PWD': '/builds/slave/test', 05:47:35 INFO - 'SHELL': '/bin/bash', 05:47:35 INFO - 'SHLVL': '1', 05:47:35 INFO - 'TERM': 'linux', 05:47:35 INFO - 'TMOUT': '86400', 05:47:35 INFO - 'USER': 'cltbld', 05:47:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:35 INFO - '_': '/tools/buildbot/bin/python'} 05:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 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)) 05:47:35 INFO - Cleaning up... 05:47:35 INFO - Return code: 0 05:47:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:35 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 05:47:35 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 05:47:35 INFO - Using env: {'DISPLAY': ':0', 05:47:35 INFO - 'HOME': '/home/cltbld', 05:47:35 INFO - 'LANG': 'en_US.UTF-8', 05:47:35 INFO - 'LANGUAGE': 'en_US:en', 05:47:35 INFO - 'LOGNAME': 'cltbld', 05:47:35 INFO - 'MAIL': '/var/mail/cltbld', 05:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:35 INFO - 'MOZ_NO_REMOTE': '1', 05:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:35 INFO - 'NO_EM_RESTART': '1', 05:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:35 INFO - 'PWD': '/builds/slave/test', 05:47:35 INFO - 'SHELL': '/bin/bash', 05:47:35 INFO - 'SHLVL': '1', 05:47:35 INFO - 'TERM': 'linux', 05:47:35 INFO - 'TMOUT': '86400', 05:47:35 INFO - 'USER': 'cltbld', 05:47:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:35 INFO - '_': '/tools/buildbot/bin/python'} 05:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:35 INFO - Cleaning up... 05:47:35 INFO - Return code: 0 05:47:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 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 0x7fbc4efdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', '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 05:47:35 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 05:47:35 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 05:47:35 INFO - Using env: {'DISPLAY': ':0', 05:47:35 INFO - 'HOME': '/home/cltbld', 05:47:35 INFO - 'LANG': 'en_US.UTF-8', 05:47:35 INFO - 'LANGUAGE': 'en_US:en', 05:47:35 INFO - 'LOGNAME': 'cltbld', 05:47:35 INFO - 'MAIL': '/var/mail/cltbld', 05:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:35 INFO - 'MOZ_NO_REMOTE': '1', 05:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:35 INFO - 'NO_EM_RESTART': '1', 05:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:35 INFO - 'PWD': '/builds/slave/test', 05:47:35 INFO - 'SHELL': '/bin/bash', 05:47:35 INFO - 'SHLVL': '1', 05:47:35 INFO - 'TERM': 'linux', 05:47:35 INFO - 'TMOUT': '86400', 05:47:35 INFO - 'USER': 'cltbld', 05:47:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:35 INFO - '_': '/tools/buildbot/bin/python'} 05:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:35 INFO - Downloading/unpacking flake8 05:47:35 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 05:47:35 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 05:47:35 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 05:47:35 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 05:47:35 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 05:47:35 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 05:47:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:47:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:47:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:38 INFO - no previously-included directories found matching 'docs/_build' 05:47:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:47:38 INFO - Running setup.py install for pep8 05:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:47:38 INFO - no previously-included directories found matching 'docs/_build' 05:47:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:47:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:47:38 INFO - Cleaning up... 05:47:38 INFO - Return code: 0 05:47:38 INFO - Running post-action listener: _resource_record_post_action 05:47:38 INFO - Running post-action listener: _start_resource_monitoring 05:47:38 INFO - Starting resource monitoring. 05:47:38 INFO - ##### 05:47:38 INFO - ##### Finished create-virtualenv step (success) 05:47:38 INFO - ##### 05:47:38 INFO - ##### 05:47:38 INFO - ##### Running install step. 05:47:38 INFO - ##### 05:47:38 INFO - Running pre-action listener: _resource_record_pre_action 05:47:38 INFO - Running main action method: install 05:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:38 INFO - Reading from file tmpfile_stdout 05:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:39 INFO - Reading from file tmpfile_stdout 05:47:39 INFO - Output received: 05:47:39 INFO - Usage: mozinstall [options] installer 05:47:39 INFO - Options: 05:47:39 INFO - -h, --help show this help message and exit 05:47:39 INFO - -d DEST, --destination=DEST 05:47:39 INFO - Directory to install application into. [default: 05:47:39 INFO - "/builds/slave/test"] 05:47:39 INFO - --app=APP Application being installed. [default: firefox] 05:47:39 INFO - mkdir: /builds/slave/test/build/application 05:47:39 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'] 05:47:39 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 05:47:56 INFO - Reading from file tmpfile_stdout 05:47:56 INFO - Output received: 05:47:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:56 INFO - Running post-action listener: _resource_record_post_action 05:47:56 INFO - ##### 05:47:56 INFO - ##### Finished install step (success) 05:47:56 INFO - ##### 05:47:56 INFO - ##### 05:47:56 INFO - ##### Running run-tests step. 05:47:56 INFO - ##### 05:47:56 INFO - Running pre-action listener: _resource_record_pre_action 05:47:56 INFO - Running main action method: run_tests 05:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:56 INFO - Python 2.7.3 05:47:56 INFO - Return code: 0 05:47:56 INFO - grabbing minidump binary from tooltool 05:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:56 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 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:56 INFO - Return code: 0 05:47:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:47:57 INFO - Return code: 0 05:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:47:57 INFO - Using env: {'DISPLAY': ':0', 05:47:57 INFO - 'HOME': '/home/cltbld', 05:47:57 INFO - 'LANG': 'en_US.UTF-8', 05:47:57 INFO - 'LANGUAGE': 'en_US:en', 05:47:57 INFO - 'LOGNAME': 'cltbld', 05:47:57 INFO - 'MAIL': '/var/mail/cltbld', 05:47:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:57 INFO - 'MOZ_NO_REMOTE': '1', 05:47:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:57 INFO - 'NO_EM_RESTART': '1', 05:47:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:57 INFO - 'PWD': '/builds/slave/test', 05:47:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:57 INFO - 'SHELL': '/bin/bash', 05:47:57 INFO - 'SHLVL': '1', 05:47:57 INFO - 'TERM': 'linux', 05:47:57 INFO - 'TMOUT': '86400', 05:47:57 INFO - 'USER': 'cltbld', 05:47:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457', 05:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:57 INFO - '_': '/tools/buildbot/bin/python'} 05:47:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:47:57 INFO - mozversion application_buildid: 20160621030208 05:47:57 INFO - mozversion application_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 05:47:57 INFO - mozversion application_display_name: Nightly 05:47:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:57 INFO - mozversion application_name: Firefox 05:47:57 INFO - mozversion application_remotingname: firefox 05:47:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:57 INFO - mozversion application_vendor: Mozilla 05:47:57 INFO - mozversion application_version: 50.0a1 05:47:57 INFO - mozversion platform_buildid: 20160621030208 05:47:57 INFO - mozversion platform_changeset: 0ffa18cfc8b4e9970275ab6dd94686792a5c8ae1 05:47:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:57 INFO - mozversion platform_version: 50.0a1 05:47:57 INFO - using testdate: 1466513277 05:47:57 INFO - actual date: 1466513277 05:47:57 INFO - starting webserver on 'localhost:59335' 05:47:57 INFO - SUITE-START | Running 2 tests 05:47:57 INFO - TEST-START | dromaeo_css 05:47:57 INFO - operating with platform_type : linux_ 05:47:57 INFO - Initialising browser for dromaeo_css test... 05:47:57 INFO - TEST-INFO | started process 11170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4LtrLv/profile http://localhost:59335/getInfo.html) 05:48:01 INFO - PROCESS | 11170 | __metrics Screen width/height:1600/1200 05:48:01 INFO - PROCESS | 11170 | colorDepth:24 05:48:01 INFO - PROCESS | 11170 | Browser inner width/height: 1024/697 05:48:01 INFO - PROCESS | 11170 | __metrics 05:48:02 INFO - PROCESS | 11170 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:03 INFO - TEST-INFO | 11170: exit 0 05:48:03 INFO - Browser initialized. 05:48:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:03 INFO - TEST-INFO | started process 11252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4LtrLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:15 INFO - PROCESS | 11252 | RSS: Main: 173338624 05:48:15 INFO - PROCESS | 11252 | 05:49:05 INFO - PROCESS | 11252 | 1466513345854 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] 05:51:14 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59335/tests/dromaeo/cssquery-ext.html) 05:51:16 INFO - PROCESS | 11252 | RSS: Main: 315240448 05:51:16 INFO - PROCESS | 11252 | 05:54:18 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-ext.html (next: http://localhost:59335/tests/dromaeo/cssquery-jquery.html) 05:54:19 INFO - PROCESS | 11252 | RSS: Main: 264507392 05:54:19 INFO - PROCESS | 11252 | 05:57:21 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59335/tests/dromaeo/cssquery-mootools.html) 05:57:21 INFO - PROCESS | 11252 | RSS: Main: 272621568 05:57:21 INFO - PROCESS | 11252 | 06:00:23 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59335/tests/dromaeo/cssquery-prototype.html) 06:00:24 INFO - PROCESS | 11252 | RSS: Main: 263319552 06:00:24 INFO - PROCESS | 11252 | 06:03:27 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59335/tests/dromaeo/cssquery-yui.html) 06:03:27 INFO - PROCESS | 11252 | RSS: Main: 243593216 06:03:27 INFO - PROCESS | 11252 | 06:06:30 INFO - PROCESS | 11252 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-yui.html (next: http://localhost:59335/tests/dromaeo/cssquery-dojo.html) 06:06:31 INFO - PROCESS | 11252 | RSS: Main: 289382400 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | __start_tp_report 06:06:31 INFO - PROCESS | 11252 | _x_x_mozilla_page_load 06:06:31 INFO - PROCESS | 11252 | _x_x_mozilla_page_load_details 06:06:31 INFO - PROCESS | 11252 | |i|pagename|runs| 06:06:31 INFO - PROCESS | 11252 | |0;dojo.html;3061.433634777566;3076.369344284422;3095.582096416984;3106.347666989932;3120.656727759946;5178.792848286064;5241.685498870061;5367.973160134199;5384.40771515133;5420.756065977031;5333.120035194198;5340.49265319795;5388.353397592285;5469.671819690821;5510.311211098613;4856.805727770885;4912.557869791718;4925.532074452921;4927.802887884481;5076.974615126919;4985.825496107637;5024.924626130611;5027.271045698371;5045.798168073273;5051.343325367697;4782.856514304576;4796.712197268158;4815.109204797123;4841.515848415165;5001.199808030716;4861.197902346109;4865.3675022247235;4865.6107511399005;4907.68100073494;4946.109700253953;4850.5877000455;4897.436794768611;4901.730404827733;4913.533214344668;4932;5212.713300768456;5292.576593872481;5375.6774593524515;5390.757415916293;5416.431274716177;5787.13193021046;5788.450097240755;5835.708214589254;5847.795327163529;5848.356680765112;5825.708714564297;5861.3552509223955;5875.206847075633;5878.441548052928;5882;5267.104592219332;5347.759350829183;5380.192971054373;5385.676859388371;5481.588880833913;5968.283805943314;5973.850653733692;5974.731137098841;5979.701014949235;5982.1325907744;5731.713414329351;5735.340435849931;5745.2243947067445;5749.741261643236;5749.798757043567;5505.889882202414;5706.572007099401;5749.655020698771;5751.194832723422;5809.8547536311935;5765.913511297334;5768.278965129359;5769.451902069297;5781;5784.219130417424;5567.610267281251;5736.225609542742;5779;5785.421457854265;5791.478766910998;4344.6089851913475;4396.582324679151;4399.340098985178;4404.2512772828695;4417.116576684676;3921.254961557295;3923.5487918889694;3927.8036098194975;3950.249452603996;3964.0486283291802;5285.101532739443;5388.299521062315;5390.68313737168;5404.081306177959;5418.997485465202;5747.798827041117;5779.913301300484;5804.796832110856;5815.098659707752;5824.767009319665;5471.7264136793;5479.506844384025;5482.451754824486;5484.314460692413;5485.890282194414;4868.342773725572;4937.703737775745;5033.245013248042;5033.370828646419;5084.339035925306;5837.649741015468;5934.940650593525;5940.34656187819;5974.2233509643465;5977.6114552553945;5793.131030345482;5799.507041901317;5804.361520232686;5806.506446952057;5806.796762113306;5581.246531718329;5766.221560089334;5927.9703601481715;5937.050071988461;5938.970305148447;5565.972170139124;5612.466815652507;5613.214150018919;5617;5680.261565996394;5639.238702775073;5708.942910570841;5713.742881570256;5717.685527296038;5727.7422515986045;5484.095124304445;5530.668159910419;5538.252335934597;5603.859903502282;5651.8304450866535;5604.915926261027;5613.045782217115;5614.887702246014;5615.241942337732;5621;5535.086710692691;5556.694381808878;5605.859853503695;5606.775728970959;5615.213870058276;5649.71751412436;5703.857403564944;5712.400197979152;5715.199872018004;5717.8570535736935;5376.838694839161;5499.972500137474;5505.284313039279;5549.7780088796;5556.583256255716 06:06:31 INFO - PROCESS | 11252 | |1;ext.html;571.9914201286981;619.5570167330359;624.697021944357;630.5775130662457;636.3636363636364;28623.856880715593;40507.79746101269;41067.38398924019;41313.58686413135;43576.3463548047;43916;44328.778356108254;44345.55654443455;44557.77721111398;44729.77635111828;8848.5575721214;9023.729288121367;9027.277817774595;9028.954855225747;9037.05110963346;8843.336749743763;8847.292216622687;8868.113188681145;8885.511296878669;8886.86669699955;8884.200421962023;8913;8918.464892106495;8920.910790892105;8958.417702849327;8929;8952.015278319379;8970.102989701043;8972.192502674758;8980.640774369018;8855.24730397917;8912.287017038687;8921.286297096216;8928.285737141077;8931.910680893174;41847.58152418467;42007.369889451686;42021.1595768086;42126;42214.577854221374;3385.5768028996376;3409.9318013639836;3413.4538473844314;3469.947950780715;3997.8800635980965;31556.684433155606;31827.681723182704;32413.351732965446;32441.188970275696;32459.675403245903;4304;4406.140802543506;4428.557144285578;4485.0805584855025;4543.863684089482;245839;246201;246337;246657;246918;55267.72366138144;55574.16638750422;55680.721596391755;55700.16449753257;55702.72148639231;57007.71496142493;57878;57907.131393029136;58022.7098864503;58035.709821450626;16737;16812.15939203035;16947.491575252763;16969.23638436273;16978.660426791394;13165.47338106465;13203.273819939803;13240.735185296433;13241.470341186438;13242.470301188037;15107.244637768288;15430.691386172213;15635.296411661502;15667.373305067898;15827.287772050286;5962.4225464721685;6072.696365181811;6154.5076393888385;6169.629822210682;6294.905576416358;950.1543626172712;1049.7270709615555;1099.367863478503;1103.8564986551858;1114.1755101225035;30367.69632303693;30546.54180187299;30845.845770771004;30874;31233;1051.779126383468;1089.3137323486153;1142.9657110286705;1144.0790163918125;1156.1733360647177;15936.681266374608;16134.596635083983;16153.273102710406;16182;16447.91776041112;533706;537889;539388;541438;542296;56981.43018569761;57087.714561426925;57108.42891571114;57149.428505715245;57249;1228.3489750432286;1322.272749987503;1330.381372661717;1339.3169483563258;1359.5445525748787;31957.840210798797;32521.349573007934;33288.1677958053;33365;33560.66439335673;49214.753926230136;49474;49526.75236623794;49646.75176624094;49818;402010;409754;410214;411405;413985;34118.658813411545;39216.411753824286;40051.79974100111;40610.18779624332;40813;40279.798601006805;40356.3946540808;40811.79594102011;41144.38283425811;41414.792926035174;39755.60244397635;40567.79716101401;40646.39030414487;41171.38242926299;41688;38928.80535597304;39627;40021;40077.198456030135;40709.79645101874;39860.40209396919;40666;40740;40805.38791918183;40910.1817963645;34139.31721365509;35284.294314114086;35519.28961420705;35747.46378804268;36160.63839361573;26763.86618066897;27075.59386609163;27496.312592185357;27613.86193069022;27710 06:06:31 INFO - PROCESS | 11252 | |2;jquery.html;372.272207833685;383.1379396358194;394.65664871561745;395.2154972379826;406.11061774713374;17725.379611713593;18640.906795466002;20399.08204130812;20403.285884994028;20423.897880510594;11824.527018919232;12065;12344.876551234485;12353.567625133122;12358.134930554865;5096.210087436453;5306.151015837467;5365.087935051031;5365.7853685852515;5368.32895888014;3874.496315478998;5499.395066542677;5757.193992841006;5760.423957604248;5861.472467477926;5821.53427725781;5823.213866128082;5841.123831425278;5848.502877255439;6098.359672234418;6221.875562488747;6324.557280990332;6348.428641422248;6359.332270111641;6388.169537960035;3809.1619843634357;5269.446708095671;5586.664800112007;5590.664560126364;5665.801696940587;13576.864231357658;13693.699098585717;13718.108322958975;13874.098183618033;14167.78748318776;2176.4667656424276;2371.632396978471;2404.4349577849193;2449.6570480132796;2913.1115009921964;10023.918676499885;10072.597096116147;10143.543540540619;10593.205509586813;12552.121351505399;1848.8705790594663;1988.4631149589675;1988.6221617892554;1999.8300144487737;2083.718697975769;84985.57507212486;86970;87089;87812;88628.5568572153;10737.516811743333;10790.460476976119;10863.348199108079;11037.302503661364;11086.61196858106;15256.46602368934;15368.462103826312;15378;15379.692406151815;15404.768928466083;8051.2351326623875;8195;8295.419320647617;8363.707270245512;8405.495670259805;8005.519668819889;8020.077691065486;8028.678852845937;8195.385346098947;8197.139300373494;4715.434147902273;4716.811327546929;4731.668783185213;4760.904781904412;4865.7323847188745;1761.5419990802484;1823.1522342110718;1939.1952339778834;1941.369055057112;1989.502624343914;863.9654413823503;976.497103991445;979.4808751361647;981.8969008254173;1020.6886899495726;18260.452186434428;19224.8077519223;19279.325223617107;19448.22207111728;19624.803751962583;947.9383840050375;957.1624828275259;961.2310151878469;997.3666721631816;1015.5480811039017;9088.591013404413;10987.340759554452;11015.394153321484;11031.83452248217;11091.667249982513;465862;467579;469552;470610;470689;56397.71801140968;90587;92499.53750231206;92719.53640231755;93371;942.1144124522926;958.8849338079475;984.3060642247199;985.7190700650424;986.5954958467138;16787.61921757622;16900.746488802433;17182.484525464257;17185.226664799862;17395.391161309293;34217.144571385914;38829;41761.1647767049;42073.78963105165;42232.36651450169;59322;60854.39145608487;60954.69522652358;61007;61789.691051544454;8491.320694344562;8680.652773888974;8877.644894204159;8959.238464730572;8980.577718822451;10079.596816127272;13858.65353366174;13894.186831962184;14042.929785351007;14204.431822727389;11899.762004759683;11931.224470409396;11938.820917686067;12394.566190183301;12444.564440244549;12079.27524348542;12123.272603643809;12190;12314.630561083182;12748.745025099632;12065;12486.500539978662;12487.438065286902;12602.180858244552;12622.810657839957;8905.376623636543;8910.599023044108;8914.687985920462;8971.192592666692;9270.44377337362;10580.36517808934;11906.166568340133;12036.338001410006;12354.25874447536;12424.254544727346 06:06:31 INFO - PROCESS | 11252 | |3;mootools.html;1335.739530791496;1430.5994321589956;1467.7945087687722;1577.589826645072;1725.8101608823035;8136.877946830795;8547.914520854789;8548.316134709225;8742.606582703778;8751;8411.789705257372;8664.176903194202;8672.826543469142;8677.26243269323;8684.73945781626;2029.6143732690816;2230.2863083813186;2290.3014580552926;2301.1945818963395;2327.406511339606;2337.801286890616;2345.3550273674705;2346.765323467657;2349.4361353275262;2353.211674089182;2329.767023297665;2330.615448451012;2354.281944007077;2359.4573248152933;2361.7992470640015;2003.8096380843797;2209.812165965895;2283.4633861042644;2284.7258329000542;2288.4622113803243;2297.322289924476;2314.051238992022;2335.1243283768586;2336.0889253191267;2336.112277334602;8547.957260213721;8592.699255526026;8593.613287402082;8593.742187734379;8603.483790972561;5098.260752190911;5178.766955487012;5219.138842091051;5221.347331583552;5231.659942103751;3207.3642442354335;3303.8348082596012;3366.1248075500303;3435.3129374125024;3441.8107004114763;1108.972275693106;1139.344876695895;1151.3034614058543;1172.7947609168448;1189.0903458853984;11546.249493782878;11643.24318919259;11680.123990700646;11703.824442633368;11865.40672966357;4499.212637788374;4591.770411479412;4669.369635099286;4688.413948256468;4689.484156742756;10147.898521014695;10187.7453063674;10214;10215.693529194135;10216.795664086676;5304.602154838402;5313.362396512366;5314.7608357624;5315.043292207362;5315.3090098286975;4149.979250103791;4688.789004494806;4824;4828.46886842447;4923.187674033816;3748.83130259139;3814.4659747635355;3899.2786334528205;3899.9610003899597;3941.3102707026155;1226.45422786859;1227.5274019502376;1243.7699025680279;1246.7755803955374;1254.861965183829;878.2052242720348;884.2395539835736;901.9188273055456;931.4644079654225;988.9159421449258;5992.43071908168;6077.149199112039;6091.329953705089;6125.989211780006;6261.7182226799905;980.5048450532436;981.3326937682444;990.7523119220195;1034.4775888176423;1090.1496832470687;4138.6482149017675;4205.936910946339;4243.236217480821;4300.247456695066;4328.485030239391;10812.243142979916;10997.34015959045;11049.723756905982;11124.610638627772;11140.610078647209;10784.568617255221;10890.61882834097;11002.50488728009;11015.228933974706;11015.669529914116;7630.160682324939;7978.880316795253;7980.281774640311;8165.224303691259;8167.95916020428;5893.116032595145;6118.908216376669;6185.783497577563;6238.157848690369;6249.843753906189;9461.810763784548;9874.160696340892;10118.038786315288;10174.949125254327;10188.134008609351;9930.404175749478;10142.49287535635;10293.588256469657;10315;10345;7000.229974702676;7516.285952834472;7655.6937722490475;7735.458517903693;7811.609419529114;8617.741467755977;8653.221210091122;8730.65077396897;8736.956315218384;8751.256143227896;7540.547567145989;7580.583067931317;7662.501937374052;7755.069391673035;7881.763547093367;7589.544627322378;7710.807229819299;7730.111037230566;7804.492707973964;7861.331786797958;6805.1833779944745;6851.931480685329;6869.931300686929;6880.8967865483055;6885.1049363582415;5020.849374518771;5027.7737501813235;5189.662671926313;5328.8401347959625;5345.1714984177515;5269.45868832177;5269.683818970874;5302.098643230583;5397.757100930546;5548.944510554843 06:06:31 INFO - PROCESS | 11252 | |4;prototype.html;323.4533638151522;332.3834287396879;335.1921868297401;338.1175132903122;339.53653263295604;5115.669925819286;5237.7904883804695;5313.256144139824;5318.574514038877;5321.52106310432;5287.629865909388;5341.1187154119525;5341.65279256848;5345.385280692722;5348.786048558053;4169.937450938239;4194.161167766459;4196.979015104936;4200.621944025037;4217.957820421802;3965.355110121257;4014.6386825185728;4067.6745860331253;4212.368144778277;4214.620684138427;4115.814788334532;4122.7631710486885;4132.648724858391;4133.6693064554765;4135.710500264982;4146.8133933972895;4159.854405095823;4175.457190565237;4176.102138040336;4182.749035057906;3515.384807658675;3637.5998640149564;3692.3169213695282;3705.573859006222;3710.3692372296773;5067.39191297043;5083.466236045236;5120.257562653394;5127.179651255781;5153.484651534854;4683.437987441529;4689.718616882998;4696.553827386427;4699.718016918996;4704.764761761899;5306.8407947761625;5458.91811622822;5484.506394424481;5509.449055094498;5531.3362396512275;3907.199024200032;3907.886252418076;3918.7060970427333;3918.8432462701458;3930.862419815293;5693.715314234313;5704.657720536739;5707.229524014247;5707.800226992035;5710.885782284373;3906.8046597670004;4064.288749468831;4075.2053349597136;4076.3885417187657;4085.91828163441;4083.2037752637953;4115.279826030433;4116.682661548336;4131.995981948812;4173.916521669549;4694.342792009122;4726.810927562928;4731.858044258678;4745.810167593327;4757.429108506932;5282.498162674539;5581.441855814467;5593.804216852391;5612.747426365823;5612.85967850807;1379.1380387257964;1408;1440.6038339456734;1449.5506393017988;1453.9709205816037;910.7131253655077;955.4983633592419;964.4599024546277;967.777411195429;975.8682577851899;4628.629709623222;4702.3416721659;4722.527747225318;4723.881902952454;4749.762511874393;4990.5508504234795;5007.324011258506;5014.674046186986;5014.974925125351;5065.341505604321;4724.456687480983;4733.810647574127;4758.262469317192;4786.976065119652;4961.957988822388;2968.985155074254;2970;2990.1627544287635;3014.4927536231885;3045.7258846703903;5848.625572990344;5848.88302233953;5882.735276912549;5910.7291932234775;5920.467157955804;5626.1842032905;5879.500242479352;5889.676067816225;5897.292324921037;5965.0455927052335;5795.1017592273265;5816.621919575214;5828.88342233153;5855.3266374367495;5880.941190588125;5383.165609330404;5673.290838645169;5711.7429715662065;5721.713914304185;5732.770689172553;5656.60403771732;5666.943330566642;5669.801556945487;5693.4875861172695;5714.171445140514;5796.029350021013;5803.216565763737;5818.24362832846;5846.853828654318;5851.502622277154;3841.5966323535627;4015.955851478578;4032.568438204395;4069.1658210066275;4072.348424252224;5481.369642491005;5569.832905012856;5658.688772117573;5663.66018038919;5671.404502527175;5547.8890422192135;5556.916646250229;5563.805266815642;5609;5621.831345059655;5543.972280138573;5550.972245138749;5552.305961754781;5559.388467268678;5575.769692123184;5255.842324730264;5490.149026900836;5491.560675146058;5498.862528436821;5514.6691198528215;5540.667559946416;5562;5577.832665020056;5586.162075688517;5627.774889004558;5260.73696315175;5492;5523.392426833126;5530.391656917816;5530.474604912688 06:06:31 INFO - PROCESS | 11252 | |5;yui.html;724.9383802376801;742.6323969635032;745.8545583611198;756.7767508584967;768.1473564343579;14352.856471435283;14799.630009249748;15365.231738413077;15373.999999999973;15404.922975385121;15260.847391526082;15450.845491545082;15457.613559661015;15463.07221566704;15469.535913922573;633.20532731422;739.4971419434783;747.5552046532318;756.1191212237763;764.8355603545236;764.0831002796639;767.221270410531;769.9961500192492;770.537677393565;770.9807254818618;802.0255389701512;805.5086397297644;805.5327909812295;805.5810978291285;806.1978331560076;667.3593350383637;772.5750837039634;780.153533416244;782.6047845837873;798.7523867601062;586.6069733278714;586.6362855029909;586.7066466766616;587.0196771391786;587.5857520448074;14811.703765924729;14887.404503819835;14893.478728244569;14898.106113633217;14946.925265373713;13590.184588924696;13750.724985500234;13786.862131378659;13926.860731392657;14165.929170354082;12462.098695745632;12530.81203781944;12612.68468288291;12777.552785652457;12953.352332383438;4312.116016216668;4354.912901741979;4358.782060896974;4405.757683327416;4512.413386259798;69250.65374673145;72261.63869180673;72683;75598;76040.23959760442;11353.318800871974;11455.369954652408;11699;11866.347350895783;12093.818592721116;19550;19576.412707618794;19630.509237269183;19652.41042768719;19658.213671453268;8369.874451883226;8586.31309495239;8625.611847466878;8638.870416943751;8648.308135349156;4924.507549245047;4956.801727930914;4961.156603377434;5014.974925125424;5016.272640467112;3546.414841551167;3633.4004889193516;3634.491171236029;3634.636536346397;3643.690286325692;599.2569214174392;600.6786369292495;612.8222815383489;614.0574218574467;614.3058344071171;680.2992917295194;695.0824911117378;695.4714417042983;697.5326531224092;710.4174576847039;8952;9141.954290228507;9360.11078947499;9441.716748497556;9517.952410238044;603.9124326972565;613.8219916224245;631.3528633151057;650.193759737931;682.4014597457348;4620.514845941195;4681.133990211753;4688.531146885284;4695.272232803921;4765.209804077111;96752.51623741977;102384;103022.48488757657;115851.42074289743;116337;99514.5024274874;101898.49050754699;102326.48836755917;102839.4858025705;103229;87492.56253718691;88228.55885720659;89790.55104724565;90018.54990725004;91602;8878;9016.729498115066;9106.089391060841;9157.130072643089;9182.95408522953;46019;46379.76810115928;47845.521544784104;50962.490375095775;51255;48986.0202795935;54674.72662636662;58887.41112588819;62907;75855.55227805699;12162.574309899464;12818.74362512726;12985.48058077704;12998.740025199631;13467.259300738553;11741.823872642088;12235.877641223475;12398.07014473936;14515.85484145145;14549.709005819612;14149.787753183504;14575.708485830437;14820.925895370454;14955.476558320406;15367.385304587691;13962.650933726332;14236.501722439665;14483;14954.700905981601;15105;14157.929210353883;14228.430862765374;14330.996830221784;14536.781948270997;15052;10906.781864362827;11078.501467434146;11174.49714762854;11437.256578322382;11750.412479375826;11860.466279017292;11957.940210298893;12142.817857732318;12178.269303841798;12311.692207694521 06:06:31 INFO - PROCESS | 11252 | __end_tp_report 06:06:31 INFO - PROCESS | 11252 | __start_cc_report 06:06:31 INFO - PROCESS | 11252 | _x_x_mozilla_cycle_collect,1060 06:06:31 INFO - PROCESS | 11252 | __end_cc_report 06:06:31 INFO - PROCESS | 11252 | __startTimestamp1466514391037__endTimestamp 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | ------- Summary: start ------- 06:06:31 INFO - PROCESS | 11252 | Number of tests: 6 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#0] dojo.html Cycles:165 Average:5350.36 Median:5538.25 stddev:609.12 (11.0%) stddev-sans-first:583.92 06:06:31 INFO - PROCESS | 11252 | Values: 3061.4 3076.4 3095.6 3106.3 3120.7 5178.8 5241.7 5368.0 5384.4 5420.8 5333.1 5340.5 5388.4 5469.7 5510.3 4856.8 4912.6 4925.5 4927.8 5077.0 4985.8 5024.9 5027.3 5045.8 5051.3 4782.9 4796.7 4815.1 4841.5 5001.2 4861.2 4865.4 4865.6 4907.7 4946.1 4850.6 4897.4 4901.7 4913.5 4932.0 5212.7 5292.6 5375.7 5390.8 5416.4 5787.1 5788.5 5835.7 5847.8 5848.4 5825.7 5861.4 5875.2 5878.4 5882.0 5267.1 5347.8 5380.2 5385.7 5481.6 5968.3 5973.9 5974.7 5979.7 5982.1 5731.7 5735.3 5745.2 5749.7 5749.8 5505.9 5706.6 5749.7 5751.2 5809.9 5765.9 5768.3 5769.5 5781.0 5784.2 5567.6 5736.2 5779.0 5785.4 5791.5 4344.6 4396.6 4399.3 4404.3 4417.1 3921.3 3923.5 3927.8 3950.2 3964.0 5285.1 5388.3 5390.7 5404.1 5419.0 5747.8 5779.9 5804.8 5815.1 5824.8 5471.7 5479.5 5482.5 5484.3 5485.9 4868.3 4937.7 5033.2 5033.4 5084.3 5837.6 5934.9 5940.3 5974.2 5977.6 5793.1 5799.5 5804.4 5806.5 5806.8 5581.2 5766.2 5928.0 5937.1 5939.0 5566.0 5612.5 5613.2 5617.0 5680.3 5639.2 5708.9 5713.7 5717.7 5727.7 5484.1 5530.7 5538.3 5603.9 5651.8 5604.9 5613.0 5614.9 5615.2 5621.0 5535.1 5556.7 5605.9 5606.8 5615.2 5649.7 5703.9 5712.4 5715.2 5717.9 5376.8 5500.0 5505.3 5549.8 5556.6 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#1] ext.html Cycles:180 Average:56235.46 Median:40812.40 stddev:110488.45 (270.7%) stddev-sans-first:110719.35 06:06:31 INFO - PROCESS | 11252 | Values: 572.0 619.6 624.7 630.6 636.4 28623.9 40507.8 41067.4 41313.6 43576.3 43916.0 44328.8 44345.6 44557.8 44729.8 8848.6 9023.7 9027.3 9029.0 9037.1 8843.3 8847.3 8868.1 8885.5 8886.9 8884.2 8913.0 8918.5 8920.9 8958.4 8929.0 8952.0 8970.1 8972.2 8980.6 8855.2 8912.3 8921.3 8928.3 8931.9 41847.6 42007.4 42021.2 42126.0 42214.6 3385.6 3409.9 3413.5 3469.9 3997.9 31556.7 31827.7 32413.4 32441.2 32459.7 4304.0 4406.1 4428.6 4485.1 4543.9 245839.0 246201.0 246337.0 246657.0 246918.0 55267.7 55574.2 55680.7 55700.2 55702.7 57007.7 57878.0 57907.1 58022.7 58035.7 16737.0 16812.2 16947.5 16969.2 16978.7 13165.5 13203.3 13240.7 13241.5 13242.5 15107.2 15430.7 15635.3 15667.4 15827.3 5962.4 6072.7 6154.5 6169.6 6294.9 950.2 1049.7 1099.4 1103.9 1114.2 30367.7 30546.5 30845.8 30874.0 31233.0 1051.8 1089.3 1143.0 1144.1 1156.2 15936.7 16134.6 16153.3 16182.0 16447.9 533706.0 537889.0 539388.0 541438.0 542296.0 56981.4 57087.7 57108.4 57149.4 57249.0 1228.3 1322.3 1330.4 1339.3 1359.5 31957.8 32521.3 33288.2 33365.0 33560.7 49214.8 49474.0 49526.8 49646.8 49818.0 402010.0 409754.0 410214.0 411405.0 413985.0 34118.7 39216.4 40051.8 40610.2 40813.0 40279.8 40356.4 40811.8 41144.4 41414.8 39755.6 40567.8 40646.4 41171.4 41688.0 38928.8 39627.0 40021.0 40077.2 40709.8 39860.4 40666.0 40740.0 40805.4 40910.2 34139.3 35284.3 35519.3 35747.5 36160.6 26763.9 27075.6 27496.3 27613.9 27710.0 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#2] jquery.html Cycles:180 Average:28043.42 Median:21351.75 stddev:77509.57 (363.0%) stddev-sans-first:77699.16 06:06:31 INFO - PROCESS | 11252 | Values: 372.3 383.1 394.7 395.2 406.1 17725.4 18640.9 20399.1 20403.3 20423.9 11824.5 12065.0 12344.9 12353.6 12358.1 5096.2 5306.2 5365.1 5365.8 5368.3 3874.5 5499.4 5757.2 5760.4 5861.5 5821.5 5823.2 5841.1 5848.5 6098.4 6221.9 6324.6 6348.4 6359.3 6388.2 3809.2 5269.4 5586.7 5590.7 5665.8 13576.9 13693.7 13718.1 13874.1 14167.8 2176.5 2371.6 2404.4 2449.7 2913.1 10023.9 10072.6 10143.5 10593.2 12552.1 1848.9 1988.5 1988.6 1999.8 2083.7 84985.6 86970.0 87089.0 87812.0 88628.6 10737.5 10790.5 10863.3 11037.3 11086.6 15256.5 15368.5 15378.0 15379.7 15404.8 8051.2 8195.0 8295.4 8363.7 8405.5 8005.5 8020.1 8028.7 8195.4 8197.1 4715.4 4716.8 4731.7 4760.9 4865.7 1761.5 1823.2 1939.2 1941.4 1989.5 864.0 976.5 979.5 981.9 1020.7 18260.5 19224.8 19279.3 19448.2 19624.8 947.9 957.2 961.2 997.4 1015.5 9088.6 10987.3 11015.4 11031.8 11091.7 465862.0 467579.0 469552.0 470610.0 470689.0 56397.7 90587.0 92499.5 92719.5 93371.0 942.1 958.9 984.3 985.7 986.6 16787.6 16900.7 17182.5 17185.2 17395.4 34217.1 38829.0 41761.2 42073.8 42232.4 59322.0 60854.4 60954.7 61007.0 61789.7 8491.3 8680.7 8877.6 8959.2 8980.6 10079.6 13858.7 13894.2 14042.9 14204.4 11899.8 11931.2 11938.8 12394.6 12444.6 12079.3 12123.3 12190.0 12314.6 12748.7 12065.0 12486.5 12487.4 12602.2 12622.8 8905.4 8910.6 8914.7 8971.2 9270.4 10580.4 11906.2 12036.3 12354.3 12424.3 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#3] mootools.html Cycles:180 Average:5767.66 Median:4756.74 stddev:3250.02 (68.3%) stddev-sans-first:3242.07 06:06:31 INFO - PROCESS | 11252 | Values: 1335.7 1430.6 1467.8 1577.6 1725.8 8136.9 8547.9 8548.3 8742.6 8751.0 8411.8 8664.2 8672.8 8677.3 8684.7 2029.6 2230.3 2290.3 2301.2 2327.4 2337.8 2345.4 2346.8 2349.4 2353.2 2329.8 2330.6 2354.3 2359.5 2361.8 2003.8 2209.8 2283.5 2284.7 2288.5 2297.3 2314.1 2335.1 2336.1 2336.1 8548.0 8592.7 8593.6 8593.7 8603.5 5098.3 5178.8 5219.1 5221.3 5231.7 3207.4 3303.8 3366.1 3435.3 3441.8 1109.0 1139.3 1151.3 1172.8 1189.1 11546.2 11643.2 11680.1 11703.8 11865.4 4499.2 4591.8 4669.4 4688.4 4689.5 10147.9 10187.7 10214.0 10215.7 10216.8 5304.6 5313.4 5314.8 5315.0 5315.3 4150.0 4688.8 4824.0 4828.5 4923.2 3748.8 3814.5 3899.3 3900.0 3941.3 1226.5 1227.5 1243.8 1246.8 1254.9 878.2 884.2 901.9 931.5 988.9 5992.4 6077.1 6091.3 6126.0 6261.7 980.5 981.3 990.8 1034.5 1090.1 4138.6 4205.9 4243.2 4300.2 4328.5 10812.2 10997.3 11049.7 11124.6 11140.6 10784.6 10890.6 11002.5 11015.2 11015.7 7630.2 7978.9 7980.3 8165.2 8168.0 5893.1 6118.9 6185.8 6238.2 6249.8 9461.8 9874.2 10118.0 10174.9 10188.1 9930.4 10142.5 10293.6 10315.0 10345.0 7000.2 7516.3 7655.7 7735.5 7811.6 8617.7 8653.2 8730.7 8737.0 8751.3 7540.5 7580.6 7662.5 7755.1 7881.8 7589.5 7710.8 7730.1 7804.5 7861.3 6805.2 6851.9 6869.9 6880.9 6885.1 5020.8 5027.8 5189.7 5328.8 5345.2 5269.5 5269.7 5302.1 5397.8 5548.9 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#4] prototype.html Cycles:180 Average:4620.77 Median:5195.64 stddev:1352.27 (26.0%) stddev-sans-first:1317.04 06:06:31 INFO - PROCESS | 11252 | Values: 323.5 332.4 335.2 338.1 339.5 5115.7 5237.8 5313.3 5318.6 5321.5 5287.6 5341.1 5341.7 5345.4 5348.8 4169.9 4194.2 4197.0 4200.6 4218.0 3965.4 4014.6 4067.7 4212.4 4214.6 4115.8 4122.8 4132.6 4133.7 4135.7 4146.8 4159.9 4175.5 4176.1 4182.7 3515.4 3637.6 3692.3 3705.6 3710.4 5067.4 5083.5 5120.3 5127.2 5153.5 4683.4 4689.7 4696.6 4699.7 4704.8 5306.8 5458.9 5484.5 5509.4 5531.3 3907.2 3907.9 3918.7 3918.8 3930.9 5693.7 5704.7 5707.2 5707.8 5710.9 3906.8 4064.3 4075.2 4076.4 4085.9 4083.2 4115.3 4116.7 4132.0 4173.9 4694.3 4726.8 4731.9 4745.8 4757.4 5282.5 5581.4 5593.8 5612.7 5612.9 1379.1 1408.0 1440.6 1449.6 1454.0 910.7 955.5 964.5 967.8 975.9 4628.6 4702.3 4722.5 4723.9 4749.8 4990.6 5007.3 5014.7 5015.0 5065.3 4724.5 4733.8 4758.3 4787.0 4962.0 2969.0 2970.0 2990.2 3014.5 3045.7 5848.6 5848.9 5882.7 5910.7 5920.5 5626.2 5879.5 5889.7 5897.3 5965.0 5795.1 5816.6 5828.9 5855.3 5880.9 5383.2 5673.3 5711.7 5721.7 5732.8 5656.6 5666.9 5669.8 5693.5 5714.2 5796.0 5803.2 5818.2 5846.9 5851.5 3841.6 4016.0 4032.6 4069.2 4072.3 5481.4 5569.8 5658.7 5663.7 5671.4 5547.9 5556.9 5563.8 5609.0 5621.8 5544.0 5551.0 5552.3 5559.4 5575.8 5255.8 5490.1 5491.6 5498.9 5514.7 5540.7 5562.0 5577.8 5586.2 5627.8 5260.7 5492.0 5523.4 5530.4 5530.5 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - PROCESS | 11252 | [#5] yui.html Cycles:180 Average:20206.01 Median:25530.45 stddev:28826.42 (112.9%) stddev-sans-first:28870.17 06:06:31 INFO - PROCESS | 11252 | Values: 724.9 742.6 745.9 756.8 768.1 14352.9 14799.6 15365.2 15374.0 15404.9 15260.8 15450.8 15457.6 15463.1 15469.5 633.2 739.5 747.6 756.1 764.8 764.1 767.2 770.0 770.5 771.0 802.0 805.5 805.5 805.6 806.2 667.4 772.6 780.2 782.6 798.8 586.6 586.6 586.7 587.0 587.6 14811.7 14887.4 14893.5 14898.1 14946.9 13590.2 13750.7 13786.9 13926.9 14165.9 12462.1 12530.8 12612.7 12777.6 12953.4 4312.1 4354.9 4358.8 4405.8 4512.4 69250.7 72261.6 72683.0 75598.0 76040.2 11353.3 11455.4 11699.0 11866.3 12093.8 19550.0 19576.4 19630.5 19652.4 19658.2 8369.9 8586.3 8625.6 8638.9 8648.3 4924.5 4956.8 4961.2 5015.0 5016.3 3546.4 3633.4 3634.5 3634.6 3643.7 599.3 600.7 612.8 614.1 614.3 680.3 695.1 695.5 697.5 710.4 8952.0 9142.0 9360.1 9441.7 9518.0 603.9 613.8 631.4 650.2 682.4 4620.5 4681.1 4688.5 4695.3 4765.2 96752.5 102384.0 103022.5 115851.4 116337.0 99514.5 101898.5 102326.5 102839.5 103229.0 87492.6 88228.6 89790.6 90018.5 91602.0 8878.0 9016.7 9106.1 9157.1 9183.0 46019.0 46379.8 47845.5 50962.5 51255.0 48986.0 54674.7 58887.4 62907.0 75855.6 12162.6 12818.7 12985.5 12998.7 13467.3 11741.8 12235.9 12398.1 14515.9 14549.7 14149.8 14575.7 14820.9 14955.5 15367.4 13962.7 14236.5 14483.0 14954.7 15105.0 14157.9 14228.4 14331.0 14536.8 15052.0 10906.8 11078.5 11174.5 11437.3 11750.4 11860.5 11957.9 12142.8 12178.3 12311.7 06:06:31 INFO - PROCESS | 11252 | -------- Summary: end -------- 06:06:31 INFO - PROCESS | 11252 | 06:06:31 INFO - TEST-INFO | 11252: exit 0 06:06:31 INFO - TEST-OK | dromaeo_css | took 1114493ms 06:06:31 INFO - TEST-START | kraken 06:06:31 INFO - operating with platform_type : linux_ 06:06:31 INFO - Initialising browser for kraken test... 06:06:31 INFO - TEST-INFO | started process 11434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptqGfNg/profile http://localhost:59335/getInfo.html) 06:06:35 INFO - PROCESS | 11434 | __metrics Screen width/height:1600/1200 06:06:35 INFO - PROCESS | 11434 | colorDepth:24 06:06:35 INFO - PROCESS | 11434 | Browser inner width/height: 1024/697 06:06:35 INFO - PROCESS | 11434 | __metrics 06:06:36 INFO - PROCESS | 11434 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:37 INFO - TEST-INFO | 11434: exit 0 06:06:37 INFO - Browser initialized. 06:06:37 INFO - Running cycle 1/1 for kraken test... 06:06:37 INFO - TEST-INFO | started process 11515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptqGfNg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:49 INFO - PROCESS | 11515 | RSS: Main: 173060096 06:06:49 INFO - PROCESS | 11515 | 06:06:51 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:52 INFO - PROCESS | 11515 | RSS: Main: 232460288 06:06:52 INFO - PROCESS | 11515 | 06:06:55 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-dft) 06:06:55 INFO - PROCESS | 11515 | RSS: Main: 220454912 06:06:55 INFO - PROCESS | 11515 | 06:06:59 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-fft) 06:06:59 INFO - PROCESS | 11515 | RSS: Main: 286060544 06:06:59 INFO - PROCESS | 11515 | 06:07:01 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-oscillator) 06:07:02 INFO - PROCESS | 11515 | RSS: Main: 198250496 06:07:02 INFO - PROCESS | 11515 | 06:07:04 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:05 INFO - PROCESS | 11515 | RSS: Main: 202006528 06:07:05 INFO - PROCESS | 11515 | 06:07:08 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:08 INFO - PROCESS | 11515 | RSS: Main: 236851200 06:07:08 INFO - PROCESS | 11515 | 06:07:12 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:12 INFO - PROCESS | 11515 | RSS: Main: 237723648 06:07:12 INFO - PROCESS | 11515 | 06:07:15 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59335/tests/kraken/driver.html?testName=json-parse-financial) 06:07:16 INFO - PROCESS | 11515 | RSS: Main: 237826048 06:07:16 INFO - PROCESS | 11515 | 06:07:17 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:18 INFO - PROCESS | 11515 | RSS: Main: 226664448 06:07:18 INFO - PROCESS | 11515 | 06:07:19 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:20 INFO - PROCESS | 11515 | RSS: Main: 229167104 06:07:20 INFO - PROCESS | 11515 | 06:07:22 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:23 INFO - PROCESS | 11515 | RSS: Main: 238944256 06:07:23 INFO - PROCESS | 11515 | 06:07:25 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:26 INFO - PROCESS | 11515 | RSS: Main: 242053120 06:07:26 INFO - PROCESS | 11515 | 06:07:29 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:29 INFO - PROCESS | 11515 | RSS: Main: 240726016 06:07:29 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59335/tests/kraken/driver.html?testName=ai-astar) 06:07:31 INFO - PROCESS | 11515 | RSS: Main: 283987968 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | __start_tp_report 06:07:31 INFO - PROCESS | 11515 | _x_x_mozilla_page_load 06:07:31 INFO - PROCESS | 11515 | _x_x_mozilla_page_load_details 06:07:31 INFO - PROCESS | 11515 | |i|pagename|runs| 06:07:31 INFO - PROCESS | 11515 | |0;ai-astar;110;106;108;108;112;108;109;108;109;111 06:07:31 INFO - PROCESS | 11515 | |1;audio-beat-detection;150;125;126;176;129;130;154;131;159;125 06:07:31 INFO - PROCESS | 11515 | |2;audio-dft;161;160;161;159;160;161;162;160;160;160 06:07:31 INFO - PROCESS | 11515 | |3;audio-fft;74;75;76;128;76;76;75;75;98;75 06:07:31 INFO - PROCESS | 11515 | |4;audio-oscillator;84;85;114;85;86;85;116;87;86;134 06:07:31 INFO - PROCESS | 11515 | |5;imaging-gaussian-blur;117;117;116;117;116;118;116;117;116;117 06:07:31 INFO - PROCESS | 11515 | |6;imaging-darkroom;146;145;146;146;145;145;145;146;145;146 06:07:31 INFO - PROCESS | 11515 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 06:07:31 INFO - PROCESS | 11515 | |8;json-parse-financial;53;55;53;55;54;56;56;54;54;54 06:07:31 INFO - PROCESS | 11515 | |9;json-stringify-tinderbox;63;62;61;62;63;61;62;63;62;62 06:07:31 INFO - PROCESS | 11515 | |10;stanford-crypto-aes;83;83;84;83;85;83;90;85;135;84 06:07:31 INFO - PROCESS | 11515 | |11;stanford-crypto-ccm;135;120;133;124;120;123;120;128;128;124 06:07:31 INFO - PROCESS | 11515 | |12;stanford-crypto-pbkdf2;168;160;160;161;160;162;162;161;165;173 06:07:31 INFO - PROCESS | 11515 | |13;stanford-crypto-sha256-iterative;67;64;71;64;66;63;62;62;63;60 06:07:31 INFO - PROCESS | 11515 | __end_tp_report 06:07:31 INFO - PROCESS | 11515 | __start_cc_report 06:07:31 INFO - PROCESS | 11515 | _x_x_mozilla_cycle_collect,1625 06:07:31 INFO - PROCESS | 11515 | __end_cc_report 06:07:31 INFO - PROCESS | 11515 | __startTimestamp1466514451748__endTimestamp 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | ------- Summary: start ------- 06:07:31 INFO - PROCESS | 11515 | Number of tests: 14 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.73 (1.6%) stddev-sans-first:1.79 06:07:31 INFO - PROCESS | 11515 | Values: 110.0 106.0 108.0 108.0 112.0 108.0 109.0 108.0 109.0 111.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:140.50 stddev:17.95 (12.8%) stddev-sans-first:18.70 06:07:31 INFO - PROCESS | 11515 | Values: 150.0 125.0 126.0 176.0 129.0 130.0 154.0 131.0 159.0 125.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 06:07:31 INFO - PROCESS | 11515 | Values: 161.0 160.0 161.0 159.0 160.0 161.0 162.0 160.0 160.0 160.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:17.43 (23.1%) stddev-sans-first:18.19 06:07:31 INFO - PROCESS | 11515 | Values: 74.0 75.0 76.0 128.0 76.0 76.0 75.0 75.0 98.0 75.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.12 (21.3%) stddev-sans-first:18.68 06:07:31 INFO - PROCESS | 11515 | Values: 84.0 85.0 114.0 85.0 86.0 85.0 116.0 87.0 86.0 134.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:07:31 INFO - PROCESS | 11515 | Values: 117.0 117.0 116.0 117.0 116.0 118.0 116.0 117.0 116.0 117.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:07:31 INFO - PROCESS | 11515 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:07:31 INFO - PROCESS | 11515 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.07 (2.0%) stddev-sans-first:1.01 06:07:31 INFO - PROCESS | 11515 | Values: 53.0 55.0 53.0 55.0 54.0 56.0 56.0 54.0 54.0 54.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 06:07:31 INFO - PROCESS | 11515 | Values: 63.0 62.0 61.0 62.0 63.0 61.0 62.0 63.0 62.0 62.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:84.00 stddev:16.13 (19.2%) stddev-sans-first:16.93 06:07:31 INFO - PROCESS | 11515 | Values: 83.0 83.0 84.0 83.0 85.0 83.0 90.0 85.0 135.0 84.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:5.38 (4.3%) stddev-sans-first:4.48 06:07:31 INFO - PROCESS | 11515 | Values: 135.0 120.0 133.0 124.0 120.0 123.0 120.0 128.0 128.0 124.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:162.00 stddev:4.29 (2.6%) stddev-sans-first:4.18 06:07:31 INFO - PROCESS | 11515 | Values: 168.0 160.0 160.0 161.0 160.0 162.0 162.0 161.0 165.0 173.0 06:07:31 INFO - PROCESS | 11515 | 06:07:31 INFO - PROCESS | 11515 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:3.12 (4.9%) stddev-sans-first:3.14 06:07:31 INFO - PROCESS | 11515 | Values: 67.0 64.0 71.0 64.0 66.0 63.0 62.0 62.0 63.0 60.0 06:07:31 INFO - PROCESS | 11515 | -------- Summary: end -------- 06:07:31 INFO - PROCESS | 11515 | 06:07:32 INFO - TEST-INFO | 11515: exit 0 06:07:32 INFO - TEST-OK | kraken | took 60921ms 06:07:32 INFO - SUITE-END | took 1175s 06:07:32 INFO - Completed test suite (00:19:35) 06:07:32 INFO - javascript benchmark 06:07:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.433634777566, 3076.369344284422, 3095.582096416984, 3106.347666989932, 3120.656727759946, 5178.792848286064, 5241.685498870061, 5367.973160134199, 5384.40771515133, 5420.756065977031, 5333.120035194198, 5340.49265319795, 5388.353397592285, 5469.671819690821, 5510.311211098613, 4856.805727770885, 4912.557869791718, 4925.532074452921, 4927.802887884481, 5076.974615126919, 4985.825496107637, 5024.924626130611, 5027.271045698371, 5045.798168073273, 5051.343325367697, 4782.856514304576, 4796.712197268158, 4815.109204797123, 4841.515848415165, 5001.199808030716, 4861.197902346109, 4865.3675022247235, 4865.6107511399005, 4907.68100073494, 4946.109700253953, 4850.5877000455, 4897.436794768611, 4901.730404827733, 4913.533214344668, 4932.0, 5212.713300768456, 5292.576593872481, 5375.6774593524515, 5390.757415916293, 5416.431274716177, 5787.13193021046, 5788.450097240755, 5835.708214589254, 5847.795327163529, 5848.356680765112, 5825.708714564297, 5861.3552509223955, 5875.206847075633, 5878.441548052928, 5882.0, 5267.104592219332, 5347.759350829183, 5380.192971054373, 5385.676859388371, 5481.588880833913, 5968.283805943314, 5973.850653733692, 5974.731137098841, 5979.701014949235, 5982.1325907744, 5731.713414329351, 5735.340435849931, 5745.2243947067445, 5749.741261643236, 5749.798757043567, 5505.889882202414, 5706.572007099401, 5749.655020698771, 5751.194832723422, 5809.8547536311935, 5765.913511297334, 5768.278965129359, 5769.451902069297, 5781.0, 5784.219130417424, 5567.610267281251, 5736.225609542742, 5779.0, 5785.421457854265, 5791.478766910998, 4344.6089851913475, 4396.582324679151, 4399.340098985178, 4404.2512772828695, 4417.116576684676, 3921.254961557295, 3923.5487918889694, 3927.8036098194975, 3950.249452603996, 3964.0486283291802, 5285.101532739443, 5388.299521062315, 5390.68313737168, 5404.081306177959, 5418.997485465202, 5747.798827041117, 5779.913301300484, 5804.796832110856, 5815.098659707752, 5824.767009319665, 5471.7264136793, 5479.506844384025, 5482.451754824486, 5484.314460692413, 5485.890282194414, 4868.342773725572, 4937.703737775745, 5033.245013248042, 5033.370828646419, 5084.339035925306, 5837.649741015468, 5934.940650593525, 5940.34656187819, 5974.2233509643465, 5977.6114552553945, 5793.131030345482, 5799.507041901317, 5804.361520232686, 5806.506446952057, 5806.796762113306, 5581.246531718329, 5766.221560089334, 5927.9703601481715, 5937.050071988461, 5938.970305148447, 5565.972170139124, 5612.466815652507, 5613.214150018919, 5617.0, 5680.261565996394, 5639.238702775073, 5708.942910570841, 5713.742881570256, 5717.685527296038, 5727.7422515986045, 5484.095124304445, 5530.668159910419, 5538.252335934597, 5603.859903502282, 5651.8304450866535, 5604.915926261027, 5613.045782217115, 5614.887702246014, 5615.241942337732, 5621.0, 5535.086710692691, 5556.694381808878, 5605.859853503695, 5606.775728970959, 5615.213870058276, 5649.71751412436, 5703.857403564944, 5712.400197979152, 5715.199872018004, 5717.8570535736935, 5376.838694839161, 5499.972500137474, 5505.284313039279, 5549.7780088796, 5556.583256255716], "value": 5308.999424831769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9914201286981, 619.5570167330359, 624.697021944357, 630.5775130662457, 636.3636363636364, 28623.856880715593, 40507.79746101269, 41067.38398924019, 41313.58686413135, 43576.3463548047, 43916.0, 44328.778356108254, 44345.55654443455, 44557.77721111398, 44729.77635111828, 8848.5575721214, 9023.729288121367, 9027.277817774595, 9028.954855225747, 9037.05110963346, 8843.336749743763, 8847.292216622687, 8868.113188681145, 8885.511296878669, 8886.86669699955, 8884.200421962023, 8913.0, 8918.464892106495, 8920.910790892105, 8958.417702849327, 8929.0, 8952.015278319379, 8970.102989701043, 8972.192502674758, 8980.640774369018, 8855.24730397917, 8912.287017038687, 8921.286297096216, 8928.285737141077, 8931.910680893174, 41847.58152418467, 42007.369889451686, 42021.1595768086, 42126.0, 42214.577854221374, 3385.5768028996376, 3409.9318013639836, 3413.4538473844314, 3469.947950780715, 3997.8800635980965, 31556.684433155606, 31827.681723182704, 32413.351732965446, 32441.188970275696, 32459.675403245903, 4304.0, 4406.140802543506, 4428.557144285578, 4485.0805584855025, 4543.863684089482, 245839.0, 246201.0, 246337.0, 246657.0, 246918.0, 55267.72366138144, 55574.16638750422, 55680.721596391755, 55700.16449753257, 55702.72148639231, 57007.71496142493, 57878.0, 57907.131393029136, 58022.7098864503, 58035.709821450626, 16737.0, 16812.15939203035, 16947.491575252763, 16969.23638436273, 16978.660426791394, 13165.47338106465, 13203.273819939803, 13240.735185296433, 13241.470341186438, 13242.470301188037, 15107.244637768288, 15430.691386172213, 15635.296411661502, 15667.373305067898, 15827.287772050286, 5962.4225464721685, 6072.696365181811, 6154.5076393888385, 6169.629822210682, 6294.905576416358, 950.1543626172712, 1049.7270709615555, 1099.367863478503, 1103.8564986551858, 1114.1755101225035, 30367.69632303693, 30546.54180187299, 30845.845770771004, 30874.0, 31233.0, 1051.779126383468, 1089.3137323486153, 1142.9657110286705, 1144.0790163918125, 1156.1733360647177, 15936.681266374608, 16134.596635083983, 16153.273102710406, 16182.0, 16447.91776041112, 533706.0, 537889.0, 539388.0, 541438.0, 542296.0, 56981.43018569761, 57087.714561426925, 57108.42891571114, 57149.428505715245, 57249.0, 1228.3489750432286, 1322.272749987503, 1330.381372661717, 1339.3169483563258, 1359.5445525748787, 31957.840210798797, 32521.349573007934, 33288.1677958053, 33365.0, 33560.66439335673, 49214.753926230136, 49474.0, 49526.75236623794, 49646.75176624094, 49818.0, 402010.0, 409754.0, 410214.0, 411405.0, 413985.0, 34118.658813411545, 39216.411753824286, 40051.79974100111, 40610.18779624332, 40813.0, 40279.798601006805, 40356.3946540808, 40811.79594102011, 41144.38283425811, 41414.792926035174, 39755.60244397635, 40567.79716101401, 40646.39030414487, 41171.38242926299, 41688.0, 38928.80535597304, 39627.0, 40021.0, 40077.198456030135, 40709.79645101874, 39860.40209396919, 40666.0, 40740.0, 40805.38791918183, 40910.1817963645, 34139.31721365509, 35284.294314114086, 35519.28961420705, 35747.46378804268, 36160.63839361573, 26763.86618066897, 27075.59386609163, 27496.312592185357, 27613.86193069022, 27710.0], "value": 19631.57484668028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.272207833685, 383.1379396358194, 394.65664871561745, 395.2154972379826, 406.11061774713374, 17725.379611713593, 18640.906795466002, 20399.08204130812, 20403.285884994028, 20423.897880510594, 11824.527018919232, 12065.0, 12344.876551234485, 12353.567625133122, 12358.134930554865, 5096.210087436453, 5306.151015837467, 5365.087935051031, 5365.7853685852515, 5368.32895888014, 3874.496315478998, 5499.395066542677, 5757.193992841006, 5760.423957604248, 5861.472467477926, 5821.53427725781, 5823.213866128082, 5841.123831425278, 5848.502877255439, 6098.359672234418, 6221.875562488747, 6324.557280990332, 6348.428641422248, 6359.332270111641, 6388.169537960035, 3809.1619843634357, 5269.446708095671, 5586.664800112007, 5590.664560126364, 5665.801696940587, 13576.864231357658, 13693.699098585717, 13718.108322958975, 13874.098183618033, 14167.78748318776, 2176.4667656424276, 2371.632396978471, 2404.4349577849193, 2449.6570480132796, 2913.1115009921964, 10023.918676499885, 10072.597096116147, 10143.543540540619, 10593.205509586813, 12552.121351505399, 1848.8705790594663, 1988.4631149589675, 1988.6221617892554, 1999.8300144487737, 2083.718697975769, 84985.57507212486, 86970.0, 87089.0, 87812.0, 88628.5568572153, 10737.516811743333, 10790.460476976119, 10863.348199108079, 11037.302503661364, 11086.61196858106, 15256.46602368934, 15368.462103826312, 15378.0, 15379.692406151815, 15404.768928466083, 8051.2351326623875, 8195.0, 8295.419320647617, 8363.707270245512, 8405.495670259805, 8005.519668819889, 8020.077691065486, 8028.678852845937, 8195.385346098947, 8197.139300373494, 4715.434147902273, 4716.811327546929, 4731.668783185213, 4760.904781904412, 4865.7323847188745, 1761.5419990802484, 1823.1522342110718, 1939.1952339778834, 1941.369055057112, 1989.502624343914, 863.9654413823503, 976.497103991445, 979.4808751361647, 981.8969008254173, 1020.6886899495726, 18260.452186434428, 19224.8077519223, 19279.325223617107, 19448.22207111728, 19624.803751962583, 947.9383840050375, 957.1624828275259, 961.2310151878469, 997.3666721631816, 1015.5480811039017, 9088.591013404413, 10987.340759554452, 11015.394153321484, 11031.83452248217, 11091.667249982513, 465862.0, 467579.0, 469552.0, 470610.0, 470689.0, 56397.71801140968, 90587.0, 92499.53750231206, 92719.53640231755, 93371.0, 942.1144124522926, 958.8849338079475, 984.3060642247199, 985.7190700650424, 986.5954958467138, 16787.61921757622, 16900.746488802433, 17182.484525464257, 17185.226664799862, 17395.391161309293, 34217.144571385914, 38829.0, 41761.1647767049, 42073.78963105165, 42232.36651450169, 59322.0, 60854.39145608487, 60954.69522652358, 61007.0, 61789.691051544454, 8491.320694344562, 8680.652773888974, 8877.644894204159, 8959.238464730572, 8980.577718822451, 10079.596816127272, 13858.65353366174, 13894.186831962184, 14042.929785351007, 14204.431822727389, 11899.762004759683, 11931.224470409396, 11938.820917686067, 12394.566190183301, 12444.564440244549, 12079.27524348542, 12123.272603643809, 12190.0, 12314.630561083182, 12748.745025099632, 12065.0, 12486.500539978662, 12487.438065286902, 12602.180858244552, 12622.810657839957, 8905.376623636543, 8910.599023044108, 8914.687985920462, 8971.192592666692, 9270.44377337362, 10580.36517808934, 11906.166568340133, 12036.338001410006, 12354.25874447536, 12424.254544727346], "value": 9003.851415084444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.739530791496, 1430.5994321589956, 1467.7945087687722, 1577.589826645072, 1725.8101608823035, 8136.877946830795, 8547.914520854789, 8548.316134709225, 8742.606582703778, 8751.0, 8411.789705257372, 8664.176903194202, 8672.826543469142, 8677.26243269323, 8684.73945781626, 2029.6143732690816, 2230.2863083813186, 2290.3014580552926, 2301.1945818963395, 2327.406511339606, 2337.801286890616, 2345.3550273674705, 2346.765323467657, 2349.4361353275262, 2353.211674089182, 2329.767023297665, 2330.615448451012, 2354.281944007077, 2359.4573248152933, 2361.7992470640015, 2003.8096380843797, 2209.812165965895, 2283.4633861042644, 2284.7258329000542, 2288.4622113803243, 2297.322289924476, 2314.051238992022, 2335.1243283768586, 2336.0889253191267, 2336.112277334602, 8547.957260213721, 8592.699255526026, 8593.613287402082, 8593.742187734379, 8603.483790972561, 5098.260752190911, 5178.766955487012, 5219.138842091051, 5221.347331583552, 5231.659942103751, 3207.3642442354335, 3303.8348082596012, 3366.1248075500303, 3435.3129374125024, 3441.8107004114763, 1108.972275693106, 1139.344876695895, 1151.3034614058543, 1172.7947609168448, 1189.0903458853984, 11546.249493782878, 11643.24318919259, 11680.123990700646, 11703.824442633368, 11865.40672966357, 4499.212637788374, 4591.770411479412, 4669.369635099286, 4688.413948256468, 4689.484156742756, 10147.898521014695, 10187.7453063674, 10214.0, 10215.693529194135, 10216.795664086676, 5304.602154838402, 5313.362396512366, 5314.7608357624, 5315.043292207362, 5315.3090098286975, 4149.979250103791, 4688.789004494806, 4824.0, 4828.46886842447, 4923.187674033816, 3748.83130259139, 3814.4659747635355, 3899.2786334528205, 3899.9610003899597, 3941.3102707026155, 1226.45422786859, 1227.5274019502376, 1243.7699025680279, 1246.7755803955374, 1254.861965183829, 878.2052242720348, 884.2395539835736, 901.9188273055456, 931.4644079654225, 988.9159421449258, 5992.43071908168, 6077.149199112039, 6091.329953705089, 6125.989211780006, 6261.7182226799905, 980.5048450532436, 981.3326937682444, 990.7523119220195, 1034.4775888176423, 1090.1496832470687, 4138.6482149017675, 4205.936910946339, 4243.236217480821, 4300.247456695066, 4328.485030239391, 10812.243142979916, 10997.34015959045, 11049.723756905982, 11124.610638627772, 11140.610078647209, 10784.568617255221, 10890.61882834097, 11002.50488728009, 11015.228933974706, 11015.669529914116, 7630.160682324939, 7978.880316795253, 7980.281774640311, 8165.224303691259, 8167.95916020428, 5893.116032595145, 6118.908216376669, 6185.783497577563, 6238.157848690369, 6249.843753906189, 9461.810763784548, 9874.160696340892, 10118.038786315288, 10174.949125254327, 10188.134008609351, 9930.404175749478, 10142.49287535635, 10293.588256469657, 10315.0, 10345.0, 7000.229974702676, 7516.285952834472, 7655.6937722490475, 7735.458517903693, 7811.609419529114, 8617.741467755977, 8653.221210091122, 8730.65077396897, 8736.956315218384, 8751.256143227896, 7540.547567145989, 7580.583067931317, 7662.501937374052, 7755.069391673035, 7881.763547093367, 7589.544627322378, 7710.807229819299, 7730.111037230566, 7804.492707973964, 7861.331786797958, 6805.1833779944745, 6851.931480685329, 6869.931300686929, 6880.8967865483055, 6885.1049363582415, 5020.849374518771, 5027.7737501813235, 5189.662671926313, 5328.8401347959625, 5345.1714984177515, 5269.45868832177, 5269.683818970874, 5302.098643230583, 5397.757100930546, 5548.944510554843], "value": 4622.147351682556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4533638151522, 332.3834287396879, 335.1921868297401, 338.1175132903122, 339.53653263295604, 5115.669925819286, 5237.7904883804695, 5313.256144139824, 5318.574514038877, 5321.52106310432, 5287.629865909388, 5341.1187154119525, 5341.65279256848, 5345.385280692722, 5348.786048558053, 4169.937450938239, 4194.161167766459, 4196.979015104936, 4200.621944025037, 4217.957820421802, 3965.355110121257, 4014.6386825185728, 4067.6745860331253, 4212.368144778277, 4214.620684138427, 4115.814788334532, 4122.7631710486885, 4132.648724858391, 4133.6693064554765, 4135.710500264982, 4146.8133933972895, 4159.854405095823, 4175.457190565237, 4176.102138040336, 4182.749035057906, 3515.384807658675, 3637.5998640149564, 3692.3169213695282, 3705.573859006222, 3710.3692372296773, 5067.39191297043, 5083.466236045236, 5120.257562653394, 5127.179651255781, 5153.484651534854, 4683.437987441529, 4689.718616882998, 4696.553827386427, 4699.718016918996, 4704.764761761899, 5306.8407947761625, 5458.91811622822, 5484.506394424481, 5509.449055094498, 5531.3362396512275, 3907.199024200032, 3907.886252418076, 3918.7060970427333, 3918.8432462701458, 3930.862419815293, 5693.715314234313, 5704.657720536739, 5707.229524014247, 5707.800226992035, 5710.885782284373, 3906.8046597670004, 4064.288749468831, 4075.2053349597136, 4076.3885417187657, 4085.91828163441, 4083.2037752637953, 4115.279826030433, 4116.682661548336, 4131.995981948812, 4173.916521669549, 4694.342792009122, 4726.810927562928, 4731.858044258678, 4745.810167593327, 4757.429108506932, 5282.498162674539, 5581.441855814467, 5593.804216852391, 5612.747426365823, 5612.85967850807, 1379.1380387257964, 1408.0, 1440.6038339456734, 1449.5506393017988, 1453.9709205816037, 910.7131253655077, 955.4983633592419, 964.4599024546277, 967.777411195429, 975.8682577851899, 4628.629709623222, 4702.3416721659, 4722.527747225318, 4723.881902952454, 4749.762511874393, 4990.5508504234795, 5007.324011258506, 5014.674046186986, 5014.974925125351, 5065.341505604321, 4724.456687480983, 4733.810647574127, 4758.262469317192, 4786.976065119652, 4961.957988822388, 2968.985155074254, 2970.0, 2990.1627544287635, 3014.4927536231885, 3045.7258846703903, 5848.625572990344, 5848.88302233953, 5882.735276912549, 5910.7291932234775, 5920.467157955804, 5626.1842032905, 5879.500242479352, 5889.676067816225, 5897.292324921037, 5965.0455927052335, 5795.1017592273265, 5816.621919575214, 5828.88342233153, 5855.3266374367495, 5880.941190588125, 5383.165609330404, 5673.290838645169, 5711.7429715662065, 5721.713914304185, 5732.770689172553, 5656.60403771732, 5666.943330566642, 5669.801556945487, 5693.4875861172695, 5714.171445140514, 5796.029350021013, 5803.216565763737, 5818.24362832846, 5846.853828654318, 5851.502622277154, 3841.5966323535627, 4015.955851478578, 4032.568438204395, 4069.1658210066275, 4072.348424252224, 5481.369642491005, 5569.832905012856, 5658.688772117573, 5663.66018038919, 5671.404502527175, 5547.8890422192135, 5556.916646250229, 5563.805266815642, 5609.0, 5621.831345059655, 5543.972280138573, 5550.972245138749, 5552.305961754781, 5559.388467268678, 5575.769692123184, 5255.842324730264, 5490.149026900836, 5491.560675146058, 5498.862528436821, 5514.6691198528215, 5540.667559946416, 5562.0, 5577.832665020056, 5586.162075688517, 5627.774889004558, 5260.73696315175, 5492.0, 5523.392426833126, 5530.391656917816, 5530.474604912688], "value": 4194.129712982659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9383802376801, 742.6323969635032, 745.8545583611198, 756.7767508584967, 768.1473564343579, 14352.856471435283, 14799.630009249748, 15365.231738413077, 15373.999999999973, 15404.922975385121, 15260.847391526082, 15450.845491545082, 15457.613559661015, 15463.07221566704, 15469.535913922573, 633.20532731422, 739.4971419434783, 747.5552046532318, 756.1191212237763, 764.8355603545236, 764.0831002796639, 767.221270410531, 769.9961500192492, 770.537677393565, 770.9807254818618, 802.0255389701512, 805.5086397297644, 805.5327909812295, 805.5810978291285, 806.1978331560076, 667.3593350383637, 772.5750837039634, 780.153533416244, 782.6047845837873, 798.7523867601062, 586.6069733278714, 586.6362855029909, 586.7066466766616, 587.0196771391786, 587.5857520448074, 14811.703765924729, 14887.404503819835, 14893.478728244569, 14898.106113633217, 14946.925265373713, 13590.184588924696, 13750.724985500234, 13786.862131378659, 13926.860731392657, 14165.929170354082, 12462.098695745632, 12530.81203781944, 12612.68468288291, 12777.552785652457, 12953.352332383438, 4312.116016216668, 4354.912901741979, 4358.782060896974, 4405.757683327416, 4512.413386259798, 69250.65374673145, 72261.63869180673, 72683.0, 75598.0, 76040.23959760442, 11353.318800871974, 11455.369954652408, 11699.0, 11866.347350895783, 12093.818592721116, 19550.0, 19576.412707618794, 19630.509237269183, 19652.41042768719, 19658.213671453268, 8369.874451883226, 8586.31309495239, 8625.611847466878, 8638.870416943751, 8648.308135349156, 4924.507549245047, 4956.801727930914, 4961.156603377434, 5014.974925125424, 5016.272640467112, 3546.414841551167, 3633.4004889193516, 3634.491171236029, 3634.636536346397, 3643.690286325692, 599.2569214174392, 600.6786369292495, 612.8222815383489, 614.0574218574467, 614.3058344071171, 680.2992917295194, 695.0824911117378, 695.4714417042983, 697.5326531224092, 710.4174576847039, 8952.0, 9141.954290228507, 9360.11078947499, 9441.716748497556, 9517.952410238044, 603.9124326972565, 613.8219916224245, 631.3528633151057, 650.193759737931, 682.4014597457348, 4620.514845941195, 4681.133990211753, 4688.531146885284, 4695.272232803921, 4765.209804077111, 96752.51623741977, 102384.0, 103022.48488757657, 115851.42074289743, 116337.0, 99514.5024274874, 101898.49050754699, 102326.48836755917, 102839.4858025705, 103229.0, 87492.56253718691, 88228.55885720659, 89790.55104724565, 90018.54990725004, 91602.0, 8878.0, 9016.729498115066, 9106.089391060841, 9157.130072643089, 9182.95408522953, 46019.0, 46379.76810115928, 47845.521544784104, 50962.490375095775, 51255.0, 48986.0202795935, 54674.72662636662, 58887.41112588819, 62907.0, 75855.55227805699, 12162.574309899464, 12818.74362512726, 12985.48058077704, 12998.740025199631, 13467.259300738553, 11741.823872642088, 12235.877641223475, 12398.07014473936, 14515.85484145145, 14549.709005819612, 14149.787753183504, 14575.708485830437, 14820.925895370454, 14955.476558320406, 15367.385304587691, 13962.650933726332, 14236.501722439665, 14483.0, 14954.700905981601, 15105.0, 14157.929210353883, 14228.430862765374, 14330.996830221784, 14536.781948270997, 15052.0, 10906.781864362827, 11078.501467434146, 11174.49714762854, 11437.256578322382, 11750.412479375826, 11860.466279017292, 11957.940210298893, 12142.817857732318, 12178.269303841798, 12311.692207694521], "value": 7429.606826927815, "unit": "score"}], "name": "dromaeo_css", "value": 7163.885972861993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 108.0, 108.0, 112.0, 108.0, 109.0, 108.0, 109.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 126.0, 176.0, 129.0, 130.0, 154.0, 131.0, 159.0, 125.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 128.0, 76.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 85.0, 86.0, 85.0, 116.0, 87.0, 86.0, 134.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 55.0, 54.0, 56.0, 56.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 85.0, 83.0, 90.0, 85.0, 135.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 120.0, 133.0, 124.0, 120.0, 123.0, 120.0, 128.0, 128.0, 124.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 160.0, 160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 165.0, 173.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 71.0, 64.0, 66.0, 63.0, 62.0, 62.0, 63.0, 60.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1505.0000000000002, "alertThreshold": 2.0}]} 06:07:32 INFO - Return code: 0 06:07:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:33 INFO - # TBPL SUCCESS # 06:07:33 INFO - Running post-action listener: _resource_record_post_action 06:07:33 INFO - ##### 06:07:33 INFO - ##### Finished run-tests step (success) 06:07:33 INFO - ##### 06:07:33 INFO - Running post-run listener: _resource_record_post_run 06:07:33 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 558702592; Read time: 176; Write time: 467616 06:07:33 INFO - TinderboxPrint: CPU usage
13.2% 06:07:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 06:07:33 INFO - TinderboxPrint: I/O write bytes / time
558,702,592 / 467,616 06:07:33 INFO - TinderboxPrint: CPU idle
8,273.1 (86.8%) 06:07:33 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 06:07:33 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267730944; Read time: 0; Write time: 258988 06:07:33 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290971648; Read time: 176; Write time: 208628 06:07:33 INFO - Running post-run listener: _upload_blobber_files 06:07:33 INFO - Blob upload gear active. 06:07:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:33 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 06:07:33 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:33 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:34 INFO - (blobuploader) - INFO - Done attempting. 06:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:35 INFO - (blobuploader) - INFO - Done attempting. 06:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:38 INFO - (blobuploader) - INFO - Done attempting. 06:07:38 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:38 INFO - Return code: 0 06:07:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bcea73025939aa3f677cb27025e1ce75718486ffebe92b23a53b9b852bc23e161ce8422cb78c2768e46e61ad18b9f3186ef3474f03e2b80e14797b573b8fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a83653f04d898d25ce8454f65502a2a0ad6e0cd22e65dcaf62a7ba6afcb6adc149d484ea8e84140c60e1e00c42e0dc2efee13f4ecf05ec2fba0faa9d72001db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69ab7352193099a0bd0acee4e78467e2eb1667fe2c39a784f17c7b6d2cfe08c88a3299a424e273ddae4a2a0e117ee00c6b54118730d98d00b9779f8f7a741070"} 06:07:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:38 INFO - Contents: 06:07:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bcea73025939aa3f677cb27025e1ce75718486ffebe92b23a53b9b852bc23e161ce8422cb78c2768e46e61ad18b9f3186ef3474f03e2b80e14797b573b8fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a83653f04d898d25ce8454f65502a2a0ad6e0cd22e65dcaf62a7ba6afcb6adc149d484ea8e84140c60e1e00c42e0dc2efee13f4ecf05ec2fba0faa9d72001db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69ab7352193099a0bd0acee4e78467e2eb1667fe2c39a784f17c7b6d2cfe08c88a3299a424e273ddae4a2a0e117ee00c6b54118730d98d00b9779f8f7a741070"} 06:07:38 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:38 INFO - Copying logs to upload dir... 06:07:38 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.285177 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 06:07:38.924838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 06:07:38.928045) ========= 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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bcea73025939aa3f677cb27025e1ce75718486ffebe92b23a53b9b852bc23e161ce8422cb78c2768e46e61ad18b9f3186ef3474f03e2b80e14797b573b8fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a83653f04d898d25ce8454f65502a2a0ad6e0cd22e65dcaf62a7ba6afcb6adc149d484ea8e84140c60e1e00c42e0dc2efee13f4ecf05ec2fba0faa9d72001db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69ab7352193099a0bd0acee4e78467e2eb1667fe2c39a784f17c7b6d2cfe08c88a3299a424e273ddae4a2a0e117ee00c6b54118730d98d00b9779f8f7a741070"} build_url:https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/OmqsGYg5TiqUasGV9SVWow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bcea73025939aa3f677cb27025e1ce75718486ffebe92b23a53b9b852bc23e161ce8422cb78c2768e46e61ad18b9f3186ef3474f03e2b80e14797b573b8fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a83653f04d898d25ce8454f65502a2a0ad6e0cd22e65dcaf62a7ba6afcb6adc149d484ea8e84140c60e1e00c42e0dc2efee13f4ecf05ec2fba0faa9d72001db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69ab7352193099a0bd0acee4e78467e2eb1667fe2c39a784f17c7b6d2cfe08c88a3299a424e273ddae4a2a0e117ee00c6b54118730d98d00b9779f8f7a741070"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 06:07:38.953779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 06:07:38.954132) ========= 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=0333a256a5e4f052382dd180000001b1-1466513221.900047-2039440457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 06:07:39.037585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 06:07:39.037907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 06:07:39.038204) ========= ========= Total master_lag: 0.17 =========