builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1465027532.82 results: success (0) buildid: 20160603223049 builduid: 10e8319d00c049d0a9b8347af6b9bd2e revision: 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:32.820148) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:32.820760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:32.821077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:32.865468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:32.865791) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 01:05:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-06-04 01:05:33 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.273401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.153561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.153881) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.204069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.204417) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 --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=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 01:05:33,498 truncating revision to first 12 chars 2016-06-04 01:05:33,498 Setting DEBUG logging. 2016-06-04 01:05:33,498 attempt 1/10 2016-06-04 01:05:33,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3538bc8b05aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 01:05:33,816 unpacking tar archive at: mozilla-inbound-3538bc8b05aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.888567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.888891) ========= script_repo_revision: 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.889303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.889609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 01:05:33.899643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 01:05:33.900053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:05:34 INFO - MultiFileLogger online at 20160604 01:05:34 in /builds/slave/test 01:05:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:05:34 INFO - {'append_to_log': False, 01:05:34 INFO - 'base_work_dir': '/builds/slave/test', 01:05:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:05:34 INFO - 'branch': 'Mozilla-Inbound', 01:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:05:34 INFO - 'config_files': ('talos/linux_config.py',), 01:05:34 INFO - 'default_actions': ('clobber', 01:05:34 INFO - 'read-buildbot-config', 01:05:34 INFO - 'download-and-extract', 01:05:34 INFO - 'populate-webroot', 01:05:34 INFO - 'create-virtualenv', 01:05:34 INFO - 'install', 01:05:34 INFO - 'run-tests'), 01:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:05:34 INFO - 'download_minidump_stackwalk': True, 01:05:34 INFO - 'download_symbols': 'ondemand', 01:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:05:34 INFO - 'installer_path': 'installer.exe', 01:05:34 INFO - 'log_level': 'info', 01:05:34 INFO - 'log_name': 'talos', 01:05:34 INFO - 'log_to_console': True, 01:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:05:34 INFO - 'opt_config_files': (), 01:05:34 INFO - 'pip_index': False, 01:05:34 INFO - 'sps_profile': False, 01:05:34 INFO - 'sps_profile_interval': 0, 01:05:34 INFO - 'suite': 'dromaeojs-e10s', 01:05:34 INFO - 'system_bits': '32', 01:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:05:34 INFO - 'title': 'talos-linux64-ix-014', 01:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:05:34 INFO - 'use_talos_json': True, 01:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:05:34 INFO - 'work_dir': 'build'} 01:05:34 INFO - ##### 01:05:34 INFO - ##### Running clobber step. 01:05:34 INFO - ##### 01:05:34 INFO - Running pre-action listener: _resource_record_pre_action 01:05:34 INFO - Running main action method: clobber 01:05:34 INFO - rmtree: /builds/slave/test/build 01:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:05:34 INFO - Running post-action listener: _resource_record_post_action 01:05:34 INFO - ##### 01:05:34 INFO - ##### Finished clobber step (success) 01:05:34 INFO - ##### 01:05:34 INFO - ##### 01:05:34 INFO - ##### Running read-buildbot-config step. 01:05:34 INFO - ##### 01:05:34 INFO - Running pre-action listener: _resource_record_pre_action 01:05:34 INFO - Running main action method: read_buildbot_config 01:05:34 INFO - Using buildbot properties: 01:05:34 INFO - { 01:05:34 INFO - "project": "", 01:05:34 INFO - "product": "firefox", 01:05:34 INFO - "script_repo_revision": "production", 01:05:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:05:34 INFO - "repository": "", 01:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:05:34 INFO - "buildid": "20160603223049", 01:05:34 INFO - "pgo_build": "True", 01:05:34 INFO - "basedir": "/builds/slave/test", 01:05:34 INFO - "buildnumber": 791, 01:05:34 INFO - "slavename": "talos-linux64-ix-014", 01:05:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:05:34 INFO - "platform": "ubuntu64_hw", 01:05:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:05:34 INFO - "branch": "mozilla-inbound", 01:05:34 INFO - "repo_path": "integration/mozilla-inbound", 01:05:34 INFO - "revision": "3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67", 01:05:34 INFO - "stage_platform": "linux64-pgo", 01:05:34 INFO - "builduid": "10e8319d00c049d0a9b8347af6b9bd2e", 01:05:34 INFO - "slavebuilddir": "test" 01:05:34 INFO - } 01:05:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:05:34 INFO - Running post-action listener: _resource_record_post_action 01:05:34 INFO - ##### 01:05:34 INFO - ##### Finished read-buildbot-config step (success) 01:05:34 INFO - ##### 01:05:34 INFO - ##### 01:05:34 INFO - ##### Running download-and-extract step. 01:05:34 INFO - ##### 01:05:34 INFO - Running pre-action listener: _resource_record_pre_action 01:05:34 INFO - Running main action method: download_and_extract 01:05:34 INFO - mkdir: /builds/slave/test/build/tests 01:05:34 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')]} 01:05:34 INFO - https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:05:38 INFO - Downloaded 1361 bytes. 01:05:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:05:38 INFO - Using the following test package requirements: 01:05:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:05:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:05:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'jsshell-linux-x86_64.zip'], 01:05:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:05:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:05:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:05:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:05:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:05:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:38 INFO - https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:05:40 INFO - Downloaded 24441874 bytes. 01:05:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:05:41 INFO - Return code: 0 01:05:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:05:41 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')]} 01:05:41 INFO - https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:05:43 INFO - Downloaded 24441874 bytes. 01:05:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:05:45 INFO - Return code: 0 01:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:45 INFO - https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:05:46 INFO - Downloaded 10833377 bytes. 01:05:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:05:46 INFO - Return code: 0 01:05:46 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')]} 01:05:46 INFO - https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:05:49 INFO - Downloaded 59218514 bytes. 01:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:05:49 INFO - mkdir: /builds/slave/test/properties 01:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:05:49 INFO - Contents: 01:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:05:50 INFO - Running post-action listener: _resource_record_post_action 01:05:50 INFO - Running post-action listener: set_extra_try_arguments 01:05:50 INFO - ##### 01:05:50 INFO - ##### Finished download-and-extract step (success) 01:05:50 INFO - ##### 01:05:50 INFO - ##### 01:05:50 INFO - ##### Running populate-webroot step. 01:05:50 INFO - ##### 01:05:50 INFO - Running pre-action listener: _resource_record_pre_action 01:05:50 INFO - Running main action method: populate_webroot 01:05:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:05:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:05:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:05:50 INFO - '--tppagecycles', 01:05:50 INFO - '7'], 01:05:50 INFO - 'tests': ['tsvgm']}}, 01:05:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:05:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:05:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:05:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:05:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['damp', 'tps']}, 01:05:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'tests': ['damp', 'tps']}, 01:05:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['dromaeo_dom']}, 01:05:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:05:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['a11yr', 01:05:50 INFO - 'ts_paint', 01:05:50 INFO - 'tpaint', 01:05:50 INFO - 'sessionrestore', 01:05:50 INFO - 'sessionrestore_no_auto_restore', 01:05:50 INFO - 'tabpaint']}, 01:05:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['tsvgx', 01:05:50 INFO - 'tsvgr_opacity', 01:05:50 INFO - 'tart', 01:05:50 INFO - 'tscrollx', 01:05:50 INFO - 'cart']}, 01:05:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:05:50 INFO - 'tsvgr_opacity', 01:05:50 INFO - 'tart', 01:05:50 INFO - 'tscrollx', 01:05:50 INFO - 'cart']}, 01:05:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'talos_options': ['--disable-e10s'], 01:05:50 INFO - 'tests': ['tp5o']}, 01:05:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'tests': ['tp5o']}, 01:05:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'talos_options': ['--disable-e10s', 01:05:50 INFO - '--xperf_path', 01:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:50 INFO - 'tests': ['tp5n']}, 01:05:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:50 INFO - 'talos_options': ['--xperf_path', 01:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:50 INFO - 'tests': ['tp5n']}}, 01:05:50 INFO - 'talos.zip': {'path': '', 01:05:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:05:50 INFO - Running post-action listener: _resource_record_post_action 01:05:50 INFO - ##### 01:05:50 INFO - ##### Finished populate-webroot step (success) 01:05:50 INFO - ##### 01:05:50 INFO - ##### 01:05:50 INFO - ##### Running create-virtualenv step. 01:05:50 INFO - ##### 01:05:50 INFO - Running pre-action listener: _resource_record_pre_action 01:05:50 INFO - Running main action method: create_virtualenv 01:05:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:05:50 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 01:05:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:05:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:05:50 INFO - Using real prefix '/usr' 01:05:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:05:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:05:53 INFO - Installing pip.................done. 01:05:53 INFO - Return code: 0 01:05:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:05:53 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')]} 01:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:53 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')]} 01:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:53 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:05:53 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 01:05:53 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 01:05:53 INFO - Using env: {'DISPLAY': ':0', 01:05:53 INFO - 'HOME': '/home/cltbld', 01:05:53 INFO - 'LANG': 'en_US.UTF-8', 01:05:53 INFO - 'LANGUAGE': 'en_US:en', 01:05:53 INFO - 'LOGNAME': 'cltbld', 01:05:53 INFO - 'MAIL': '/var/mail/cltbld', 01:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:53 INFO - 'MOZ_NO_REMOTE': '1', 01:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:53 INFO - 'NO_EM_RESTART': '1', 01:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:53 INFO - 'PWD': '/builds/slave/test', 01:05:53 INFO - 'SHELL': '/bin/bash', 01:05:53 INFO - 'SHLVL': '1', 01:05:53 INFO - 'TERM': 'linux', 01:05:53 INFO - 'TMOUT': '86400', 01:05:53 INFO - 'USER': 'cltbld', 01:05:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:53 INFO - '_': '/tools/buildbot/bin/python'} 01:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:53 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 01:05:53 INFO - Cleaning up... 01:05:53 INFO - Return code: 0 01:05:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:05:53 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')]} 01:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:53 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')]} 01:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:53 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:05:53 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 01:05:53 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 01:05:53 INFO - Using env: {'DISPLAY': ':0', 01:05:53 INFO - 'HOME': '/home/cltbld', 01:05:53 INFO - 'LANG': 'en_US.UTF-8', 01:05:53 INFO - 'LANGUAGE': 'en_US:en', 01:05:53 INFO - 'LOGNAME': 'cltbld', 01:05:53 INFO - 'MAIL': '/var/mail/cltbld', 01:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:53 INFO - 'MOZ_NO_REMOTE': '1', 01:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:53 INFO - 'NO_EM_RESTART': '1', 01:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:53 INFO - 'PWD': '/builds/slave/test', 01:05:53 INFO - 'SHELL': '/bin/bash', 01:05:53 INFO - 'SHLVL': '1', 01:05:53 INFO - 'TERM': 'linux', 01:05:53 INFO - 'TMOUT': '86400', 01:05:53 INFO - 'USER': 'cltbld', 01:05:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:53 INFO - '_': '/tools/buildbot/bin/python'} 01:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:53 INFO - Downloading/unpacking psutil>=3.1.1 01:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:55 INFO - Installing collected packages: psutil 01:05:55 INFO - Running setup.py install for psutil 01:05:55 INFO - building 'psutil._psutil_linux' extension 01:05:55 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 01:05:55 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 01:05:55 INFO - building 'psutil._psutil_posix' extension 01:05:55 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 01:05:55 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 01:05:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:56 INFO - Successfully installed psutil 01:05:56 INFO - Cleaning up... 01:05:56 INFO - Return code: 0 01:05:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:05:56 INFO - Using env: {'DISPLAY': ':0', 01:05:56 INFO - 'HOME': '/home/cltbld', 01:05:56 INFO - 'LANG': 'en_US.UTF-8', 01:05:56 INFO - 'LANGUAGE': 'en_US:en', 01:05:56 INFO - 'LOGNAME': 'cltbld', 01:05:56 INFO - 'MAIL': '/var/mail/cltbld', 01:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:56 INFO - 'MOZ_NO_REMOTE': '1', 01:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:56 INFO - 'NO_EM_RESTART': '1', 01:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:56 INFO - 'PWD': '/builds/slave/test', 01:05:56 INFO - 'SHELL': '/bin/bash', 01:05:56 INFO - 'SHLVL': '1', 01:05:56 INFO - 'TERM': 'linux', 01:05:56 INFO - 'TMOUT': '86400', 01:05:56 INFO - 'USER': 'cltbld', 01:05:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:56 INFO - '_': '/tools/buildbot/bin/python'} 01:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:05:58 INFO - Installing collected packages: mozsystemmonitor 01:05:58 INFO - Running setup.py install for mozsystemmonitor 01:05:58 INFO - Successfully installed mozsystemmonitor 01:05:58 INFO - Cleaning up... 01:05:58 INFO - Return code: 0 01:05:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:58 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:05:58 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 01:05:58 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 01:05:58 INFO - Using env: {'DISPLAY': ':0', 01:05:58 INFO - 'HOME': '/home/cltbld', 01:05:58 INFO - 'LANG': 'en_US.UTF-8', 01:05:58 INFO - 'LANGUAGE': 'en_US:en', 01:05:58 INFO - 'LOGNAME': 'cltbld', 01:05:58 INFO - 'MAIL': '/var/mail/cltbld', 01:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:58 INFO - 'MOZ_NO_REMOTE': '1', 01:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:58 INFO - 'NO_EM_RESTART': '1', 01:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:58 INFO - 'PWD': '/builds/slave/test', 01:05:58 INFO - 'SHELL': '/bin/bash', 01:05:58 INFO - 'SHLVL': '1', 01:05:58 INFO - 'TERM': 'linux', 01:05:58 INFO - 'TMOUT': '86400', 01:05:58 INFO - 'USER': 'cltbld', 01:05:58 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:58 INFO - '_': '/tools/buildbot/bin/python'} 01:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:58 INFO - Downloading/unpacking jsonschema==2.5.1 01:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:06:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:06:00 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 01:06:00 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 01:06:00 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 01:06:00 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 01:06:00 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 01:06:00 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 01:06:00 INFO - Downloading functools32-3.2.3-2.tar.gz 01:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:06:00 INFO - warning: no files found matching '*.txt' 01:06:00 INFO - no previously-included directories found matching 'build' 01:06:00 INFO - no previously-included directories found matching 'dist' 01:06:00 INFO - no previously-included directories found matching '.git*' 01:06:00 INFO - Installing collected packages: jsonschema, functools32 01:06:00 INFO - Running setup.py install for functools32 01:06:00 INFO - warning: no files found matching '*.txt' 01:06:00 INFO - no previously-included directories found matching 'build' 01:06:00 INFO - no previously-included directories found matching 'dist' 01:06:00 INFO - no previously-included directories found matching '.git*' 01:06:00 INFO - Successfully installed jsonschema functools32 01:06:00 INFO - Cleaning up... 01:06:00 INFO - Return code: 0 01:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:06:00 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')]} 01:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:00 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')]} 01:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:00 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:00 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 01:06:00 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 01:06:01 INFO - Using env: {'DISPLAY': ':0', 01:06:01 INFO - 'HOME': '/home/cltbld', 01:06:01 INFO - 'LANG': 'en_US.UTF-8', 01:06:01 INFO - 'LANGUAGE': 'en_US:en', 01:06:01 INFO - 'LOGNAME': 'cltbld', 01:06:01 INFO - 'MAIL': '/var/mail/cltbld', 01:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:01 INFO - 'MOZ_NO_REMOTE': '1', 01:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:01 INFO - 'NO_EM_RESTART': '1', 01:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:01 INFO - 'PWD': '/builds/slave/test', 01:06:01 INFO - 'SHELL': '/bin/bash', 01:06:01 INFO - 'SHLVL': '1', 01:06:01 INFO - 'TERM': 'linux', 01:06:01 INFO - 'TMOUT': '86400', 01:06:01 INFO - 'USER': 'cltbld', 01:06:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:01 INFO - '_': '/tools/buildbot/bin/python'} 01:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:06:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 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 01:06:03 INFO - Downloading docopt-0.6.1.tar.gz 01:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:06:03 INFO - Running setup.py install for blobuploader 01:06:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:06:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:06:04 INFO - Running setup.py install for requests 01:06:04 INFO - Running setup.py install for docopt 01:06:04 INFO - Successfully installed blobuploader requests docopt 01:06:04 INFO - Cleaning up... 01:06:04 INFO - Return code: 0 01:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:04 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')]} 01:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:04 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')]} 01:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:04 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:04 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 01:06:04 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 01:06:04 INFO - Using env: {'DISPLAY': ':0', 01:06:04 INFO - 'HOME': '/home/cltbld', 01:06:04 INFO - 'LANG': 'en_US.UTF-8', 01:06:04 INFO - 'LANGUAGE': 'en_US:en', 01:06:04 INFO - 'LOGNAME': 'cltbld', 01:06:04 INFO - 'MAIL': '/var/mail/cltbld', 01:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:04 INFO - 'MOZ_NO_REMOTE': '1', 01:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:04 INFO - 'NO_EM_RESTART': '1', 01:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:04 INFO - 'PWD': '/builds/slave/test', 01:06:04 INFO - 'SHELL': '/bin/bash', 01:06:04 INFO - 'SHLVL': '1', 01:06:04 INFO - 'TERM': 'linux', 01:06:04 INFO - 'TMOUT': '86400', 01:06:04 INFO - 'USER': 'cltbld', 01:06:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:04 INFO - '_': '/tools/buildbot/bin/python'} 01:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:04 INFO - Running setup.py (path:/tmp/pip-EYBkRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:04 INFO - Running setup.py (path:/tmp/pip-io9JAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:04 INFO - Running setup.py (path:/tmp/pip-Hv7Jnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:05 INFO - Running setup.py (path:/tmp/pip-rDb3hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:05 INFO - Running setup.py (path:/tmp/pip-ySfLaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:05 INFO - Running setup.py (path:/tmp/pip-pKDeS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:05 INFO - Running setup.py (path:/tmp/pip-lRy7a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:05 INFO - Running setup.py (path:/tmp/pip-KrAD83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:05 INFO - Running setup.py (path:/tmp/pip-ylfGQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:05 INFO - Running setup.py (path:/tmp/pip-qs9z40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:05 INFO - Running setup.py (path:/tmp/pip-andupg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:05 INFO - Running setup.py (path:/tmp/pip-6Ztas9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:05 INFO - Running setup.py (path:/tmp/pip-MS4xU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:05 INFO - Running setup.py (path:/tmp/pip-P7kyV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:05 INFO - Running setup.py (path:/tmp/pip-PsMyxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:05 INFO - Running setup.py (path:/tmp/pip-1Fub6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:05 INFO - Running setup.py (path:/tmp/pip-mfQbeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:06:06 INFO - Running setup.py install for manifestparser 01:06:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Running setup.py install for mozcrash 01:06:06 INFO - Running setup.py install for mozdebug 01:06:06 INFO - Running setup.py install for mozdevice 01:06:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Running setup.py install for mozfile 01:06:06 INFO - Running setup.py install for mozhttpd 01:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Running setup.py install for mozinfo 01:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Running setup.py install for mozInstall 01:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:06:06 INFO - Running setup.py install for mozleak 01:06:06 INFO - Running setup.py install for mozlog 01:06:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Running setup.py install for moznetwork 01:06:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Running setup.py install for mozprocess 01:06:07 INFO - Running setup.py install for mozprofile 01:06:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Running setup.py install for mozrunner 01:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Running setup.py install for mozscreenshot 01:06:07 INFO - Running setup.py install for moztest 01:06:07 INFO - Running setup.py install for mozversion 01:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:06:07 INFO - Cleaning up... 01:06:07 INFO - Return code: 0 01:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:07 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')]} 01:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:07 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')]} 01:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:07 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:07 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 01:06:07 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 01:06:07 INFO - Using env: {'DISPLAY': ':0', 01:06:07 INFO - 'HOME': '/home/cltbld', 01:06:07 INFO - 'LANG': 'en_US.UTF-8', 01:06:07 INFO - 'LANGUAGE': 'en_US:en', 01:06:07 INFO - 'LOGNAME': 'cltbld', 01:06:07 INFO - 'MAIL': '/var/mail/cltbld', 01:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:07 INFO - 'MOZ_NO_REMOTE': '1', 01:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:07 INFO - 'NO_EM_RESTART': '1', 01:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:07 INFO - 'PWD': '/builds/slave/test', 01:06:07 INFO - 'SHELL': '/bin/bash', 01:06:07 INFO - 'SHLVL': '1', 01:06:07 INFO - 'TERM': 'linux', 01:06:07 INFO - 'TMOUT': '86400', 01:06:07 INFO - 'USER': 'cltbld', 01:06:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:07 INFO - '_': '/tools/buildbot/bin/python'} 01:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:08 INFO - Running setup.py (path:/tmp/pip-cxUPUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:08 INFO - Running setup.py (path:/tmp/pip-fRWISs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:08 INFO - Running setup.py (path:/tmp/pip-eoXPsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:08 INFO - Running setup.py (path:/tmp/pip-EH6ff8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:08 INFO - Running setup.py (path:/tmp/pip-5J9PbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:08 INFO - Running setup.py (path:/tmp/pip-LJkZYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:08 INFO - Running setup.py (path:/tmp/pip-HJWgsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:08 INFO - Running setup.py (path:/tmp/pip-R0m8Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:08 INFO - Running setup.py (path:/tmp/pip-vC2z4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:08 INFO - Running setup.py (path:/tmp/pip-OX52f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:08 INFO - Running setup.py (path:/tmp/pip-sFnI4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:08 INFO - Running setup.py (path:/tmp/pip-zdb7SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:08 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)) 01:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:08 INFO - Running setup.py (path:/tmp/pip-7upPm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:09 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)) 01:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:09 INFO - Running setup.py (path:/tmp/pip-eqKsii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:09 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)) 01:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:09 INFO - Running setup.py (path:/tmp/pip-FBtvDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:09 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)) 01:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:09 INFO - Running setup.py (path:/tmp/pip-_slWy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:09 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)) 01:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:09 INFO - Running setup.py (path:/tmp/pip-BdL50F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:09 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)) 01:06:09 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)) 01:06:09 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)) 01:06:09 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)) 01:06:09 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)) 01:06:09 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)) 01:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06:09 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 01:06:09 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 01:06:09 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 01:06:09 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 01:06:09 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 01:06:09 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 01:06:11 INFO - Downloading blessings-1.6.tar.gz 01:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:06:11 INFO - Installing collected packages: blessings 01:06:11 INFO - Running setup.py install for blessings 01:06:11 INFO - Successfully installed blessings 01:06:11 INFO - Cleaning up... 01:06:11 INFO - Return code: 0 01:06:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:06:11 INFO - Reading from file tmpfile_stdout 01:06:11 INFO - Current package versions: 01:06:11 INFO - argparse == 1.2.1 01:06:11 INFO - blessings == 1.6 01:06:11 INFO - blobuploader == 1.2.4 01:06:11 INFO - docopt == 0.6.1 01:06:11 INFO - functools32 == 3.2.3-2 01:06:11 INFO - jsonschema == 2.5.1 01:06:11 INFO - manifestparser == 1.1 01:06:11 INFO - mozInstall == 1.12 01:06:11 INFO - mozcrash == 0.17 01:06:11 INFO - mozdebug == 0.1 01:06:11 INFO - mozdevice == 0.48 01:06:11 INFO - mozfile == 1.2 01:06:11 INFO - mozhttpd == 0.7 01:06:11 INFO - mozinfo == 0.9 01:06:11 INFO - mozleak == 0.1 01:06:11 INFO - mozlog == 3.2 01:06:11 INFO - moznetwork == 0.27 01:06:11 INFO - mozprocess == 0.22 01:06:11 INFO - mozprofile == 0.28 01:06:11 INFO - mozrunner == 6.11 01:06:11 INFO - mozscreenshot == 0.1 01:06:11 INFO - mozsystemmonitor == 0.3 01:06:11 INFO - moztest == 0.7 01:06:11 INFO - mozversion == 1.4 01:06:11 INFO - psutil == 3.1.1 01:06:11 INFO - requests == 1.2.3 01:06:11 INFO - wsgiref == 0.1.2 01:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06: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')]} 01:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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')]} 01:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:11 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:11 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 01:06:11 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 01:06:11 INFO - Using env: {'DISPLAY': ':0', 01:06:11 INFO - 'HOME': '/home/cltbld', 01:06:11 INFO - 'LANG': 'en_US.UTF-8', 01:06:11 INFO - 'LANGUAGE': 'en_US:en', 01:06:11 INFO - 'LOGNAME': 'cltbld', 01:06:11 INFO - 'MAIL': '/var/mail/cltbld', 01:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:11 INFO - 'MOZ_NO_REMOTE': '1', 01:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:11 INFO - 'NO_EM_RESTART': '1', 01:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:11 INFO - 'PWD': '/builds/slave/test', 01:06:11 INFO - 'SHELL': '/bin/bash', 01:06:11 INFO - 'SHLVL': '1', 01:06:11 INFO - 'TERM': 'linux', 01:06:11 INFO - 'TMOUT': '86400', 01:06:11 INFO - 'USER': 'cltbld', 01:06:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:11 INFO - '_': '/tools/buildbot/bin/python'} 01:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 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)) 01:06:11 INFO - Cleaning up... 01:06:11 INFO - Return code: 0 01:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:06: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')]} 01:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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')]} 01:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:06:11 INFO - Using env: {'DISPLAY': ':0', 01:06:11 INFO - 'HOME': '/home/cltbld', 01:06:11 INFO - 'LANG': 'en_US.UTF-8', 01:06:11 INFO - 'LANGUAGE': 'en_US:en', 01:06:11 INFO - 'LOGNAME': 'cltbld', 01:06:11 INFO - 'MAIL': '/var/mail/cltbld', 01:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:11 INFO - 'MOZ_NO_REMOTE': '1', 01:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:11 INFO - 'NO_EM_RESTART': '1', 01:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:11 INFO - 'PWD': '/builds/slave/test', 01:06:11 INFO - 'SHELL': '/bin/bash', 01:06:11 INFO - 'SHLVL': '1', 01:06:11 INFO - 'TERM': 'linux', 01:06:11 INFO - 'TMOUT': '86400', 01:06:11 INFO - 'USER': 'cltbld', 01:06:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:11 INFO - '_': '/tools/buildbot/bin/python'} 01:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:06:12 INFO - Cleaning up... 01:06:12 INFO - Return code: 0 01:06:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:06: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')]} 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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')]} 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:12 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 0x7ffc990fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', '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 01:06:12 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 01:06:12 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 01:06:12 INFO - Using env: {'DISPLAY': ':0', 01:06:12 INFO - 'HOME': '/home/cltbld', 01:06:12 INFO - 'LANG': 'en_US.UTF-8', 01:06:12 INFO - 'LANGUAGE': 'en_US:en', 01:06:12 INFO - 'LOGNAME': 'cltbld', 01:06:12 INFO - 'MAIL': '/var/mail/cltbld', 01:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:12 INFO - 'MOZ_NO_REMOTE': '1', 01:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:12 INFO - 'NO_EM_RESTART': '1', 01:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:12 INFO - 'PWD': '/builds/slave/test', 01:06:12 INFO - 'SHELL': '/bin/bash', 01:06:12 INFO - 'SHLVL': '1', 01:06:12 INFO - 'TERM': 'linux', 01:06:12 INFO - 'TMOUT': '86400', 01:06:12 INFO - 'USER': 'cltbld', 01:06:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:12 INFO - '_': '/tools/buildbot/bin/python'} 01:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:12 INFO - Downloading/unpacking flake8 01:06:12 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 01:06:12 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 01:06:12 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 01:06:12 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 01:06:12 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 01:06:12 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 01:06:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:06:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:06:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:06:14 INFO - no previously-included directories found matching 'docs/_build' 01:06:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:06:14 INFO - Running setup.py install for pep8 01:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:06:15 INFO - no previously-included directories found matching 'docs/_build' 01:06:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:06:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:06:15 INFO - Cleaning up... 01:06:15 INFO - Return code: 0 01:06:15 INFO - Running post-action listener: _resource_record_post_action 01:06:15 INFO - Running post-action listener: _start_resource_monitoring 01:06:15 INFO - Starting resource monitoring. 01:06:15 INFO - ##### 01:06:15 INFO - ##### Finished create-virtualenv step (success) 01:06:15 INFO - ##### 01:06:15 INFO - ##### 01:06:15 INFO - ##### Running install step. 01:06:15 INFO - ##### 01:06:15 INFO - Running pre-action listener: _resource_record_pre_action 01:06:15 INFO - Running main action method: install 01:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:06:15 INFO - Reading from file tmpfile_stdout 01:06:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:06:15 INFO - Reading from file tmpfile_stdout 01:06:15 INFO - Output received: 01:06:15 INFO - Usage: mozinstall [options] installer 01:06:15 INFO - Options: 01:06:15 INFO - -h, --help show this help message and exit 01:06:15 INFO - -d DEST, --destination=DEST 01:06:15 INFO - Directory to install application into. [default: 01:06:15 INFO - "/builds/slave/test"] 01:06:15 INFO - --app=APP Application being installed. [default: firefox] 01:06:15 INFO - mkdir: /builds/slave/test/build/application 01:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:06:32 INFO - Reading from file tmpfile_stdout 01:06:32 INFO - Output received: 01:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 01:06:32 INFO - Running post-action listener: _resource_record_post_action 01:06:32 INFO - ##### 01:06:32 INFO - ##### Finished install step (success) 01:06:32 INFO - ##### 01:06:32 INFO - ##### 01:06:32 INFO - ##### Running run-tests step. 01:06:32 INFO - ##### 01:06:32 INFO - Running pre-action listener: _resource_record_pre_action 01:06:32 INFO - Running main action method: run_tests 01:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:06:32 INFO - Python 2.7.3 01:06:32 INFO - Return code: 0 01:06:32 INFO - grabbing minidump binary from tooltool 01:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:32 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 0x13de1c0>, '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 0x13df0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13df550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:06:32 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 01:06:32 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 01:06:32 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 01:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:06:32 INFO - Return code: 0 01:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:06:33 INFO - Return code: 0 01:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:06:33 INFO - Using env: {'DISPLAY': ':0', 01:06:33 INFO - 'HOME': '/home/cltbld', 01:06:33 INFO - 'LANG': 'en_US.UTF-8', 01:06:33 INFO - 'LANGUAGE': 'en_US:en', 01:06:33 INFO - 'LOGNAME': 'cltbld', 01:06:33 INFO - 'MAIL': '/var/mail/cltbld', 01:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:33 INFO - 'MOZ_NO_REMOTE': '1', 01:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:33 INFO - 'NO_EM_RESTART': '1', 01:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:33 INFO - 'PWD': '/builds/slave/test', 01:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:06:33 INFO - 'SHELL': '/bin/bash', 01:06:33 INFO - 'SHLVL': '1', 01:06:33 INFO - 'TERM': 'linux', 01:06:33 INFO - 'TMOUT': '86400', 01:06:33 INFO - 'USER': 'cltbld', 01:06:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533', 01:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:33 INFO - '_': '/tools/buildbot/bin/python'} 01:06:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:06:33 INFO - mozversion application_buildid: 20160603223049 01:06:33 INFO - mozversion application_changeset: 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 01:06:33 INFO - mozversion application_display_name: Nightly 01:06:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:06:33 INFO - mozversion application_name: Firefox 01:06:33 INFO - mozversion application_remotingname: firefox 01:06:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:06:33 INFO - mozversion application_vendor: Mozilla 01:06:33 INFO - mozversion application_version: 49.0a1 01:06:33 INFO - mozversion platform_buildid: 20160603223049 01:06:33 INFO - mozversion platform_changeset: 3538bc8b05aa5b9ee7fc2e27d2c7130cd881bb67 01:06:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:06:33 INFO - mozversion platform_version: 49.0a1 01:06:33 INFO - using testdate: 1465027593 01:06:33 INFO - actual date: 1465027593 01:06:33 INFO - starting webserver on 'localhost:44510' 01:06:33 INFO - SUITE-START | Running 2 tests 01:06:33 INFO - TEST-START | dromaeo_css 01:06:33 INFO - operating with platform_type : linux_ 01:06:33 INFO - Initialising browser for dromaeo_css test... 01:06:33 INFO - TEST-INFO | started process 3980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJidWm/profile http://localhost:44510/getInfo.html) 01:06:37 INFO - PROCESS | 3980 | __metrics Screen width/height:1600/1200 01:06:37 INFO - PROCESS | 3980 | colorDepth:24 01:06:37 INFO - PROCESS | 3980 | Browser inner width/height: 1024/697 01:06:37 INFO - PROCESS | 3980 | __metrics 01:06:38 ERROR - PROCESS | 3980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 01:06:39 INFO - TEST-INFO | 3980: exit 0 01:06:39 INFO - Browser initialized. 01:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 01:06:39 INFO - TEST-INFO | started process 4101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJidWm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:06:51 INFO - PROCESS | 4101 | RSS: Main: 167182336 01:06:51 INFO - PROCESS | 4101 | 01:07:40 INFO - PROCESS | 4101 | 1465027660784 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] 01:09:48 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44510/tests/dromaeo/cssquery-ext.html) 01:09:49 INFO - PROCESS | 4101 | RSS: Main: 170209280 01:09:49 INFO - PROCESS | 4101 | 01:12:51 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-ext.html (next: http://localhost:44510/tests/dromaeo/cssquery-jquery.html) 01:12:51 INFO - PROCESS | 4101 | RSS: Main: 169717760 01:12:51 INFO - PROCESS | 4101 | 01:15:53 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44510/tests/dromaeo/cssquery-mootools.html) 01:15:54 INFO - PROCESS | 4101 | RSS: Main: 171630592 01:15:54 INFO - PROCESS | 4101 | 01:18:56 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44510/tests/dromaeo/cssquery-prototype.html) 01:18:56 INFO - PROCESS | 4101 | RSS: Main: 168620032 01:18:56 INFO - PROCESS | 4101 | 01:21:59 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44510/tests/dromaeo/cssquery-yui.html) 01:22:00 INFO - PROCESS | 4101 | RSS: Main: 170762240 01:22:00 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | Cycle 1(1): loaded http://localhost:44510/tests/dromaeo/cssquery-yui.html (next: http://localhost:44510/tests/dromaeo/cssquery-dojo.html) 01:25:02 INFO - PROCESS | 4101 | RSS: Main: 171962368 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | __start_tp_report 01:25:02 INFO - PROCESS | 4101 | _x_x_mozilla_page_load 01:25:02 INFO - PROCESS | 4101 | _x_x_mozilla_page_load_details 01:25:02 INFO - PROCESS | 4101 | |i|pagename|runs| 01:25:02 INFO - PROCESS | 4101 | |0;dojo.html;3110.580071690322;3130.8121512709226;3142.277276226468;3154.7791654584175;3173.793703409279;5397.217403476494;5411.053065713504;5426.945730542693;5438.102713052346;5441.292631957845;5304.045271851065;5354.330708661418;5379.865503362418;5423.457654234585;5454.045542030149;4859.173940430135;4897.8775530611665;4975.950240497603;5027.044861476326;5070.543651071403;849.5773106955326;4797.160496913044;4843.685160464576;4969.055879382924;4994.051130285252;4851.054044461332;4881.389826271734;4912.631552633549;4936.728479933602;5003.499650034985;4899.681520701143;4906;4927.088488629615;4957.752112394366;4972;4863.2461968394955;4916.385451818523;4927.507249275044;4927.704337739711;4948.084604348207;5168.405633352175;5283;5288.127458969266;5333.653312534711;5351.277577527023;5696.914546281809;5734.741936612862;5775.5668324875805;5802.303723553158;5805.042168042268;5757.4818266355815;5793.13103034544;5825.825225243249;5867.677277749722;5875.118732190205;5412.377576578665;5416.485433883775;5431.511163995259;5443.83668489942;5445.673259604397;5747.655140691489;5882.705864706748;5982.461578457873;5984.491318237911;5986.5809393342915;5642.605017648807;5732.914006289909;5757.596968212269;5768.105943578668;5796.536277097822;5748.626339287933;5757.625754325955;5764.682942438122;5796.449337312949;5816.82549523515;5607.831765047055;5653.519450846724;5696.031674615326;5793.913091303634;5819.359870414251;5736;5737.913931291034;5745;5761.971190144022;5820.82537523875;4387.890302742393;4420.80106395213;4421.42521472213;4431.1137772445;4485.529019452975;3913.3542965410957;3927.1752931884052;3931.272714547818;3941.5270167580074;3956.5054368203973;5428.891422171613;5465.262189604353;5492.423295553909;5527.613067085346;5540.418256083134;5835.4748072673665;5908.350081491032;5913.793017244462;5937.673427961504;5941.197938278364;5449.237106805051;5582.637128586629;5610.943890561042;5626.831195064155;5651.15232715096;4937.679050861754;4986.675866068694;5001.89996200074;5017.648764586444;5026;6139.539534534839;6140.6929653517145;6157.168782214344;6164.845878853064;6177;5755.482006619424;5872.823815285548;5901.026330655393;5912.556558258148;5924.437178468039;6139.877202456015;6179.84550386244;6183.659898705614;6200.596961197508;6225.221847269091;5837.591368604327;5850.12248162762;5870.853228669317;5877.35349111606;5911.7930872420975;5633.126865335879;5732.369439361751;5765.221695071279;5844.035734103825;5880.911786323123;5704.229928959703;5726.541876649775;5738.856528586819;5739.684317362585;5774.509166720708;5517.586181036358;5654.575906806924;5703.372629010889;5715.314162300384;5724.255846740064;5500.4499550044675;5530.142827861688;5553.6390134641115;5575.721213939206;5578.414266501959;5686.687232202103;5687.146927960839;5687.914681279702;5691.715414229355;5702.45826646468;5390.757415916371;5545.140503222007;5574.804881829116;5574.86062848432;5575.107982722745 01:25:02 INFO - PROCESS | 4101 | |1;ext.html;564.9180868774027;596.9732060855329;618.7339444039064;627.9058141278807;650.7494614573394;38699.41950870739;42092.368614470804;42451.78774106133;42517.57482425171;42547.36178957318;42551;43549.7822510887;43556.782216088955;43746;43772.56227437725;8676.869846952284;8873.20141187293;8875.201231889128;8883.822323553524;8888.155625215626;8686.739397818044;8764.912350876506;8777.122287771204;8787.780305492382;8825.602847871862;8769.079246679103;8849.734507964771;8857.114288571156;8912.331575131859;8936.731898043068;8817.867731983994;8818.603162857655;8824.073472285381;8834.55827208637;8874.511901845395;8631.050584435707;8755;8836.513991730451;8852;8853.955730221373;40510.59489405098;40759.18481630351;40893.591064089575;40945.59054409448;41067.794661026506;3579.2483578448555;3608.4226523756074;3671.522702048743;3704.685101766353;3872.5159355080614;33335;33716;34225.14437139066;34455;34474.655253447396;4002.0595160137345;4028.2144981728575;4062.898427539335;4063.7764922929227;4094.222097801438;129730.35134824265;130415.34792326072;130738.34630826785;131022;131500;34432.311353772784;64021;64115.35884641187;64517.67741161264;64680.676596616715;35457.64542354544;36967.445488317695;37263.813680931424;37270.25459490795;37313.62686373156;15330.770038449433;15334.463293784664;15422.460213892684;15433.074015559103;15456;12937.805932911015;12971.805422918664;12989.350532473338;12990.155639883378;13001.15492492985;8399.37004724648;8436.620352084172;8476.957615212008;8533.914660853436;8543.188397102265;3266.2324353776844;3278.8032718036993;3279.983600081984;3298.373309071269;3382.746294027958;1066.4667666166918;1071.8338657507943;1084.3168803653648;1131.3042478875432;1165.9708507287385;33220;33847.661523384944;33934.49098263528;34048.48927266093;34127;1121.1647322744607;1121.9382933938548;1135.1089394825187;1152.6196355202762;1153.2503872482785;17280.11352847698;17417.47747567575;17434.476965690796;17565.20956556958;17583.912080439517;495152;502603;503369.76411651564;504039;506496;59653.70173149106;60489.395106049255;60866;60969.695151523956;61218.693906530185;1364;1370.260059567842;1374.3952660829402;1396.0576610787678;1400.1459109942928;30907.690923090482;32263.35473290474;32685.34629307353;32955.8352208247;32968.670313297516;53432.198517023055;53600.73199634133;54077.72961135169;54111.72944135254;54127.188092177865;398879;402440;404281;404547;407466;27689;29176;29249.122526324245;29273;29310.853445732635;48199.75900120617;49583.256251156985;50463;50651.493485064675;51209.48790512047;42605.57394426016;42815.571844281156;42905.57094429016;43216.13567728565;43324.56675433331;41636;41959.37060944027;42189.78905105455;43104.78447607742;43111;42206.155876881676;42348.78825605852;42957.35563966606;43565.56434435615;43913.78043109764;38084.238315232986;38432.807835960644;39045.60954390533;39169.73284274503;39372;29863.402731944803;29956.700432995392;30000.849995749883;30004.399912002074;30323.090307289935 01:25:02 INFO - PROCESS | 4101 | |2;jquery.html;366.6846511999678;376.4860964783069;382.95213098362706;389.9922001559969;399.34108720611005;17831.93008419496;19987.900060499713;20304.89847550762;20359.28742494015;20544.794552054474;18717.625647487042;19164.233430662793;19583.118759655816;19612.607747845035;19617.705734413994;5312.229726689628;5497.8075767348255;5621.269234999444;5732.082866741302;5783.624064435799;5418.864528386783;5685.289338832646;5686.431356864301;5688.744006519716;5756.65460072397;5554.888902221953;5733.799317023905;5814.244148260741;5831.650100993933;5834;5757.1652110444165;5762.135679648065;5798.536117110621;5830.387809280007;5846.09385545239;5533.584981126432;5768.769249230026;5774.0761478163295;5787.074068149076;5791.218185544982;20591.69112463299;21288.148474061174;21669.566608667898;22918.854057297067;23046.423839403982;2260.8530445520987;2306.1006207579057;2394.317619478458;2510.598304271308;2708.7155848636003;10066.194704423702;10203.489825508696;10323.690289291333;10340.431276279802;10470.685879423629;1945.4066509714532;1952.9804701952942;1963.4796778853615;1974.5853370792152;2001.5096301406104;82162.58918705428;85018.57490712569;85048;85141;85579.5721021391;10387.169026477864;10422.426766527913;10475.47622618866;10697.572097116185;11321.150913681508;14769.40922363115;14857.182854942866;14942.626434339229;14944;15121.470748523749;7836.333911617462;8172.264496195371;8175;8219.013718353835;8250.54621995796;7729.8454030919065;7755.379569634416;7805.726799561988;7821.608919554;7926.4847784894955;3611.638836116367;3771.340015497332;3844.2888065707934;4423.911521769546;4618.538146185355;1858.1638262781803;1858.210260639223;1872.4663470910725;1895.7061655443429;1907.094130288102;958.7028021313415;1004.0662184168647;1037.1650821089095;1049.396596956753;1076.7428528700586;18241;18871;18899.338523151622;19640.901795491216;19881.403557893285;1020.7597768710904;1033.235405799703;1035.4563853976722;1046.0951277145214;1070.6520380876245;10832.729181770519;11014.669559913216;11064.502097405637;11085.72285692848;11159.888401116048;488625;488878;488909;491122;503656;93016.53491732499;93792;94544.0545594549;94659;95835.52082239544;986.7582442301682;995.7162208770466;1002.1982414068862;1003.1373019203479;1013.690824298596;17699.646007080042;17727.379541715978;17796.91101544484;17923.73114403311;17987.550311242325;40022.39966400564;41220;41415.58584414118;41618;41745.791271043454;57184;58248;58774.70612646909;59820.102698460425;60138.699306503186;5434.212039254365;5447.618666693452;8377.874331884905;8580.227779499875;8610.65557377698;11278.492467838803;12912.483500659868;12982.675433114247;13331.400086996302;13496.86503134956;11504.712382190512;12022.038236940849;12036.097292703258;12112.818307725214;12399.194052386567;11633.825492617787;11685.182037257311;11699.122565807429;11760.470778814803;11845.111616628616;11929;12172.391380430767;12245.75508489843;12374;12406.81389779172;8423.831523369621;8599.097094804956;8631.223189912938;8730.126987301219;8840.513771742615;11441.828372574584;12162.148649594797;12271.509139634314;12290.446929888356;12488.937555312164 01:25:02 INFO - PROCESS | 4101 | |3;mootools.html;1506.902051366661;1515.212089713349;1692.7884014498188;1827.7258411238313;1842.6867432536467;7780.183080776522;8517.403781735266;8626.56867156642;9183.127602877725;9205.033471485498;8653.61058752356;8859.158379953895;8982.505962172077;9022.954885225565;9030.72907812765;2316.6872472216205;2348.095983046522;2351.0478256306137;2367.9052837886466;2369.917052903149;2356.1282325539573;2363.0902102690416;2393.4854006388623;2395.6526303685955;2399.448126930807;2329.196427232602;2350.318407661776;2359.28041947206;2369.6445533170076;2372.2171683344454;2335.871527066011;2339.2748248043163;2366.325597204797;2373.6083546214854;2383.4756353602265;2381.30942026812;2385.105585405473;2395.796357309631;2406.9037238510437;2419.8790060496904;8828.24959878411;8876.911230887674;8925.776855578597;8948.8657670135;8957.641694332218;5221.269022336875;5397.865053373658;5414.7834086636485;5422.674639521641;5441.646292990943;3205.118592387089;3217.549543063973;3323.0861513083855;3327.8169700666454;3379.0876463355003;1164.6971787335353;1165.8717541070475;1225.3260706611418;1251.3117785218094;2138.957220855574;12017.339046352447;12289.877101228964;12431.813522797165;12479.064070194772;12489.063320251018;4547.454305483363;4567.9086418271445;4669.766511674471;4672.672912896064;4687.20317546018;9631.277654175965;9703.66037188695;9742.171915387129;9745.951270243604;9749.07383798538;5175;5237.790488380499;5238.60710446718;5277.050130976461;5281.630285879952;4299.269124248885;4760.45254795696;4917.803287868517;4923.876903077452;4955.801767929314;3824.4836947012354;3828.2152158807376;3944.15200731844;3962.128331767007;3969.563348031714;1134.0643968725835;1141.406468636321;1149.3793351590048;1150.6087930103804;1178.8997935175435;980.6616717232544;998.0468652436905;1004.492731170754;1009.5255230042015;1034.736142283728;6016.278046634432;6158.784442544579;6162.137300777895;6307.779227727007;6321.747130114744;453.2770231480783;459.6920063557425;466.9322948172496;467.0215897694325;471.07433892401593;4316.5467625899455;4318.287482565404;4319.67602429819;4332.328489084197;4332.696711230184;10712.410817405118;11109.277896936674;11149.777004459866;11150.21948463616;11182.329060256248;10495;11024.724381890357;11112.888871111185;11116;11134.220604557766;7807.375409967302;8204.794880128045;8229.835403291901;8245.464044837066;8283.37874659403;6091.969540152271;6249.312575616769;6352.618842869442;6364.6181229126405;6400.935990640221;9833.754156145867;10252.846207306748;10267.640632577824;10349.430781306799;10351.327163734333;10227.59089636436;10356.844647330145;10509;10588;10636.627718029831;7259.6007219603425;7758.534487930742;7922.0889597697005;7954.84090318202;8035.638396272298;8741.169588889044;8813.294936404944;8816.426932249384;8821.779455513406;8870.911290887008;7539.698412063456;7675.270849269311;7818.374530037697;7940.16628254025;8050.5572193529915;7466.626668666654;7819.257170568787;7856.960715196617;7947.761567152995;8007.959960200395;7129.857402852018;7262.31008054234;7352.301531354513;7356.0437143173185;7385.187629360658;5161.251618515369;5248.186531087687;5261.921071184011;5314.734263286898;5337.039332919956;5169.438265016047;5245.423003469692;5258.395284542174;5292.391374991771;5347.572194224531 01:25:02 INFO - PROCESS | 4101 | |4;prototype.html;321.7072464057708;329.3314571420017;332.45975290153496;334.7372312734502;337.5982580728931;5408.594355423339;5457.399686034533;5480.7533660985255;5609.915851262234;5624.690642014688;5589.413111623282;5599.776008959647;5613.859653508664;5615.887682246363;5626.212330273755;4217.662586993041;4245.681573881956;4256.4463970650795;4284.400183974246;4342.609165175134;4062.5531191569053;4296.462942132233;4317.438732964726;4326.97836510817;4372.693911426201;4211.263028969934;4213;4218.725782824122;4268.295731204347;4309.676774241929;4208.200441916026;4243.554426785174;4249.766262855542;4278.229918614648;4290.2706539888295;3461.394256005214;3737.458068580068;3741.5323084614424;3755.2114056048263;3758.2859256741403;5273.997940391313;5289.3917199521775;5296.258523806631;5334.173203153478;5354.759035843357;4880.511948805127;4905.386826646669;4915.606751459874;4926.507349265081;4930.753462326905;5580.135079062752;5785.2189954356045;5801.3328467225965;5807.593468457209;5814.511293224074;4034.273830710471;4064.1058967027207;4071.104357041476;4082.7346222495444;4092.897677558085;5976.641401515923;6025.728842202111;6084.269887613515;6114.908276375858;6168.25980882297;4114.403411505315;4197.370394440858;4221.699173950205;4225.492940847118;4337.568602361213;4347.043650396908;4375.78121093944;4378.211921854033;4386.627136693417;4398.516163222043;4988.72562009093;4994.90010199794;5000.099962014411;5004.749762511859;5012.448630650625;5709.68596727184;5868.823935281948;5906.291245050621;5960.731767070492;5966.613354658171;1499.7252335514725;1503.5789978805951;1509.6150481627114;1510.77338399241;1540.8998415102983;936.9531523423801;941.8257622339889;943.4339396362265;968.1770495079127;979.5298256836759;4983.725895075806;5001.549860512571;5090.643654944119;5094.6688465249645;5161.200013997836;5343.198520221998;5347.540131539536;5357.11607584752;5479.726013699299;5487.972560137254;4987.561070647127;5069.479156253109;5174.231785994475;5176.870578235575;5217.791288348423;2830.6037154798346;2924.5905573219766;2935.2955290730497;2948.5282354823553;2949.7492713119195;5519.9448005520235;5591.273134492571;5666.798258983744;5671.688057156814;5687.492814404186;5198.376194856642;5273.730316600204;5436.510714035756;5484.2596249506605;5537.511367838236;5499.175123731392;5509.779608815683;5519.592503911557;5519.647686316798;5527.39198688144;5009.423916249532;5330.96046270989;5365.704886231295;5408.5673146149;5410.513053825174;5271.550323661024;5279.287296215115;5289.285946397187;5326.280952071421;5328.333958255218;5611.242482264842;5623.550115990793;5666.405027472056;5699.088145896637;6069.453749162597;4169.91660166801;4268.871933841865;4294.269974104473;4301.333293339538;4304.956950430581;5940.732667030081;5969.70151492415;6004.219451471281;6045.78839740607;6046.818595442144;5676.893005863817;5851.765929362949;5858.8242352729485;5895.9705201475435;5897.201353587197;5820.679862607428;5833.387494313036;5839.386864379179;5847.742735311758;5850.385709500441;5748.712564371848;5786.247787787561;5794.494330929895;5794.82615521535;5805.912911306249;5575;5802.460499095633;5811.680357580373;5822.475977162076;5858.648481091148;5684.602077854676;5719.456651618089;5726.685032323262;5752.922186630133;5794.4205579443405 01:25:02 INFO - PROCESS | 4101 | |5;yui.html;710.9822254443635;726.4297526441741;735.9742409015682;838.5974732128578;869.6130222051188;15557.455489057886;15980.440684576042;16509.752353714674;16525.669486610277;16548.834511654895;14992.175430351326;15185.620359491018;15205.923970380132;15212.695746085072;15225.390984360612;679.0357692077262;801.9157988411221;804.569555287921;833.9291160251356;835.8537255980209;813.7151996801132;817.0685418622775;820.3478234803316;820.9630566624517;824.1017291152642;850.6299759604592;863.0377129500594;865.9610317535726;866.0949307973152;867.6616119713317;848.5290663681654;848.6138806842872;849.1678155407674;849.2611428057598;853.7780177153985;610.8595023144658;613.7176898626637;617.3425302053299;617.4042049422329;617.543018166558;14499.130052196902;14643.853561464355;14671.046381985243;14705;14765.18791466469;13578.253196074213;13732.931335343259;13961.79057314141;15622.531324060297;15785.000849838494;13658.385372658255;13895.861041389659;13907.79138312926;14006.509772158028;14146.504872329522;4541.886452838672;4557.293619488984;4626.1210370029585;4678.602318802906;4701.083288758693;70982;71109.28890711078;74798.25201747967;76816.61591692005;77067;11227.34551549705;11369.602063927723;11649.41752912351;11662.416879156008;11844.763104737856;20556.28053018167;20652.793472065387;20683.896580517;20688.689669654665;20705.27531536419;8426;8476.872846907301;8490.702825401082;8623.913760862311;8778.736637900873;4831.558736254159;4847.321375007502;4897.510248975145;4975.253711943165;5013.072581572421;3170.4293227219323;3268.2319654881085;3282.7373810095137;3285.375778602058;3292.2592416706048;619.442501748421;620.8292719502083;624.8063100438878;640.7789312687208;641.7817941899776;580.2717589425245;587.3421767620207;622.6482037648714;728.0462594001768;737;9502.667406640734;10032.846515834337;10047.732696897316;10112.679290874332;10140.29975851678;623.4420193926411;629.9055141728777;643.2184895352169;670.3899451499112;731.1518638379455;4430.556944305544;4593.425821772278;4701.435827700698;4707.670463067552;4709.152352576569;102158.48920755349;103489;103624.48187759014;103844;105080.47459762653;61151.38848611457;61558.69220653868;74092;93368.53315733514;97441.51279243559;54830.80676772964;85287;85622.14377856266;86529;86639.56680216685;8943.642254309754;8955.59699813523;8967.148120928501;9061.41100828444;9086.000539940733;50234.497655022984;51010.74494627503;51059.48940510547;52141;52810.20784688156;74621.25378746144;75001.62499187469;76684;77498.6125069371;77502;13194.670133246362;13422.530211442552;13753.79369309441;13758.518451854137;13935;15081.698366032399;15157.242137893281;15339.233038347815;15429.922850385676;15490.380384784483;13595.592132236048;13765.449382024606;13917.652058698613;14229.14625122496;14347.713045738818;14315.57053288403;14689.559313220621;14691.85308146905;14792.926035369754;14846.960712750004;13682.93158534201;13789.586312410644;14243.145411275356;14412.85587144157;15236.466723664618;11936.880631193577;12041.277523348626;12131.272123672608;12180.390980451119;12310.876891230973;12039.217450865666;12185.329806860707;12440.31578263168;12535.686607834878;12625.242485450903 01:25:02 INFO - PROCESS | 4101 | __end_tp_report 01:25:02 INFO - PROCESS | 4101 | __start_cc_report 01:25:02 INFO - PROCESS | 4101 | _x_x_mozilla_cycle_collect,367 01:25:02 INFO - PROCESS | 4101 | __end_cc_report 01:25:02 INFO - PROCESS | 4101 | __startTimestamp1465028702651__endTimestamp 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | ------- Summary: start ------- 01:25:02 INFO - PROCESS | 4101 | Number of tests: 6 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#0] dojo.html Cycles:165 Average:5374.15 Median:5607.83 stddev:721.71 (12.9%) stddev-sans-first:701.73 01:25:02 INFO - PROCESS | 4101 | Values: 3110.6 3130.8 3142.3 3154.8 3173.8 5397.2 5411.1 5426.9 5438.1 5441.3 5304.0 5354.3 5379.9 5423.5 5454.0 4859.2 4897.9 4976.0 5027.0 5070.5 849.6 4797.2 4843.7 4969.1 4994.1 4851.1 4881.4 4912.6 4936.7 5003.5 4899.7 4906.0 4927.1 4957.8 4972.0 4863.2 4916.4 4927.5 4927.7 4948.1 5168.4 5283.0 5288.1 5333.7 5351.3 5696.9 5734.7 5775.6 5802.3 5805.0 5757.5 5793.1 5825.8 5867.7 5875.1 5412.4 5416.5 5431.5 5443.8 5445.7 5747.7 5882.7 5982.5 5984.5 5986.6 5642.6 5732.9 5757.6 5768.1 5796.5 5748.6 5757.6 5764.7 5796.4 5816.8 5607.8 5653.5 5696.0 5793.9 5819.4 5736.0 5737.9 5745.0 5762.0 5820.8 4387.9 4420.8 4421.4 4431.1 4485.5 3913.4 3927.2 3931.3 3941.5 3956.5 5428.9 5465.3 5492.4 5527.6 5540.4 5835.5 5908.4 5913.8 5937.7 5941.2 5449.2 5582.6 5610.9 5626.8 5651.2 4937.7 4986.7 5001.9 5017.6 5026.0 6139.5 6140.7 6157.2 6164.8 6177.0 5755.5 5872.8 5901.0 5912.6 5924.4 6139.9 6179.8 6183.7 6200.6 6225.2 5837.6 5850.1 5870.9 5877.4 5911.8 5633.1 5732.4 5765.2 5844.0 5880.9 5704.2 5726.5 5738.9 5739.7 5774.5 5517.6 5654.6 5703.4 5715.3 5724.3 5500.4 5530.1 5553.6 5575.7 5578.4 5686.7 5687.1 5687.9 5691.7 5702.5 5390.8 5545.1 5574.8 5574.9 5575.1 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#1] ext.html Cycles:180 Average:51729.84 Median:205764.89 stddev:101459.27 (49.3%) stddev-sans-first:101671.16 01:25:02 INFO - PROCESS | 4101 | Values: 564.9 597.0 618.7 627.9 650.7 38699.4 42092.4 42451.8 42517.6 42547.4 42551.0 43549.8 43556.8 43746.0 43772.6 8676.9 8873.2 8875.2 8883.8 8888.2 8686.7 8764.9 8777.1 8787.8 8825.6 8769.1 8849.7 8857.1 8912.3 8936.7 8817.9 8818.6 8824.1 8834.6 8874.5 8631.1 8755.0 8836.5 8852.0 8854.0 40510.6 40759.2 40893.6 40945.6 41067.8 3579.2 3608.4 3671.5 3704.7 3872.5 33335.0 33716.0 34225.1 34455.0 34474.7 4002.1 4028.2 4062.9 4063.8 4094.2 129730.4 130415.3 130738.3 131022.0 131500.0 34432.3 64021.0 64115.4 64517.7 64680.7 35457.6 36967.4 37263.8 37270.3 37313.6 15330.8 15334.5 15422.5 15433.1 15456.0 12937.8 12971.8 12989.4 12990.2 13001.2 8399.4 8436.6 8477.0 8533.9 8543.2 3266.2 3278.8 3280.0 3298.4 3382.7 1066.5 1071.8 1084.3 1131.3 1166.0 33220.0 33847.7 33934.5 34048.5 34127.0 1121.2 1121.9 1135.1 1152.6 1153.3 17280.1 17417.5 17434.5 17565.2 17583.9 495152.0 502603.0 503369.8 504039.0 506496.0 59653.7 60489.4 60866.0 60969.7 61218.7 1364.0 1370.3 1374.4 1396.1 1400.1 30907.7 32263.4 32685.3 32955.8 32968.7 53432.2 53600.7 54077.7 54111.7 54127.2 398879.0 402440.0 404281.0 404547.0 407466.0 27689.0 29176.0 29249.1 29273.0 29310.9 48199.8 49583.3 50463.0 50651.5 51209.5 42605.6 42815.6 42905.6 43216.1 43324.6 41636.0 41959.4 42189.8 43104.8 43111.0 42206.2 42348.8 42957.4 43565.6 43913.8 38084.2 38432.8 39045.6 39169.7 39372.0 29863.4 29956.7 30000.8 30004.4 30323.1 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#2] jquery.html Cycles:180 Average:29199.79 Median:12589.85 stddev:81287.29 (645.7%) stddev-sans-first:81486.49 01:25:02 INFO - PROCESS | 4101 | Values: 366.7 376.5 383.0 390.0 399.3 17831.9 19987.9 20304.9 20359.3 20544.8 18717.6 19164.2 19583.1 19612.6 19617.7 5312.2 5497.8 5621.3 5732.1 5783.6 5418.9 5685.3 5686.4 5688.7 5756.7 5554.9 5733.8 5814.2 5831.7 5834.0 5757.2 5762.1 5798.5 5830.4 5846.1 5533.6 5768.8 5774.1 5787.1 5791.2 20591.7 21288.1 21669.6 22918.9 23046.4 2260.9 2306.1 2394.3 2510.6 2708.7 10066.2 10203.5 10323.7 10340.4 10470.7 1945.4 1953.0 1963.5 1974.6 2001.5 82162.6 85018.6 85048.0 85141.0 85579.6 10387.2 10422.4 10475.5 10697.6 11321.2 14769.4 14857.2 14942.6 14944.0 15121.5 7836.3 8172.3 8175.0 8219.0 8250.5 7729.8 7755.4 7805.7 7821.6 7926.5 3611.6 3771.3 3844.3 4423.9 4618.5 1858.2 1858.2 1872.5 1895.7 1907.1 958.7 1004.1 1037.2 1049.4 1076.7 18241.0 18871.0 18899.3 19640.9 19881.4 1020.8 1033.2 1035.5 1046.1 1070.7 10832.7 11014.7 11064.5 11085.7 11159.9 488625.0 488878.0 488909.0 491122.0 503656.0 93016.5 93792.0 94544.1 94659.0 95835.5 986.8 995.7 1002.2 1003.1 1013.7 17699.6 17727.4 17796.9 17923.7 17987.6 40022.4 41220.0 41415.6 41618.0 41745.8 57184.0 58248.0 58774.7 59820.1 60138.7 5434.2 5447.6 8377.9 8580.2 8610.7 11278.5 12912.5 12982.7 13331.4 13496.9 11504.7 12022.0 12036.1 12112.8 12399.2 11633.8 11685.2 11699.1 11760.5 11845.1 11929.0 12172.4 12245.8 12374.0 12406.8 8423.8 8599.1 8631.2 8730.1 8840.5 11441.8 12162.1 12271.5 12290.4 12488.9 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#3] mootools.html Cycles:180 Average:5861.37 Median:4679.94 stddev:3323.21 (71.0%) stddev-sans-first:3316.42 01:25:02 INFO - PROCESS | 4101 | Values: 1506.9 1515.2 1692.8 1827.7 1842.7 7780.2 8517.4 8626.6 9183.1 9205.0 8653.6 8859.2 8982.5 9023.0 9030.7 2316.7 2348.1 2351.0 2367.9 2369.9 2356.1 2363.1 2393.5 2395.7 2399.4 2329.2 2350.3 2359.3 2369.6 2372.2 2335.9 2339.3 2366.3 2373.6 2383.5 2381.3 2385.1 2395.8 2406.9 2419.9 8828.2 8876.9 8925.8 8948.9 8957.6 5221.3 5397.9 5414.8 5422.7 5441.6 3205.1 3217.5 3323.1 3327.8 3379.1 1164.7 1165.9 1225.3 1251.3 2139.0 12017.3 12289.9 12431.8 12479.1 12489.1 4547.5 4567.9 4669.8 4672.7 4687.2 9631.3 9703.7 9742.2 9746.0 9749.1 5175.0 5237.8 5238.6 5277.1 5281.6 4299.3 4760.5 4917.8 4923.9 4955.8 3824.5 3828.2 3944.2 3962.1 3969.6 1134.1 1141.4 1149.4 1150.6 1178.9 980.7 998.0 1004.5 1009.5 1034.7 6016.3 6158.8 6162.1 6307.8 6321.7 453.3 459.7 466.9 467.0 471.1 4316.5 4318.3 4319.7 4332.3 4332.7 10712.4 11109.3 11149.8 11150.2 11182.3 10495.0 11024.7 11112.9 11116.0 11134.2 7807.4 8204.8 8229.8 8245.5 8283.4 6092.0 6249.3 6352.6 6364.6 6400.9 9833.8 10252.8 10267.6 10349.4 10351.3 10227.6 10356.8 10509.0 10588.0 10636.6 7259.6 7758.5 7922.1 7954.8 8035.6 8741.2 8813.3 8816.4 8821.8 8870.9 7539.7 7675.3 7818.4 7940.2 8050.6 7466.6 7819.3 7857.0 7947.8 8008.0 7129.9 7262.3 7352.3 7356.0 7385.2 5161.3 5248.2 5261.9 5314.7 5337.0 5169.4 5245.4 5258.4 5292.4 5347.6 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#4] prototype.html Cycles:180 Average:4746.58 Median:5329.65 stddev:1377.74 (25.9%) stddev-sans-first:1340.98 01:25:02 INFO - PROCESS | 4101 | Values: 321.7 329.3 332.5 334.7 337.6 5408.6 5457.4 5480.8 5609.9 5624.7 5589.4 5599.8 5613.9 5615.9 5626.2 4217.7 4245.7 4256.4 4284.4 4342.6 4062.6 4296.5 4317.4 4327.0 4372.7 4211.3 4213.0 4218.7 4268.3 4309.7 4208.2 4243.6 4249.8 4278.2 4290.3 3461.4 3737.5 3741.5 3755.2 3758.3 5274.0 5289.4 5296.3 5334.2 5354.8 4880.5 4905.4 4915.6 4926.5 4930.8 5580.1 5785.2 5801.3 5807.6 5814.5 4034.3 4064.1 4071.1 4082.7 4092.9 5976.6 6025.7 6084.3 6114.9 6168.3 4114.4 4197.4 4221.7 4225.5 4337.6 4347.0 4375.8 4378.2 4386.6 4398.5 4988.7 4994.9 5000.1 5004.7 5012.4 5709.7 5868.8 5906.3 5960.7 5966.6 1499.7 1503.6 1509.6 1510.8 1540.9 937.0 941.8 943.4 968.2 979.5 4983.7 5001.5 5090.6 5094.7 5161.2 5343.2 5347.5 5357.1 5479.7 5488.0 4987.6 5069.5 5174.2 5176.9 5217.8 2830.6 2924.6 2935.3 2948.5 2949.7 5519.9 5591.3 5666.8 5671.7 5687.5 5198.4 5273.7 5436.5 5484.3 5537.5 5499.2 5509.8 5519.6 5519.6 5527.4 5009.4 5331.0 5365.7 5408.6 5410.5 5271.6 5279.3 5289.3 5326.3 5328.3 5611.2 5623.6 5666.4 5699.1 6069.5 4169.9 4268.9 4294.3 4301.3 4305.0 5940.7 5969.7 6004.2 6045.8 6046.8 5676.9 5851.8 5858.8 5896.0 5897.2 5820.7 5833.4 5839.4 5847.7 5850.4 5748.7 5786.2 5794.5 5794.8 5805.9 5575.0 5802.5 5811.7 5822.5 5858.6 5684.6 5719.5 5726.7 5752.9 5794.4 01:25:02 INFO - PROCESS | 4101 | 01:25:02 INFO - PROCESS | 4101 | [#5] yui.html Cycles:180 Average:19928.87 Median:4701.26 stddev:27221.12 (579.0%) stddev-sans-first:27259.23 01:25:02 INFO - PROCESS | 4101 | Values: 711.0 726.4 736.0 838.6 869.6 15557.5 15980.4 16509.8 16525.7 16548.8 14992.2 15185.6 15205.9 15212.7 15225.4 679.0 801.9 804.6 833.9 835.9 813.7 817.1 820.3 821.0 824.1 850.6 863.0 866.0 866.1 867.7 848.5 848.6 849.2 849.3 853.8 610.9 613.7 617.3 617.4 617.5 14499.1 14643.9 14671.0 14705.0 14765.2 13578.3 13732.9 13961.8 15622.5 15785.0 13658.4 13895.9 13907.8 14006.5 14146.5 4541.9 4557.3 4626.1 4678.6 4701.1 70982.0 71109.3 74798.3 76816.6 77067.0 11227.3 11369.6 11649.4 11662.4 11844.8 20556.3 20652.8 20683.9 20688.7 20705.3 8426.0 8476.9 8490.7 8623.9 8778.7 4831.6 4847.3 4897.5 4975.3 5013.1 3170.4 3268.2 3282.7 3285.4 3292.3 619.4 620.8 624.8 640.8 641.8 580.3 587.3 622.6 728.0 737.0 9502.7 10032.8 10047.7 10112.7 10140.3 623.4 629.9 643.2 670.4 731.2 4430.6 4593.4 4701.4 4707.7 4709.2 102158.5 103489.0 103624.5 103844.0 105080.5 61151.4 61558.7 74092.0 93368.5 97441.5 54830.8 85287.0 85622.1 86529.0 86639.6 8943.6 8955.6 8967.1 9061.4 9086.0 50234.5 51010.7 51059.5 52141.0 52810.2 74621.3 75001.6 76684.0 77498.6 77502.0 13194.7 13422.5 13753.8 13758.5 13935.0 15081.7 15157.2 15339.2 15429.9 15490.4 13595.6 13765.4 13917.7 14229.1 14347.7 14315.6 14689.6 14691.9 14792.9 14847.0 13682.9 13789.6 14243.1 14412.9 15236.5 11936.9 12041.3 12131.3 12180.4 12310.9 12039.2 12185.3 12440.3 12535.7 12625.2 01:25:02 INFO - PROCESS | 4101 | -------- Summary: end -------- 01:25:02 INFO - PROCESS | 4101 | 01:25:03 INFO - TEST-INFO | 4101: exit 0 01:25:03 INFO - TEST-OK | dromaeo_css | took 1109893ms 01:25:03 INFO - TEST-START | kraken 01:25:03 INFO - operating with platform_type : linux_ 01:25:03 INFO - Initialising browser for kraken test... 01:25:03 INFO - TEST-INFO | started process 4340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5C_0L5/profile http://localhost:44510/getInfo.html) 01:25:07 INFO - PROCESS | 4340 | __metrics Screen width/height:1600/1200 01:25:07 INFO - PROCESS | 4340 | colorDepth:24 01:25:07 INFO - PROCESS | 4340 | Browser inner width/height: 1024/697 01:25:07 INFO - PROCESS | 4340 | __metrics 01:25:08 ERROR - PROCESS | 4340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 01:25:09 INFO - TEST-INFO | 4340: exit 0 01:25:09 INFO - Browser initialized. 01:25:09 INFO - Running cycle 1/1 for kraken test... 01:25:09 INFO - TEST-INFO | started process 4461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5C_0L5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:21 INFO - PROCESS | 4461 | RSS: Main: 167538688 01:25:21 INFO - PROCESS | 4461 | 01:25:23 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44510/tests/kraken/driver.html?testName=audio-beat-detection) 01:25:24 INFO - PROCESS | 4461 | RSS: Main: 172576768 01:25:24 INFO - PROCESS | 4461 | 01:25:27 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44510/tests/kraken/driver.html?testName=audio-dft) 01:25:27 INFO - PROCESS | 4461 | RSS: Main: 172244992 01:25:27 INFO - PROCESS | 4461 | 01:25:30 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44510/tests/kraken/driver.html?testName=audio-fft) 01:25:31 INFO - PROCESS | 4461 | RSS: Main: 167108608 01:25:31 INFO - PROCESS | 4461 | 01:25:33 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44510/tests/kraken/driver.html?testName=audio-oscillator) 01:25:34 INFO - PROCESS | 4461 | RSS: Main: 168034304 01:25:34 INFO - PROCESS | 4461 | 01:25:36 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:25:37 INFO - PROCESS | 4461 | RSS: Main: 168140800 01:25:37 INFO - PROCESS | 4461 | 01:25:40 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44510/tests/kraken/driver.html?testName=imaging-darkroom) 01:25:40 INFO - PROCESS | 4461 | RSS: Main: 168669184 01:25:40 INFO - PROCESS | 4461 | 01:25:44 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44510/tests/kraken/driver.html?testName=imaging-desaturate) 01:25:44 INFO - PROCESS | 4461 | RSS: Main: 168669184 01:25:44 INFO - PROCESS | 4461 | 01:25:47 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44510/tests/kraken/driver.html?testName=json-parse-financial) 01:25:48 INFO - PROCESS | 4461 | RSS: Main: 169127936 01:25:48 INFO - PROCESS | 4461 | 01:25:49 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:25:50 INFO - PROCESS | 4461 | RSS: Main: 169058304 01:25:50 INFO - PROCESS | 4461 | 01:25:52 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:25:52 INFO - PROCESS | 4461 | RSS: Main: 168988672 01:25:52 INFO - PROCESS | 4461 | 01:25:55 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:25:55 INFO - PROCESS | 4461 | RSS: Main: 169758720 01:25:55 INFO - PROCESS | 4461 | 01:25:58 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:25:58 INFO - PROCESS | 4461 | RSS: Main: 169463808 01:25:58 INFO - PROCESS | 4461 | 01:26:01 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:02 INFO - PROCESS | 4461 | RSS: Main: 169160704 01:26:02 INFO - PROCESS | 4461 | 01:26:03 INFO - PROCESS | 4461 | Cycle 1(1): loaded http://localhost:44510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44510/tests/kraken/driver.html?testName=ai-astar) 01:26:04 INFO - PROCESS | 4461 | RSS: Main: 169959424 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | __start_tp_report 01:26:04 INFO - PROCESS | 4461 | _x_x_mozilla_page_load 01:26:04 INFO - PROCESS | 4461 | _x_x_mozilla_page_load_details 01:26:04 INFO - PROCESS | 4461 | |i|pagename|runs| 01:26:04 INFO - PROCESS | 4461 | |0;ai-astar;112;106;111;114;110;111;110;110;114;113 01:26:04 INFO - PROCESS | 4461 | |1;audio-beat-detection;163;125;159;179;127;163;152;129;185;126 01:26:04 INFO - PROCESS | 4461 | |2;audio-dft;161;164;161;162;163;164;169;164;162;162 01:26:04 INFO - PROCESS | 4461 | |3;audio-fft;76;75;75;160;77;75;74;75;160;75 01:26:04 INFO - PROCESS | 4461 | |4;audio-oscillator;86;87;146;87;84;85;143;85;85;143 01:26:04 INFO - PROCESS | 4461 | |5;imaging-gaussian-blur;117;118;118;117;118;117;119;119;117;117 01:26:04 INFO - PROCESS | 4461 | |6;imaging-darkroom;147;147;147;146;147;147;146;147;146;147 01:26:04 INFO - PROCESS | 4461 | |7;imaging-desaturate;97;95;96;95;96;95;95;96;95;96 01:26:04 INFO - PROCESS | 4461 | |8;json-parse-financial;53;54;53;56;57;56;55;54;55;55 01:26:04 INFO - PROCESS | 4461 | |9;json-stringify-tinderbox;62;62;65;62;62;61;62;62;61;62 01:26:04 INFO - PROCESS | 4461 | |10;stanford-crypto-aes;78;78;78;80;80;78;81;80;108;78 01:26:04 INFO - PROCESS | 4461 | |11;stanford-crypto-ccm;132;123;133;120;132;126;131;122;136;128 01:26:04 INFO - PROCESS | 4461 | |12;stanford-crypto-pbkdf2;158;158;165;160;161;163;161;158;164;158 01:26:04 INFO - PROCESS | 4461 | |13;stanford-crypto-sha256-iterative;64;72;66;64;65;66;66;64;64;62 01:26:04 INFO - PROCESS | 4461 | __end_tp_report 01:26:04 INFO - PROCESS | 4461 | __start_cc_report 01:26:04 INFO - PROCESS | 4461 | _x_x_mozilla_cycle_collect,880 01:26:04 INFO - PROCESS | 4461 | __end_cc_report 01:26:04 INFO - PROCESS | 4461 | __startTimestamp1465028764211__endTimestamp 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | ------- Summary: start ------- 01:26:04 INFO - PROCESS | 4461 | Number of tests: 14 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:2.38 (2.1%) stddev-sans-first:2.50 01:26:04 INFO - PROCESS | 4461 | Values: 112.0 106.0 111.0 114.0 110.0 111.0 110.0 110.0 114.0 113.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:161.00 stddev:22.74 (14.1%) stddev-sans-first:23.69 01:26:04 INFO - PROCESS | 4461 | Values: 163.0 125.0 159.0 179.0 127.0 163.0 152.0 129.0 185.0 126.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.35 01:26:04 INFO - PROCESS | 4461 | Values: 161.0 164.0 161.0 162.0 163.0 164.0 169.0 164.0 162.0 162.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#3] audio-fft Cycles:10 Average:92.20 Median:75.00 stddev:35.74 (47.7%) stddev-sans-first:37.43 01:26:04 INFO - PROCESS | 4461 | Values: 76.0 75.0 75.0 160.0 77.0 75.0 74.0 75.0 160.0 75.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:28.25 (33.2%) stddev-sans-first:29.28 01:26:04 INFO - PROCESS | 4461 | Values: 86.0 87.0 146.0 87.0 84.0 85.0 143.0 85.0 85.0 143.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 01:26:04 INFO - PROCESS | 4461 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 119.0 119.0 117.0 117.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:26:04 INFO - PROCESS | 4461 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 01:26:04 INFO - PROCESS | 4461 | Values: 97.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.32 (2.4%) stddev-sans-first:1.22 01:26:04 INFO - PROCESS | 4461 | Values: 53.0 54.0 53.0 56.0 57.0 56.0 55.0 54.0 55.0 55.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 01:26:04 INFO - PROCESS | 4461 | Values: 62.0 62.0 65.0 62.0 62.0 61.0 62.0 62.0 61.0 62.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:79.00 stddev:9.24 (11.7%) stddev-sans-first:9.70 01:26:04 INFO - PROCESS | 4461 | Values: 78.0 78.0 78.0 80.0 80.0 78.0 81.0 80.0 108.0 78.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:131.50 stddev:5.36 (4.1%) stddev-sans-first:5.51 01:26:04 INFO - PROCESS | 4461 | Values: 132.0 123.0 133.0 120.0 132.0 126.0 131.0 122.0 136.0 128.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.67 (1.7%) stddev-sans-first:2.67 01:26:04 INFO - PROCESS | 4461 | Values: 158.0 158.0 165.0 160.0 161.0 163.0 161.0 158.0 164.0 158.0 01:26:04 INFO - PROCESS | 4461 | 01:26:04 INFO - PROCESS | 4461 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.67 (4.1%) stddev-sans-first:2.79 01:26:04 INFO - PROCESS | 4461 | Values: 64.0 72.0 66.0 64.0 65.0 66.0 66.0 64.0 64.0 62.0 01:26:04 INFO - PROCESS | 4461 | -------- Summary: end -------- 01:26:04 INFO - PROCESS | 4461 | 01:26:05 INFO - TEST-INFO | 4461: exit 0 01:26:05 INFO - TEST-OK | kraken | took 61731ms 01:26:05 INFO - SUITE-END | took 1171s 01:26:05 INFO - Completed test suite (00:19:31) 01:26:05 INFO - javascript benchmark 01:26:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.483639972508, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.580071690322, 3130.8121512709226, 3142.277276226468, 3154.7791654584175, 3173.793703409279, 5397.217403476494, 5411.053065713504, 5426.945730542693, 5438.102713052346, 5441.292631957845, 5304.045271851065, 5354.330708661418, 5379.865503362418, 5423.457654234585, 5454.045542030149, 4859.173940430135, 4897.8775530611665, 4975.950240497603, 5027.044861476326, 5070.543651071403, 849.5773106955326, 4797.160496913044, 4843.685160464576, 4969.055879382924, 4994.051130285252, 4851.054044461332, 4881.389826271734, 4912.631552633549, 4936.728479933602, 5003.499650034985, 4899.681520701143, 4906.0, 4927.088488629615, 4957.752112394366, 4972.0, 4863.2461968394955, 4916.385451818523, 4927.507249275044, 4927.704337739711, 4948.084604348207, 5168.405633352175, 5283.0, 5288.127458969266, 5333.653312534711, 5351.277577527023, 5696.914546281809, 5734.741936612862, 5775.5668324875805, 5802.303723553158, 5805.042168042268, 5757.4818266355815, 5793.13103034544, 5825.825225243249, 5867.677277749722, 5875.118732190205, 5412.377576578665, 5416.485433883775, 5431.511163995259, 5443.83668489942, 5445.673259604397, 5747.655140691489, 5882.705864706748, 5982.461578457873, 5984.491318237911, 5986.5809393342915, 5642.605017648807, 5732.914006289909, 5757.596968212269, 5768.105943578668, 5796.536277097822, 5748.626339287933, 5757.625754325955, 5764.682942438122, 5796.449337312949, 5816.82549523515, 5607.831765047055, 5653.519450846724, 5696.031674615326, 5793.913091303634, 5819.359870414251, 5736.0, 5737.913931291034, 5745.0, 5761.971190144022, 5820.82537523875, 4387.890302742393, 4420.80106395213, 4421.42521472213, 4431.1137772445, 4485.529019452975, 3913.3542965410957, 3927.1752931884052, 3931.272714547818, 3941.5270167580074, 3956.5054368203973, 5428.891422171613, 5465.262189604353, 5492.423295553909, 5527.613067085346, 5540.418256083134, 5835.4748072673665, 5908.350081491032, 5913.793017244462, 5937.673427961504, 5941.197938278364, 5449.237106805051, 5582.637128586629, 5610.943890561042, 5626.831195064155, 5651.15232715096, 4937.679050861754, 4986.675866068694, 5001.89996200074, 5017.648764586444, 5026.0, 6139.539534534839, 6140.6929653517145, 6157.168782214344, 6164.845878853064, 6177.0, 5755.482006619424, 5872.823815285548, 5901.026330655393, 5912.556558258148, 5924.437178468039, 6139.877202456015, 6179.84550386244, 6183.659898705614, 6200.596961197508, 6225.221847269091, 5837.591368604327, 5850.12248162762, 5870.853228669317, 5877.35349111606, 5911.7930872420975, 5633.126865335879, 5732.369439361751, 5765.221695071279, 5844.035734103825, 5880.911786323123, 5704.229928959703, 5726.541876649775, 5738.856528586819, 5739.684317362585, 5774.509166720708, 5517.586181036358, 5654.575906806924, 5703.372629010889, 5715.314162300384, 5724.255846740064, 5500.4499550044675, 5530.142827861688, 5553.6390134641115, 5575.721213939206, 5578.414266501959, 5686.687232202103, 5687.146927960839, 5687.914681279702, 5691.715414229355, 5702.45826646468, 5390.757415916371, 5545.140503222007, 5574.804881829116, 5574.86062848432, 5575.107982722745], "value": 5326.104916127976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9180868774027, 596.9732060855329, 618.7339444039064, 627.9058141278807, 650.7494614573394, 38699.41950870739, 42092.368614470804, 42451.78774106133, 42517.57482425171, 42547.36178957318, 42551.0, 43549.7822510887, 43556.782216088955, 43746.0, 43772.56227437725, 8676.869846952284, 8873.20141187293, 8875.201231889128, 8883.822323553524, 8888.155625215626, 8686.739397818044, 8764.912350876506, 8777.122287771204, 8787.780305492382, 8825.602847871862, 8769.079246679103, 8849.734507964771, 8857.114288571156, 8912.331575131859, 8936.731898043068, 8817.867731983994, 8818.603162857655, 8824.073472285381, 8834.55827208637, 8874.511901845395, 8631.050584435707, 8755.0, 8836.513991730451, 8852.0, 8853.955730221373, 40510.59489405098, 40759.18481630351, 40893.591064089575, 40945.59054409448, 41067.794661026506, 3579.2483578448555, 3608.4226523756074, 3671.522702048743, 3704.685101766353, 3872.5159355080614, 33335.0, 33716.0, 34225.14437139066, 34455.0, 34474.655253447396, 4002.0595160137345, 4028.2144981728575, 4062.898427539335, 4063.7764922929227, 4094.222097801438, 129730.35134824265, 130415.34792326072, 130738.34630826785, 131022.0, 131500.0, 34432.311353772784, 64021.0, 64115.35884641187, 64517.67741161264, 64680.676596616715, 35457.64542354544, 36967.445488317695, 37263.813680931424, 37270.25459490795, 37313.62686373156, 15330.770038449433, 15334.463293784664, 15422.460213892684, 15433.074015559103, 15456.0, 12937.805932911015, 12971.805422918664, 12989.350532473338, 12990.155639883378, 13001.15492492985, 8399.37004724648, 8436.620352084172, 8476.957615212008, 8533.914660853436, 8543.188397102265, 3266.2324353776844, 3278.8032718036993, 3279.983600081984, 3298.373309071269, 3382.746294027958, 1066.4667666166918, 1071.8338657507943, 1084.3168803653648, 1131.3042478875432, 1165.9708507287385, 33220.0, 33847.661523384944, 33934.49098263528, 34048.48927266093, 34127.0, 1121.1647322744607, 1121.9382933938548, 1135.1089394825187, 1152.6196355202762, 1153.2503872482785, 17280.11352847698, 17417.47747567575, 17434.476965690796, 17565.20956556958, 17583.912080439517, 495152.0, 502603.0, 503369.76411651564, 504039.0, 506496.0, 59653.70173149106, 60489.395106049255, 60866.0, 60969.695151523956, 61218.693906530185, 1364.0, 1370.260059567842, 1374.3952660829402, 1396.0576610787678, 1400.1459109942928, 30907.690923090482, 32263.35473290474, 32685.34629307353, 32955.8352208247, 32968.670313297516, 53432.198517023055, 53600.73199634133, 54077.72961135169, 54111.72944135254, 54127.188092177865, 398879.0, 402440.0, 404281.0, 404547.0, 407466.0, 27689.0, 29176.0, 29249.122526324245, 29273.0, 29310.853445732635, 48199.75900120617, 49583.256251156985, 50463.0, 50651.493485064675, 51209.48790512047, 42605.57394426016, 42815.571844281156, 42905.57094429016, 43216.13567728565, 43324.56675433331, 41636.0, 41959.37060944027, 42189.78905105455, 43104.78447607742, 43111.0, 42206.155876881676, 42348.78825605852, 42957.35563966606, 43565.56434435615, 43913.78043109764, 38084.238315232986, 38432.807835960644, 39045.60954390533, 39169.73284274503, 39372.0, 29863.402731944803, 29956.700432995392, 30000.849995749883, 30004.399912002074, 30323.090307289935], "value": 18655.4456940381, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6846511999678, 376.4860964783069, 382.95213098362706, 389.9922001559969, 399.34108720611005, 17831.93008419496, 19987.900060499713, 20304.89847550762, 20359.28742494015, 20544.794552054474, 18717.625647487042, 19164.233430662793, 19583.118759655816, 19612.607747845035, 19617.705734413994, 5312.229726689628, 5497.8075767348255, 5621.269234999444, 5732.082866741302, 5783.624064435799, 5418.864528386783, 5685.289338832646, 5686.431356864301, 5688.744006519716, 5756.65460072397, 5554.888902221953, 5733.799317023905, 5814.244148260741, 5831.650100993933, 5834.0, 5757.1652110444165, 5762.135679648065, 5798.536117110621, 5830.387809280007, 5846.09385545239, 5533.584981126432, 5768.769249230026, 5774.0761478163295, 5787.074068149076, 5791.218185544982, 20591.69112463299, 21288.148474061174, 21669.566608667898, 22918.854057297067, 23046.423839403982, 2260.8530445520987, 2306.1006207579057, 2394.317619478458, 2510.598304271308, 2708.7155848636003, 10066.194704423702, 10203.489825508696, 10323.690289291333, 10340.431276279802, 10470.685879423629, 1945.4066509714532, 1952.9804701952942, 1963.4796778853615, 1974.5853370792152, 2001.5096301406104, 82162.58918705428, 85018.57490712569, 85048.0, 85141.0, 85579.5721021391, 10387.169026477864, 10422.426766527913, 10475.47622618866, 10697.572097116185, 11321.150913681508, 14769.40922363115, 14857.182854942866, 14942.626434339229, 14944.0, 15121.470748523749, 7836.333911617462, 8172.264496195371, 8175.0, 8219.013718353835, 8250.54621995796, 7729.8454030919065, 7755.379569634416, 7805.726799561988, 7821.608919554, 7926.4847784894955, 3611.638836116367, 3771.340015497332, 3844.2888065707934, 4423.911521769546, 4618.538146185355, 1858.1638262781803, 1858.210260639223, 1872.4663470910725, 1895.7061655443429, 1907.094130288102, 958.7028021313415, 1004.0662184168647, 1037.1650821089095, 1049.396596956753, 1076.7428528700586, 18241.0, 18871.0, 18899.338523151622, 19640.901795491216, 19881.403557893285, 1020.7597768710904, 1033.235405799703, 1035.4563853976722, 1046.0951277145214, 1070.6520380876245, 10832.729181770519, 11014.669559913216, 11064.502097405637, 11085.72285692848, 11159.888401116048, 488625.0, 488878.0, 488909.0, 491122.0, 503656.0, 93016.53491732499, 93792.0, 94544.0545594549, 94659.0, 95835.52082239544, 986.7582442301682, 995.7162208770466, 1002.1982414068862, 1003.1373019203479, 1013.690824298596, 17699.646007080042, 17727.379541715978, 17796.91101544484, 17923.73114403311, 17987.550311242325, 40022.39966400564, 41220.0, 41415.58584414118, 41618.0, 41745.791271043454, 57184.0, 58248.0, 58774.70612646909, 59820.102698460425, 60138.699306503186, 5434.212039254365, 5447.618666693452, 8377.874331884905, 8580.227779499875, 8610.65557377698, 11278.492467838803, 12912.483500659868, 12982.675433114247, 13331.400086996302, 13496.86503134956, 11504.712382190512, 12022.038236940849, 12036.097292703258, 12112.818307725214, 12399.194052386567, 11633.825492617787, 11685.182037257311, 11699.122565807429, 11760.470778814803, 11845.111616628616, 11929.0, 12172.391380430767, 12245.75508489843, 12374.0, 12406.81389779172, 8423.831523369621, 8599.097094804956, 8631.223189912938, 8730.126987301219, 8840.513771742615, 11441.828372574584, 12162.148649594797, 12271.509139634314, 12290.446929888356, 12488.937555312164], "value": 9189.191616730679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.902051366661, 1515.212089713349, 1692.7884014498188, 1827.7258411238313, 1842.6867432536467, 7780.183080776522, 8517.403781735266, 8626.56867156642, 9183.127602877725, 9205.033471485498, 8653.61058752356, 8859.158379953895, 8982.505962172077, 9022.954885225565, 9030.72907812765, 2316.6872472216205, 2348.095983046522, 2351.0478256306137, 2367.9052837886466, 2369.917052903149, 2356.1282325539573, 2363.0902102690416, 2393.4854006388623, 2395.6526303685955, 2399.448126930807, 2329.196427232602, 2350.318407661776, 2359.28041947206, 2369.6445533170076, 2372.2171683344454, 2335.871527066011, 2339.2748248043163, 2366.325597204797, 2373.6083546214854, 2383.4756353602265, 2381.30942026812, 2385.105585405473, 2395.796357309631, 2406.9037238510437, 2419.8790060496904, 8828.24959878411, 8876.911230887674, 8925.776855578597, 8948.8657670135, 8957.641694332218, 5221.269022336875, 5397.865053373658, 5414.7834086636485, 5422.674639521641, 5441.646292990943, 3205.118592387089, 3217.549543063973, 3323.0861513083855, 3327.8169700666454, 3379.0876463355003, 1164.6971787335353, 1165.8717541070475, 1225.3260706611418, 1251.3117785218094, 2138.957220855574, 12017.339046352447, 12289.877101228964, 12431.813522797165, 12479.064070194772, 12489.063320251018, 4547.454305483363, 4567.9086418271445, 4669.766511674471, 4672.672912896064, 4687.20317546018, 9631.277654175965, 9703.66037188695, 9742.171915387129, 9745.951270243604, 9749.07383798538, 5175.0, 5237.790488380499, 5238.60710446718, 5277.050130976461, 5281.630285879952, 4299.269124248885, 4760.45254795696, 4917.803287868517, 4923.876903077452, 4955.801767929314, 3824.4836947012354, 3828.2152158807376, 3944.15200731844, 3962.128331767007, 3969.563348031714, 1134.0643968725835, 1141.406468636321, 1149.3793351590048, 1150.6087930103804, 1178.8997935175435, 980.6616717232544, 998.0468652436905, 1004.492731170754, 1009.5255230042015, 1034.736142283728, 6016.278046634432, 6158.784442544579, 6162.137300777895, 6307.779227727007, 6321.747130114744, 453.2770231480783, 459.6920063557425, 466.9322948172496, 467.0215897694325, 471.07433892401593, 4316.5467625899455, 4318.287482565404, 4319.67602429819, 4332.328489084197, 4332.696711230184, 10712.410817405118, 11109.277896936674, 11149.777004459866, 11150.21948463616, 11182.329060256248, 10495.0, 11024.724381890357, 11112.888871111185, 11116.0, 11134.220604557766, 7807.375409967302, 8204.794880128045, 8229.835403291901, 8245.464044837066, 8283.37874659403, 6091.969540152271, 6249.312575616769, 6352.618842869442, 6364.6181229126405, 6400.935990640221, 9833.754156145867, 10252.846207306748, 10267.640632577824, 10349.430781306799, 10351.327163734333, 10227.59089636436, 10356.844647330145, 10509.0, 10588.0, 10636.627718029831, 7259.6007219603425, 7758.534487930742, 7922.0889597697005, 7954.84090318202, 8035.638396272298, 8741.169588889044, 8813.294936404944, 8816.426932249384, 8821.779455513406, 8870.911290887008, 7539.698412063456, 7675.270849269311, 7818.374530037697, 7940.16628254025, 8050.5572193529915, 7466.626668666654, 7819.257170568787, 7856.960715196617, 7947.761567152995, 8007.959960200395, 7129.857402852018, 7262.31008054234, 7352.301531354513, 7356.0437143173185, 7385.187629360658, 5161.251618515369, 5248.186531087687, 5261.921071184011, 5314.734263286898, 5337.039332919956, 5169.438265016047, 5245.423003469692, 5258.395284542174, 5292.391374991771, 5347.572194224531], "value": 4632.530793240182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.7072464057708, 329.3314571420017, 332.45975290153496, 334.7372312734502, 337.5982580728931, 5408.594355423339, 5457.399686034533, 5480.7533660985255, 5609.915851262234, 5624.690642014688, 5589.413111623282, 5599.776008959647, 5613.859653508664, 5615.887682246363, 5626.212330273755, 4217.662586993041, 4245.681573881956, 4256.4463970650795, 4284.400183974246, 4342.609165175134, 4062.5531191569053, 4296.462942132233, 4317.438732964726, 4326.97836510817, 4372.693911426201, 4211.263028969934, 4213.0, 4218.725782824122, 4268.295731204347, 4309.676774241929, 4208.200441916026, 4243.554426785174, 4249.766262855542, 4278.229918614648, 4290.2706539888295, 3461.394256005214, 3737.458068580068, 3741.5323084614424, 3755.2114056048263, 3758.2859256741403, 5273.997940391313, 5289.3917199521775, 5296.258523806631, 5334.173203153478, 5354.759035843357, 4880.511948805127, 4905.386826646669, 4915.606751459874, 4926.507349265081, 4930.753462326905, 5580.135079062752, 5785.2189954356045, 5801.3328467225965, 5807.593468457209, 5814.511293224074, 4034.273830710471, 4064.1058967027207, 4071.104357041476, 4082.7346222495444, 4092.897677558085, 5976.641401515923, 6025.728842202111, 6084.269887613515, 6114.908276375858, 6168.25980882297, 4114.403411505315, 4197.370394440858, 4221.699173950205, 4225.492940847118, 4337.568602361213, 4347.043650396908, 4375.78121093944, 4378.211921854033, 4386.627136693417, 4398.516163222043, 4988.72562009093, 4994.90010199794, 5000.099962014411, 5004.749762511859, 5012.448630650625, 5709.68596727184, 5868.823935281948, 5906.291245050621, 5960.731767070492, 5966.613354658171, 1499.7252335514725, 1503.5789978805951, 1509.6150481627114, 1510.77338399241, 1540.8998415102983, 936.9531523423801, 941.8257622339889, 943.4339396362265, 968.1770495079127, 979.5298256836759, 4983.725895075806, 5001.549860512571, 5090.643654944119, 5094.6688465249645, 5161.200013997836, 5343.198520221998, 5347.540131539536, 5357.11607584752, 5479.726013699299, 5487.972560137254, 4987.561070647127, 5069.479156253109, 5174.231785994475, 5176.870578235575, 5217.791288348423, 2830.6037154798346, 2924.5905573219766, 2935.2955290730497, 2948.5282354823553, 2949.7492713119195, 5519.9448005520235, 5591.273134492571, 5666.798258983744, 5671.688057156814, 5687.492814404186, 5198.376194856642, 5273.730316600204, 5436.510714035756, 5484.2596249506605, 5537.511367838236, 5499.175123731392, 5509.779608815683, 5519.592503911557, 5519.647686316798, 5527.39198688144, 5009.423916249532, 5330.96046270989, 5365.704886231295, 5408.5673146149, 5410.513053825174, 5271.550323661024, 5279.287296215115, 5289.285946397187, 5326.280952071421, 5328.333958255218, 5611.242482264842, 5623.550115990793, 5666.405027472056, 5699.088145896637, 6069.453749162597, 4169.91660166801, 4268.871933841865, 4294.269974104473, 4301.333293339538, 4304.956950430581, 5940.732667030081, 5969.70151492415, 6004.219451471281, 6045.78839740607, 6046.818595442144, 5676.893005863817, 5851.765929362949, 5858.8242352729485, 5895.9705201475435, 5897.201353587197, 5820.679862607428, 5833.387494313036, 5839.386864379179, 5847.742735311758, 5850.385709500441, 5748.712564371848, 5786.247787787561, 5794.494330929895, 5794.82615521535, 5805.912911306249, 5575.0, 5802.460499095633, 5811.680357580373, 5822.475977162076, 5858.648481091148, 5684.602077854676, 5719.456651618089, 5726.685032323262, 5752.922186630133, 5794.4205579443405], "value": 4306.004247741718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9822254443635, 726.4297526441741, 735.9742409015682, 838.5974732128578, 869.6130222051188, 15557.455489057886, 15980.440684576042, 16509.752353714674, 16525.669486610277, 16548.834511654895, 14992.175430351326, 15185.620359491018, 15205.923970380132, 15212.695746085072, 15225.390984360612, 679.0357692077262, 801.9157988411221, 804.569555287921, 833.9291160251356, 835.8537255980209, 813.7151996801132, 817.0685418622775, 820.3478234803316, 820.9630566624517, 824.1017291152642, 850.6299759604592, 863.0377129500594, 865.9610317535726, 866.0949307973152, 867.6616119713317, 848.5290663681654, 848.6138806842872, 849.1678155407674, 849.2611428057598, 853.7780177153985, 610.8595023144658, 613.7176898626637, 617.3425302053299, 617.4042049422329, 617.543018166558, 14499.130052196902, 14643.853561464355, 14671.046381985243, 14705.0, 14765.18791466469, 13578.253196074213, 13732.931335343259, 13961.79057314141, 15622.531324060297, 15785.000849838494, 13658.385372658255, 13895.861041389659, 13907.79138312926, 14006.509772158028, 14146.504872329522, 4541.886452838672, 4557.293619488984, 4626.1210370029585, 4678.602318802906, 4701.083288758693, 70982.0, 71109.28890711078, 74798.25201747967, 76816.61591692005, 77067.0, 11227.34551549705, 11369.602063927723, 11649.41752912351, 11662.416879156008, 11844.763104737856, 20556.28053018167, 20652.793472065387, 20683.896580517, 20688.689669654665, 20705.27531536419, 8426.0, 8476.872846907301, 8490.702825401082, 8623.913760862311, 8778.736637900873, 4831.558736254159, 4847.321375007502, 4897.510248975145, 4975.253711943165, 5013.072581572421, 3170.4293227219323, 3268.2319654881085, 3282.7373810095137, 3285.375778602058, 3292.2592416706048, 619.442501748421, 620.8292719502083, 624.8063100438878, 640.7789312687208, 641.7817941899776, 580.2717589425245, 587.3421767620207, 622.6482037648714, 728.0462594001768, 737.0, 9502.667406640734, 10032.846515834337, 10047.732696897316, 10112.679290874332, 10140.29975851678, 623.4420193926411, 629.9055141728777, 643.2184895352169, 670.3899451499112, 731.1518638379455, 4430.556944305544, 4593.425821772278, 4701.435827700698, 4707.670463067552, 4709.152352576569, 102158.48920755349, 103489.0, 103624.48187759014, 103844.0, 105080.47459762653, 61151.38848611457, 61558.69220653868, 74092.0, 93368.53315733514, 97441.51279243559, 54830.80676772964, 85287.0, 85622.14377856266, 86529.0, 86639.56680216685, 8943.642254309754, 8955.59699813523, 8967.148120928501, 9061.41100828444, 9086.000539940733, 50234.497655022984, 51010.74494627503, 51059.48940510547, 52141.0, 52810.20784688156, 74621.25378746144, 75001.62499187469, 76684.0, 77498.6125069371, 77502.0, 13194.670133246362, 13422.530211442552, 13753.79369309441, 13758.518451854137, 13935.0, 15081.698366032399, 15157.242137893281, 15339.233038347815, 15429.922850385676, 15490.380384784483, 13595.592132236048, 13765.449382024606, 13917.652058698613, 14229.14625122496, 14347.713045738818, 14315.57053288403, 14689.559313220621, 14691.85308146905, 14792.926035369754, 14846.960712750004, 13682.93158534201, 13789.586312410644, 14243.145411275356, 14412.85587144157, 15236.466723664618, 11936.880631193577, 12041.277523348626, 12131.272123672608, 12180.390980451119, 12310.876891230973, 12039.217450865666, 12185.329806860707, 12440.31578263168, 12535.686607834878, 12625.242485450903], "value": 7587.901258046566, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 114.0, 110.0, 111.0, 110.0, 110.0, 114.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 159.0, 179.0, 127.0, 163.0, 152.0, 129.0, 185.0, 126.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 162.0, 163.0, 164.0, 169.0, 164.0, 162.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 160.0, 77.0, 75.0, 74.0, 75.0, 160.0, 75.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 146.0, 87.0, 84.0, 85.0, 143.0, 85.0, 85.0, 143.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 119.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 56.0, 57.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 80.0, 80.0, 78.0, 81.0, 80.0, 108.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 133.0, 120.0, 132.0, 126.0, 131.0, 122.0, 136.0, 128.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 165.0, 160.0, 161.0, 163.0, 161.0, 158.0, 164.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 66.0, 64.0, 65.0, 66.0, 66.0, 64.0, 64.0, 62.0], "value": 65.3, "unit": "score"}]}]} 01:26:05 INFO - Return code: 0 01:26:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:26:05 ERROR - # TBPL SUCCESS # 01:26:05 INFO - Running post-action listener: _resource_record_post_action 01:26:05 INFO - ##### 01:26:05 INFO - ##### Finished run-tests step (success) 01:26:05 INFO - ##### 01:26:05 INFO - Running post-run listener: _resource_record_post_run 01:26:05 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 4096; Write bytes: 540958720; Read time: 8; Write time: 507772 01:26:05 INFO - TinderboxPrint: CPU usage
13.5% 01:26:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:26:05 INFO - TinderboxPrint: I/O write bytes / time
540,958,720 / 507,772 01:26:05 INFO - TinderboxPrint: CPU idle
8,212.9 (86.5%) 01:26:05 INFO - TinderboxPrint: CPU user
1,226.7 (12.9%) 01:26:05 INFO - TinderboxPrint: Swap in / out
0 / 0 01:26:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248000512; Read time: 0; Write time: 238644 01:26:05 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292958208; Read time: 8; Write time: 269128 01:26:06 INFO - Running post-run listener: _upload_blobber_files 01:26:06 INFO - Blob upload gear active. 01:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:26:06 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 01:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:26:06 INFO - (blobuploader) - INFO - Open directory for files ... 01:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:09 INFO - (blobuploader) - INFO - Done attempting. 01:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:10 INFO - (blobuploader) - INFO - Done attempting. 01:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:11 INFO - (blobuploader) - INFO - Done attempting. 01:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:26:11 INFO - Return code: 0 01:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a19ad145a06245d42697a36cd0b4e45c9e7f040ed470f03e8287799473c72f8255cc04f408802fc67005b6ebd03e66e4422d0684a12018fce5ddf9ffba4c93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6eab2cfdb6f812008c8cc5c038f1770d4a40a6681e12d0622918994715c1cb91aaec9337776146c6f2f1cafc553579defca3dfbd9f57bc5d4e4d5ddfaf1d4a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84fc20a97587ab6b25da7b952c7bd24120e9a9e7975e5e3f96a2336ec4d9ffa3cf2dc2a05447e90be5dbe28c4c4ebe8e3e40e10a4d9d7f759c4553bd9b21a3a8"} 01:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:26:11 INFO - Contents: 01:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a19ad145a06245d42697a36cd0b4e45c9e7f040ed470f03e8287799473c72f8255cc04f408802fc67005b6ebd03e66e4422d0684a12018fce5ddf9ffba4c93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6eab2cfdb6f812008c8cc5c038f1770d4a40a6681e12d0622918994715c1cb91aaec9337776146c6f2f1cafc553579defca3dfbd9f57bc5d4e4d5ddfaf1d4a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84fc20a97587ab6b25da7b952c7bd24120e9a9e7975e5e3f96a2336ec4d9ffa3cf2dc2a05447e90be5dbe28c4c4ebe8e3e40e10a4d9d7f759c4553bd9b21a3a8"} 01:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 01:26:11 INFO - Copying logs to upload dir... 01:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 01:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.369117 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 01:26:11.287297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 01:26:11.293113) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a19ad145a06245d42697a36cd0b4e45c9e7f040ed470f03e8287799473c72f8255cc04f408802fc67005b6ebd03e66e4422d0684a12018fce5ddf9ffba4c93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6eab2cfdb6f812008c8cc5c038f1770d4a40a6681e12d0622918994715c1cb91aaec9337776146c6f2f1cafc553579defca3dfbd9f57bc5d4e4d5ddfaf1d4a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84fc20a97587ab6b25da7b952c7bd24120e9a9e7975e5e3f96a2336ec4d9ffa3cf2dc2a05447e90be5dbe28c4c4ebe8e3e40e10a4d9d7f759c4553bd9b21a3a8"} build_url:https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/JSRZoQwvRYOrmY1LStthYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a19ad145a06245d42697a36cd0b4e45c9e7f040ed470f03e8287799473c72f8255cc04f408802fc67005b6ebd03e66e4422d0684a12018fce5ddf9ffba4c93a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6eab2cfdb6f812008c8cc5c038f1770d4a40a6681e12d0622918994715c1cb91aaec9337776146c6f2f1cafc553579defca3dfbd9f57bc5d4e4d5ddfaf1d4a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84fc20a97587ab6b25da7b952c7bd24120e9a9e7975e5e3f96a2336ec4d9ffa3cf2dc2a05447e90be5dbe28c4c4ebe8e3e40e10a4d9d7f759c4553bd9b21a3a8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 01:26:11.319318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:26:11.319689) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465013652.344807-1318291533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 01:26:11.408680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 01:26:11.409398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 01:26:11.409978) ========= ========= Total master_lag: 0.17 =========