builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1465179037.05 results: success (0) buildid: 20160605163003 builduid: 40dec010446b4dbe8612b8205283e671 revision: e54065dbe41dc0192f5d1710ad1ba5855f573545 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.051089) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.052205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.052472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.069388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.069639) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 19:10:37-- 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% 223M=0s 2016-06-05 19:10:37 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.413370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.496410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.496746) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.546252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 19:10:37.546578) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e54065dbe41dc0192f5d1710ad1ba5855f573545 --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 e54065dbe41dc0192f5d1710ad1ba5855f573545 --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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 19:10:37,820 truncating revision to first 12 chars 2016-06-05 19:10:37,820 Setting DEBUG logging. 2016-06-05 19:10:37,820 attempt 1/10 2016-06-05 19:10:37,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e54065dbe41d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 19:10:39,009 unpacking tar archive at: mozilla-inbound-e54065dbe41d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 19:10:39.104426) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:39.104771) ========= script_repo_revision: e54065dbe41dc0192f5d1710ad1ba5855f573545 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:39.105153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:39.105453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:39.114785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-05 19:10:39.115043) ========= /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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:39 INFO - MultiFileLogger online at 20160605 19:10:39 in /builds/slave/test 19:10:39 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 19:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:39 INFO - {'append_to_log': False, 19:10:39 INFO - 'base_work_dir': '/builds/slave/test', 19:10:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:39 INFO - 'branch': 'Mozilla-Inbound', 19:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:39 INFO - 'config_files': ('talos/linux_config.py',), 19:10:39 INFO - 'default_actions': ('clobber', 19:10:39 INFO - 'read-buildbot-config', 19:10:39 INFO - 'download-and-extract', 19:10:39 INFO - 'populate-webroot', 19:10:39 INFO - 'create-virtualenv', 19:10:39 INFO - 'install', 19:10:39 INFO - 'run-tests'), 19:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:39 INFO - 'download_minidump_stackwalk': True, 19:10:39 INFO - 'download_symbols': 'ondemand', 19:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:39 INFO - 'installer_path': 'installer.exe', 19:10:39 INFO - 'log_level': 'info', 19:10:39 INFO - 'log_name': 'talos', 19:10:39 INFO - 'log_to_console': True, 19:10:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:39 INFO - 'opt_config_files': (), 19:10:39 INFO - 'pip_index': False, 19:10:39 INFO - 'sps_profile': False, 19:10:39 INFO - 'sps_profile_interval': 0, 19:10:39 INFO - 'suite': 'dromaeojs-e10s', 19:10:39 INFO - 'system_bits': '32', 19:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:39 INFO - 'title': 'talos-linux64-ix-046', 19:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:39 INFO - 'use_talos_json': True, 19:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:39 INFO - 'work_dir': 'build'} 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running clobber step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: clobber 19:10:39 INFO - rmtree: /builds/slave/test/build 19:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - ##### 19:10:39 INFO - ##### Finished clobber step (success) 19:10:39 INFO - ##### 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running read-buildbot-config step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: read_buildbot_config 19:10:39 INFO - Using buildbot properties: 19:10:39 INFO - { 19:10:39 INFO - "project": "", 19:10:39 INFO - "product": "firefox", 19:10:39 INFO - "script_repo_revision": "production", 19:10:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:10:39 INFO - "repository": "", 19:10:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:10:39 INFO - "buildid": "20160605163003", 19:10:39 INFO - "pgo_build": "True", 19:10:39 INFO - "basedir": "/builds/slave/test", 19:10:39 INFO - "buildnumber": 1124, 19:10:39 INFO - "slavename": "talos-linux64-ix-046", 19:10:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:10:39 INFO - "platform": "ubuntu64_hw", 19:10:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:10:39 INFO - "branch": "mozilla-inbound", 19:10:39 INFO - "repo_path": "integration/mozilla-inbound", 19:10:39 INFO - "revision": "e54065dbe41dc0192f5d1710ad1ba5855f573545", 19:10:39 INFO - "stage_platform": "linux64-pgo", 19:10:39 INFO - "builduid": "40dec010446b4dbe8612b8205283e671", 19:10:39 INFO - "slavebuilddir": "test" 19:10:39 INFO - } 19:10:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - ##### 19:10:39 INFO - ##### Finished read-buildbot-config step (success) 19:10:39 INFO - ##### 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running download-and-extract step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: download_and_extract 19:10:39 INFO - mkdir: /builds/slave/test/build/tests 19:10:39 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')]} 19:10:39 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:42 INFO - Downloaded 1361 bytes. 19:10:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:42 INFO - Using the following test package requirements: 19:10:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'jsshell-linux-x86_64.zip'], 19:10:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:42 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:46 INFO - Downloaded 24443848 bytes. 19:10:46 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'] 19:10:46 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 19:10:48 INFO - Return code: 0 19:10:48 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 19:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:48 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:51 INFO - Downloaded 24443848 bytes. 19:10:51 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'] 19:10:51 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 19:10:52 INFO - Return code: 0 19:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:52 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:53 INFO - Downloaded 10833369 bytes. 19:10:53 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'] 19:10:53 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 19:10:53 INFO - Return code: 0 19:10: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')]} 19:10:53 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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 19:10:59 INFO - Downloaded 59192519 bytes. 19:10:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:59 INFO - mkdir: /builds/slave/test/properties 19:10:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:59 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:59 INFO - Contents: 19:10:59 INFO - build_url:https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:00 INFO - Running post-action listener: _resource_record_post_action 19:11:00 INFO - Running post-action listener: set_extra_try_arguments 19:11:00 INFO - ##### 19:11:00 INFO - ##### Finished download-and-extract step (success) 19:11:00 INFO - ##### 19:11:00 INFO - ##### 19:11:00 INFO - ##### Running populate-webroot step. 19:11:00 INFO - ##### 19:11:00 INFO - Running pre-action listener: _resource_record_pre_action 19:11:00 INFO - Running main action method: populate_webroot 19:11:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:00 INFO - '--tppagecycles', 19:11:00 INFO - '7'], 19:11:00 INFO - 'tests': ['tsvgm']}}, 19:11:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['damp', 'tps']}, 19:11:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'tests': ['damp', 'tps']}, 19:11:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['dromaeo_dom']}, 19:11:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['a11yr', 19:11:00 INFO - 'ts_paint', 19:11:00 INFO - 'tpaint', 19:11:00 INFO - 'sessionrestore', 19:11:00 INFO - 'sessionrestore_no_auto_restore', 19:11:00 INFO - 'tabpaint']}, 19:11:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['tsvgx', 19:11:00 INFO - 'tsvgr_opacity', 19:11:00 INFO - 'tart', 19:11:00 INFO - 'tscrollx', 19:11:00 INFO - 'cart']}, 19:11:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:00 INFO - 'tsvgr_opacity', 19:11:00 INFO - 'tart', 19:11:00 INFO - 'tscrollx', 19:11:00 INFO - 'cart']}, 19:11:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'talos_options': ['--disable-e10s'], 19:11:00 INFO - 'tests': ['tp5o']}, 19:11:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'tests': ['tp5o']}, 19:11:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'talos_options': ['--disable-e10s', 19:11:00 INFO - '--xperf_path', 19:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:00 INFO - 'tests': ['tp5n']}, 19:11:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:00 INFO - 'talos_options': ['--xperf_path', 19:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:00 INFO - 'tests': ['tp5n']}}, 19:11:00 INFO - 'talos.zip': {'path': '', 19:11:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:00 INFO - Running post-action listener: _resource_record_post_action 19:11:00 INFO - ##### 19:11:00 INFO - ##### Finished populate-webroot step (success) 19:11:00 INFO - ##### 19:11:00 INFO - ##### 19:11:00 INFO - ##### Running create-virtualenv step. 19:11:00 INFO - ##### 19:11:00 INFO - Running pre-action listener: _resource_record_pre_action 19:11:00 INFO - Running main action method: create_virtualenv 19:11:00 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:00 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 19:11:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:00 INFO - Using real prefix '/usr' 19:11:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:01 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:03 INFO - Installing pip.................done. 19:11:03 INFO - Return code: 0 19:11:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:11:03 INFO - Using env: {'DISPLAY': ':0', 19:11:03 INFO - 'HOME': '/home/cltbld', 19:11:03 INFO - 'LANG': 'en_US.UTF-8', 19:11:03 INFO - 'LANGUAGE': 'en_US:en', 19:11:03 INFO - 'LOGNAME': 'cltbld', 19:11:03 INFO - 'MAIL': '/var/mail/cltbld', 19:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:03 INFO - 'MOZ_NO_REMOTE': '1', 19:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:03 INFO - 'NO_EM_RESTART': '1', 19:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:03 INFO - 'PWD': '/builds/slave/test', 19:11:03 INFO - 'SHELL': '/bin/bash', 19:11:03 INFO - 'SHLVL': '1', 19:11:03 INFO - 'TERM': 'linux', 19:11:03 INFO - 'TMOUT': '86400', 19:11:03 INFO - 'USER': 'cltbld', 19:11:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:03 INFO - '_': '/tools/buildbot/bin/python'} 19:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:03 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 19:11:03 INFO - Cleaning up... 19:11:03 INFO - Return code: 0 19:11:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:11:03 INFO - Using env: {'DISPLAY': ':0', 19:11:03 INFO - 'HOME': '/home/cltbld', 19:11:03 INFO - 'LANG': 'en_US.UTF-8', 19:11:03 INFO - 'LANGUAGE': 'en_US:en', 19:11:03 INFO - 'LOGNAME': 'cltbld', 19:11:03 INFO - 'MAIL': '/var/mail/cltbld', 19:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:03 INFO - 'MOZ_NO_REMOTE': '1', 19:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:03 INFO - 'NO_EM_RESTART': '1', 19:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:03 INFO - 'PWD': '/builds/slave/test', 19:11:03 INFO - 'SHELL': '/bin/bash', 19:11:03 INFO - 'SHLVL': '1', 19:11:03 INFO - 'TERM': 'linux', 19:11:03 INFO - 'TMOUT': '86400', 19:11:03 INFO - 'USER': 'cltbld', 19:11:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:03 INFO - '_': '/tools/buildbot/bin/python'} 19:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:03 INFO - Downloading/unpacking psutil>=3.1.1 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:05 INFO - Installing collected packages: psutil 19:11:05 INFO - Running setup.py install for psutil 19:11:05 INFO - building 'psutil._psutil_linux' extension 19:11:05 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 19:11:05 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 19:11:05 INFO - building 'psutil._psutil_posix' extension 19:11:05 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 19:11:05 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 19:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:05 INFO - Successfully installed psutil 19:11:05 INFO - Cleaning up... 19:11:06 INFO - Return code: 0 19:11:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:06 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')]} 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 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')]} 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:06 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 19:11:06 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 19:11:06 INFO - Using env: {'DISPLAY': ':0', 19:11:06 INFO - 'HOME': '/home/cltbld', 19:11:06 INFO - 'LANG': 'en_US.UTF-8', 19:11:06 INFO - 'LANGUAGE': 'en_US:en', 19:11:06 INFO - 'LOGNAME': 'cltbld', 19:11:06 INFO - 'MAIL': '/var/mail/cltbld', 19:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:06 INFO - 'MOZ_NO_REMOTE': '1', 19:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:06 INFO - 'NO_EM_RESTART': '1', 19:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:06 INFO - 'PWD': '/builds/slave/test', 19:11:06 INFO - 'SHELL': '/bin/bash', 19:11:06 INFO - 'SHLVL': '1', 19:11:06 INFO - 'TERM': 'linux', 19:11:06 INFO - 'TMOUT': '86400', 19:11:06 INFO - 'USER': 'cltbld', 19:11:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:06 INFO - '_': '/tools/buildbot/bin/python'} 19:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:08 INFO - Installing collected packages: mozsystemmonitor 19:11:08 INFO - Running setup.py install for mozsystemmonitor 19:11:08 INFO - Successfully installed mozsystemmonitor 19:11:08 INFO - Cleaning up... 19:11:08 INFO - Return code: 0 19:11:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:11:08 INFO - Using env: {'DISPLAY': ':0', 19:11:08 INFO - 'HOME': '/home/cltbld', 19:11:08 INFO - 'LANG': 'en_US.UTF-8', 19:11:08 INFO - 'LANGUAGE': 'en_US:en', 19:11:08 INFO - 'LOGNAME': 'cltbld', 19:11:08 INFO - 'MAIL': '/var/mail/cltbld', 19:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:08 INFO - 'MOZ_NO_REMOTE': '1', 19:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:08 INFO - 'NO_EM_RESTART': '1', 19:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:08 INFO - 'PWD': '/builds/slave/test', 19:11:08 INFO - 'SHELL': '/bin/bash', 19:11:08 INFO - 'SHLVL': '1', 19:11:08 INFO - 'TERM': 'linux', 19:11:08 INFO - 'TMOUT': '86400', 19:11:08 INFO - 'USER': 'cltbld', 19:11:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:08 INFO - '_': '/tools/buildbot/bin/python'} 19:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:08 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:10 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 19:11:10 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 19:11:10 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 19:11:10 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 19:11:10 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 19:11:10 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 19:11:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:10 INFO - warning: no files found matching '*.txt' 19:11:10 INFO - no previously-included directories found matching 'build' 19:11:10 INFO - no previously-included directories found matching 'dist' 19:11:10 INFO - no previously-included directories found matching '.git*' 19:11:10 INFO - Installing collected packages: jsonschema, functools32 19:11:10 INFO - Running setup.py install for functools32 19:11:10 INFO - warning: no files found matching '*.txt' 19:11:10 INFO - no previously-included directories found matching 'build' 19:11:10 INFO - no previously-included directories found matching 'dist' 19:11:10 INFO - no previously-included directories found matching '.git*' 19:11:10 INFO - Successfully installed jsonschema functools32 19:11:10 INFO - Cleaning up... 19:11:10 INFO - Return code: 0 19:11:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:10 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')]} 19:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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')]} 19:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:10 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 19:11:10 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 19:11:10 INFO - Using env: {'DISPLAY': ':0', 19:11:10 INFO - 'HOME': '/home/cltbld', 19:11:10 INFO - 'LANG': 'en_US.UTF-8', 19:11:10 INFO - 'LANGUAGE': 'en_US:en', 19:11:10 INFO - 'LOGNAME': 'cltbld', 19:11:10 INFO - 'MAIL': '/var/mail/cltbld', 19:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:10 INFO - 'MOZ_NO_REMOTE': '1', 19:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:10 INFO - 'NO_EM_RESTART': '1', 19:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:10 INFO - 'PWD': '/builds/slave/test', 19:11:10 INFO - 'SHELL': '/bin/bash', 19:11:10 INFO - 'SHLVL': '1', 19:11:10 INFO - 'TERM': 'linux', 19:11:10 INFO - 'TMOUT': '86400', 19:11:10 INFO - 'USER': 'cltbld', 19:11:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:10 INFO - '_': '/tools/buildbot/bin/python'} 19:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:11 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 INFO - Downloading docopt-0.6.1.tar.gz 19:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:13 INFO - Running setup.py install for blobuploader 19:11:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:13 INFO - Running setup.py install for requests 19:11:14 INFO - Running setup.py install for docopt 19:11:14 INFO - Successfully installed blobuploader requests docopt 19:11:14 INFO - Cleaning up... 19:11:14 INFO - Return code: 0 19:11:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:14 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')]} 19:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:14 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')]} 19:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:14 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:14 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 19:11:14 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 19:11:14 INFO - Using env: {'DISPLAY': ':0', 19:11:14 INFO - 'HOME': '/home/cltbld', 19:11:14 INFO - 'LANG': 'en_US.UTF-8', 19:11:14 INFO - 'LANGUAGE': 'en_US:en', 19:11:14 INFO - 'LOGNAME': 'cltbld', 19:11:14 INFO - 'MAIL': '/var/mail/cltbld', 19:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:14 INFO - 'MOZ_NO_REMOTE': '1', 19:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:14 INFO - 'NO_EM_RESTART': '1', 19:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:14 INFO - 'PWD': '/builds/slave/test', 19:11:14 INFO - 'SHELL': '/bin/bash', 19:11:14 INFO - 'SHLVL': '1', 19:11:14 INFO - 'TERM': 'linux', 19:11:14 INFO - 'TMOUT': '86400', 19:11:14 INFO - 'USER': 'cltbld', 19:11:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:14 INFO - '_': '/tools/buildbot/bin/python'} 19:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:14 INFO - Running setup.py (path:/tmp/pip-3xTFD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:14 INFO - Running setup.py (path:/tmp/pip-Bd9eu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:14 INFO - Running setup.py (path:/tmp/pip-WWKB6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:14 INFO - Running setup.py (path:/tmp/pip-Ls275x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:14 INFO - Running setup.py (path:/tmp/pip-kIA1mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:14 INFO - Running setup.py (path:/tmp/pip-GbUuUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:14 INFO - Running setup.py (path:/tmp/pip-aeQb34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:14 INFO - Running setup.py (path:/tmp/pip-AwfKve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:15 INFO - Running setup.py (path:/tmp/pip-GI4A5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:15 INFO - Running setup.py (path:/tmp/pip-k32lQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:15 INFO - Running setup.py (path:/tmp/pip-uWJojo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:15 INFO - Running setup.py (path:/tmp/pip-YPE55_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:15 INFO - Running setup.py (path:/tmp/pip-efkPft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:15 INFO - Running setup.py (path:/tmp/pip-xEVVz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:15 INFO - Running setup.py (path:/tmp/pip-5M8kE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:15 INFO - Running setup.py (path:/tmp/pip-hKBzXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:15 INFO - Running setup.py (path:/tmp/pip-ohNgUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:15 INFO - Running setup.py install for manifestparser 19:11:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:15 INFO - Running setup.py install for mozcrash 19:11:15 INFO - Running setup.py install for mozdebug 19:11:15 INFO - Running setup.py install for mozdevice 19:11:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozfile 19:11:16 INFO - Running setup.py install for mozhttpd 19:11:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozinfo 19:11:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozInstall 19:11:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozleak 19:11:16 INFO - Running setup.py install for mozlog 19:11:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for moznetwork 19:11:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozprocess 19:11:16 INFO - Running setup.py install for mozprofile 19:11:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Running setup.py install for mozrunner 19:11:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Running setup.py install for mozscreenshot 19:11:17 INFO - Running setup.py install for moztest 19:11:17 INFO - Running setup.py install for mozversion 19:11:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:17 INFO - Cleaning up... 19:11:17 INFO - Return code: 0 19:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:17 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:17 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 19:11:17 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 19:11:17 INFO - Using env: {'DISPLAY': ':0', 19:11:17 INFO - 'HOME': '/home/cltbld', 19:11:17 INFO - 'LANG': 'en_US.UTF-8', 19:11:17 INFO - 'LANGUAGE': 'en_US:en', 19:11:17 INFO - 'LOGNAME': 'cltbld', 19:11:17 INFO - 'MAIL': '/var/mail/cltbld', 19:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:17 INFO - 'MOZ_NO_REMOTE': '1', 19:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:17 INFO - 'NO_EM_RESTART': '1', 19:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:17 INFO - 'PWD': '/builds/slave/test', 19:11:17 INFO - 'SHELL': '/bin/bash', 19:11:17 INFO - 'SHLVL': '1', 19:11:17 INFO - 'TERM': 'linux', 19:11:17 INFO - 'TMOUT': '86400', 19:11:17 INFO - 'USER': 'cltbld', 19:11:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:17 INFO - '_': '/tools/buildbot/bin/python'} 19:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:17 INFO - Running setup.py (path:/tmp/pip-ar1JRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:17 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)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:17 INFO - Running setup.py (path:/tmp/pip-JhZJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:17 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)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:17 INFO - Running setup.py (path:/tmp/pip-VjNtka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:17 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)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:17 INFO - Running setup.py (path:/tmp/pip-QjgVH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:18 INFO - Running setup.py (path:/tmp/pip-EmoHJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:18 INFO - Running setup.py (path:/tmp/pip-yPT0RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:18 INFO - Running setup.py (path:/tmp/pip-mRkgTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:18 INFO - Running setup.py (path:/tmp/pip-Y6aBnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:18 INFO - Running setup.py (path:/tmp/pip-jv9x7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:18 INFO - Running setup.py (path:/tmp/pip-LPK82s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:18 INFO - Running setup.py (path:/tmp/pip-Oiaxu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:18 INFO - Running setup.py (path:/tmp/pip-nVU9cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:18 INFO - Running setup.py (path:/tmp/pip-D_TJdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:18 INFO - Running setup.py (path:/tmp/pip-9RfCJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:18 INFO - Running setup.py (path:/tmp/pip-bL8Hb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:18 INFO - Running setup.py (path:/tmp/pip-Rzc7kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:18 INFO - Running setup.py (path:/tmp/pip-LX3gwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:18 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)) 19:11:18 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)) 19:11:18 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)) 19:11:18 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)) 19:11:18 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)) 19:11:18 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)) 19:11:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:21 INFO - Downloading blessings-1.6.tar.gz 19:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:21 INFO - Installing collected packages: blessings 19:11:21 INFO - Running setup.py install for blessings 19:11:21 INFO - Successfully installed blessings 19:11:21 INFO - Cleaning up... 19:11:21 INFO - Return code: 0 19:11:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:21 INFO - Reading from file tmpfile_stdout 19:11:21 INFO - Current package versions: 19:11:21 INFO - argparse == 1.2.1 19:11:21 INFO - blessings == 1.6 19:11:21 INFO - blobuploader == 1.2.4 19:11:21 INFO - docopt == 0.6.1 19:11:21 INFO - functools32 == 3.2.3-2 19:11:21 INFO - jsonschema == 2.5.1 19:11:21 INFO - manifestparser == 1.1 19:11:21 INFO - mozInstall == 1.12 19:11:21 INFO - mozcrash == 0.17 19:11:21 INFO - mozdebug == 0.1 19:11:21 INFO - mozdevice == 0.48 19:11:21 INFO - mozfile == 1.2 19:11:21 INFO - mozhttpd == 0.7 19:11:21 INFO - mozinfo == 0.9 19:11:21 INFO - mozleak == 0.1 19:11:21 INFO - mozlog == 3.2 19:11:21 INFO - moznetwork == 0.27 19:11:21 INFO - mozprocess == 0.22 19:11:21 INFO - mozprofile == 0.28 19:11:21 INFO - mozrunner == 6.11 19:11:21 INFO - mozscreenshot == 0.1 19:11:21 INFO - mozsystemmonitor == 0.3 19:11:21 INFO - moztest == 0.7 19:11:21 INFO - mozversion == 1.4 19:11:21 INFO - psutil == 3.1.1 19:11:21 INFO - requests == 1.2.3 19:11:21 INFO - wsgiref == 0.1.2 19:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:21 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')]} 19:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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')]} 19:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:21 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 19:11:21 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 19:11:21 INFO - Using env: {'DISPLAY': ':0', 19:11:21 INFO - 'HOME': '/home/cltbld', 19:11:21 INFO - 'LANG': 'en_US.UTF-8', 19:11:21 INFO - 'LANGUAGE': 'en_US:en', 19:11:21 INFO - 'LOGNAME': 'cltbld', 19:11:21 INFO - 'MAIL': '/var/mail/cltbld', 19:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:21 INFO - 'MOZ_NO_REMOTE': '1', 19:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:21 INFO - 'NO_EM_RESTART': '1', 19:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:21 INFO - 'PWD': '/builds/slave/test', 19:11:21 INFO - 'SHELL': '/bin/bash', 19:11:21 INFO - 'SHLVL': '1', 19:11:21 INFO - 'TERM': 'linux', 19:11:21 INFO - 'TMOUT': '86400', 19:11:21 INFO - 'USER': 'cltbld', 19:11:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:21 INFO - '_': '/tools/buildbot/bin/python'} 19:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 INFO - Cleaning up... 19:11:21 INFO - Return code: 0 19:11:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:21 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')]} 19:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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')]} 19:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:21 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 19:11:21 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 19:11:21 INFO - Using env: {'DISPLAY': ':0', 19:11:21 INFO - 'HOME': '/home/cltbld', 19:11:21 INFO - 'LANG': 'en_US.UTF-8', 19:11:21 INFO - 'LANGUAGE': 'en_US:en', 19:11:21 INFO - 'LOGNAME': 'cltbld', 19:11:21 INFO - 'MAIL': '/var/mail/cltbld', 19:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:21 INFO - 'MOZ_NO_REMOTE': '1', 19:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:21 INFO - 'NO_EM_RESTART': '1', 19:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:21 INFO - 'PWD': '/builds/slave/test', 19:11:21 INFO - 'SHELL': '/bin/bash', 19:11:21 INFO - 'SHLVL': '1', 19:11:21 INFO - 'TERM': 'linux', 19:11:21 INFO - 'TMOUT': '86400', 19:11:21 INFO - 'USER': 'cltbld', 19:11:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:21 INFO - '_': '/tools/buildbot/bin/python'} 19:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:21 INFO - Cleaning up... 19:11:21 INFO - Return code: 0 19:11:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11:21 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')]} 19:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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')]} 19:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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 0x7fc6d74d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, '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': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', '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 19:11:21 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 19:11:21 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 19:11:22 INFO - Using env: {'DISPLAY': ':0', 19:11:22 INFO - 'HOME': '/home/cltbld', 19:11:22 INFO - 'LANG': 'en_US.UTF-8', 19:11:22 INFO - 'LANGUAGE': 'en_US:en', 19:11:22 INFO - 'LOGNAME': 'cltbld', 19:11:22 INFO - 'MAIL': '/var/mail/cltbld', 19:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:22 INFO - 'MOZ_NO_REMOTE': '1', 19:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:22 INFO - 'NO_EM_RESTART': '1', 19:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:22 INFO - 'PWD': '/builds/slave/test', 19:11:22 INFO - 'SHELL': '/bin/bash', 19:11:22 INFO - 'SHLVL': '1', 19:11:22 INFO - 'TERM': 'linux', 19:11:22 INFO - 'TMOUT': '86400', 19:11:22 INFO - 'USER': 'cltbld', 19:11:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:22 INFO - '_': '/tools/buildbot/bin/python'} 19:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:22 INFO - Downloading/unpacking flake8 19:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:24 INFO - no previously-included directories found matching 'docs/_build' 19:11:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:24 INFO - Running setup.py install for pep8 19:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:25 INFO - no previously-included directories found matching 'docs/_build' 19:11:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:11:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:25 INFO - Cleaning up... 19:11:25 INFO - Return code: 0 19:11:25 INFO - Running post-action listener: _resource_record_post_action 19:11:25 INFO - Running post-action listener: _start_resource_monitoring 19:11:25 INFO - Starting resource monitoring. 19:11:25 INFO - ##### 19:11:25 INFO - ##### Finished create-virtualenv step (success) 19:11:25 INFO - ##### 19:11:25 INFO - ##### 19:11:25 INFO - ##### Running install step. 19:11:25 INFO - ##### 19:11:25 INFO - Running pre-action listener: _resource_record_pre_action 19:11:25 INFO - Running main action method: install 19:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:25 INFO - Reading from file tmpfile_stdout 19:11:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:25 INFO - Reading from file tmpfile_stdout 19:11:25 INFO - Output received: 19:11:25 INFO - Usage: mozinstall [options] installer 19:11:25 INFO - Options: 19:11:25 INFO - -h, --help show this help message and exit 19:11:25 INFO - -d DEST, --destination=DEST 19:11:25 INFO - Directory to install application into. [default: 19:11:25 INFO - "/builds/slave/test"] 19:11:25 INFO - --app=APP Application being installed. [default: firefox] 19:11:25 INFO - mkdir: /builds/slave/test/build/application 19:11:25 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'] 19:11:25 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 19:11:42 INFO - Reading from file tmpfile_stdout 19:11:42 INFO - Output received: 19:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:42 INFO - Running post-action listener: _resource_record_post_action 19:11:42 INFO - ##### 19:11:42 INFO - ##### Finished install step (success) 19:11:42 INFO - ##### 19:11:42 INFO - ##### 19:11:42 INFO - ##### Running run-tests step. 19:11:42 INFO - ##### 19:11:42 INFO - Running pre-action listener: _resource_record_pre_action 19:11:42 INFO - Running main action method: run_tests 19:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:42 INFO - Python 2.7.3 19:11:42 INFO - Return code: 0 19:11:42 INFO - grabbing minidump binary from tooltool 19:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:42 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 0x2794e20>, '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 0x27983a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2798830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:42 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 19:11:42 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 19:11:42 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 19:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:42 INFO - Return code: 0 19:11:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:11:43 INFO - Return code: 0 19:11:43 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/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:11:43 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/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test', 19:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:43 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/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:11:43 INFO - mozversion application_buildid: 20160605163003 19:11:43 INFO - mozversion application_changeset: e54065dbe41dc0192f5d1710ad1ba5855f573545 19:11:43 INFO - mozversion application_display_name: Nightly 19:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:43 INFO - mozversion application_name: Firefox 19:11:43 INFO - mozversion application_remotingname: firefox 19:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:43 INFO - mozversion application_vendor: Mozilla 19:11:43 INFO - mozversion application_version: 49.0a1 19:11:43 INFO - mozversion platform_buildid: 20160605163003 19:11:43 INFO - mozversion platform_changeset: e54065dbe41dc0192f5d1710ad1ba5855f573545 19:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:43 INFO - mozversion platform_version: 49.0a1 19:11:43 INFO - using testdate: 1465179103 19:11:43 INFO - actual date: 1465179103 19:11:43 INFO - starting webserver on 'localhost:57979' 19:11:43 INFO - SUITE-START | Running 2 tests 19:11:43 INFO - TEST-START | dromaeo_css 19:11:43 INFO - operating with platform_type : linux_ 19:11:43 INFO - Initialising browser for dromaeo_css test... 19:11:43 INFO - TEST-INFO | started process 14536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEnmFf/profile http://localhost:57979/getInfo.html) 19:11:48 INFO - PROCESS | 14536 | __metrics Screen width/height:1600/1200 19:11:48 INFO - PROCESS | 14536 | colorDepth:24 19:11:48 INFO - PROCESS | 14536 | Browser inner width/height: 1024/697 19:11:48 INFO - PROCESS | 14536 | __metrics 19:11:48 ERROR - PROCESS | 14536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 19:11:49 INFO - TEST-INFO | 14536: exit 0 19:11:49 INFO - Browser initialized. 19:11:49 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:49 INFO - TEST-INFO | started process 14658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEnmFf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:01 INFO - PROCESS | 14658 | RSS: Main: 167432192 19:12:01 INFO - PROCESS | 14658 | 19:12:51 INFO - PROCESS | 14658 | 1465179171123 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] 19:14:58 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57979/tests/dromaeo/cssquery-ext.html) 19:14:59 INFO - PROCESS | 14658 | RSS: Main: 170930176 19:14:59 INFO - PROCESS | 14658 | 19:18:01 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-ext.html (next: http://localhost:57979/tests/dromaeo/cssquery-jquery.html) 19:18:02 INFO - PROCESS | 14658 | RSS: Main: 170041344 19:18:02 INFO - PROCESS | 14658 | 19:21:04 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57979/tests/dromaeo/cssquery-mootools.html) 19:21:05 INFO - PROCESS | 14658 | RSS: Main: 171511808 19:21:05 INFO - PROCESS | 14658 | 19:24:06 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57979/tests/dromaeo/cssquery-prototype.html) 19:24:07 INFO - PROCESS | 14658 | RSS: Main: 169287680 19:24:07 INFO - PROCESS | 14658 | 19:27:09 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57979/tests/dromaeo/cssquery-yui.html) 19:27:10 INFO - PROCESS | 14658 | RSS: Main: 170622976 19:27:10 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-yui.html (next: http://localhost:57979/tests/dromaeo/cssquery-dojo.html) 19:30:13 INFO - PROCESS | 14658 | RSS: Main: 172294144 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | __start_tp_report 19:30:13 INFO - PROCESS | 14658 | _x_x_mozilla_page_load 19:30:13 INFO - PROCESS | 14658 | _x_x_mozilla_page_load_details 19:30:13 INFO - PROCESS | 14658 | |i|pagename|runs| 19:30:13 INFO - PROCESS | 14658 | |0;dojo.html;3133.8903138390156;3152.29073458472;3176.6029246344206;3177.904662860114;3200.471922132847;5380.05848976429;5380.757865896035;5441.646292990958;5485.396606373306;5509.889802203954;5400.486953739398;5458.972705136469;5520.889582208353;5540.833774986747;5564.443555644433;4972.179590367594;5004.924926126111;5112.693238405707;5153.304303918979;5203.843884683465;719.6604450407921;4931.211006239003;4978.726170060645;5105.5660268877;5140.640155189139;5004.249362595603;5007.674501157431;5038.974805125988;5040.59675225981;5054.115529782292;5065.822696205615;5077.949220507785;5079.720615366154;5082.822101226477;5096.388433388017;4950.603951683893;4997.075541024922;5007.524285192901;5023.673461225008;5037.345145131146;5417.431169727161;5437.075697131497;5453.509184173404;5490.066688662937;5514.696691681956;5701.515371193454;5839.503642190419;5893.499052580536;5893.852653683649;5894.351621321651;5929.9703501482645;5972.790952316648;5973.701314934279;5977.970110149465;6045.576809623328;5536;5553.444655534414;5555.416681248451;5568.443155684439;5581.748821303092;5920.052791553331;5994.880102397928;6020.488258498077;6095.420935011167;6118.755249789959;5771.884562308815;5774.249347584787;5789.94210057894;5801.9419805802245;5812.041013232853;5953.255843019622;5964.5526585505395;5967.075103358986;5974.641521508724;5982.49148822355;5838.591298609142;5838.649681019152;5855.268091488564;5864.824055278348;5944.762209511571;5829.795957141479;5870.207521984563;5890.8821823563285;5941.70291485424;5951.851203719855;4377.9781101094295;4417.315316126005;4453.643708503312;4468.151051300242;4506.459224893034;3908.5309762828642;3940.2316548273384;3952.7628342299554;3979.0251388410024;4003.279409706281;5537.418571050062;5565.1095824667855;5607.551395888319;5629.211910332557;5658.886822263532;5813.389594092644;5948.196993405835;5954.225950626477;5959.135925290895;5996.5202783777195;5579.581531385163;5643.830685079454;5645.915311270334;5656.717164141776;5671.659700417906;5044.243363495505;5098.796048158107;5112.335396398445;5131.230315452712;5165.121929271958;6049;6093.4440451109185;6184.288806787277;6193.907091393633;6199.411055949678;5966.492848107872;6021.006533922029;6024.487918526975;6031.09533569968;6074.331823499323;6165.565672796567;6220.346863579259;6229.750809967551;6232.314445411092;6245.594036387621;5723.570732195185;5828.271466066742;5866.911996319973;5879.235699359056;5958.612690175298;6039.516838652809;6042.577019608585;6064.484518815773;6067.726952287069;6112.419320164578;5867.882642347215;5908.940910590839;5912.408759124225;5919.733611987557;5924.763009479572;5614.326280846324;5684.289463817023;5700.657960522382;5747.224124743107;5815.302163740378;5651.519620832275;5659.066254068197;5689.971550142222;5693.174489699053;5727.656340619576;5804.5356371491025;5820.912686309794;5827.79602713903;5843;5867.647941123546;5555.194496797861;5557.944420555905;5631.7184140793615;5680.460356266148;5716.685582292847 19:30:13 INFO - PROCESS | 14658 | |1;ext.html;564.7853815550093;619.987600247995;623.4949690750492;644.6905485367025;657.4838751580011;41116.58883411165;42078.15843683128;45045.999999999956;45143.77428112855;45584;45506;46418.76790616051;46575;46630.53369466304;46647.533524664745;8458.069612342653;8477.66089356425;8529.275011624019;8534.317254619615;8566.486010839339;8808.207261346477;8908.599113039929;8932.8660070099;8945.507997060158;8945.95527022364;8895.777605559848;8919.464832110094;8967;9026.593803278836;9043.773905652346;8758.605862736193;8883;8935.151160639729;8947.060558641346;8963.910360896372;8732.345074119467;8818.779530511725;8869.201771840566;8887.289016878634;8887.333449991276;42941.35587966183;43030.78484607588;43183;43251.351229731576;43416.348754768704;3413.675700808444;3484.9303013939834;3554.662307080823;3863.2466668999555;3917.0599056226583;32661.835581290597;33013.17467063342;33257.6674233257;33323.83338083318;33431.85091780836;4387.978060109711;4401.22978478765;4415.249407600716;4494.505604383515;4500.321665278597;338779;338986;339953;340097;340326;58472.70763646239;59484;59659;59664.403355965886;59668.40331596629;36082.8195859019;36598.8170059148;37007;56296.155557666665;57114;17320.220590073477;17449.389271375694;17468;17532.123393830258;17712.114394280492;12203.572874949334;12358.814617780741;12361.443735031946;12378.381080945917;12463.376831158406;19859.404217873485;19910;19927.900360498104;20131.496712582302;20144.89927550353;7230.517079410799;7289.963550182215;7358.227386124487;7443.255674432514;7456.440766942501;954.188939401517;1025.600015993763;1058.142904247562;1100.834874768775;1105.7567335186245;32734.345313093603;33166.33667326688;33566.3286734264;33849.32301353959;33889.98330050102;1104.5471356743858;1112.6328311657135;1128.2553514680435;1133.4162906103363;1199.508201637342;16830;17515.36587906704;17621.295148194185;17778.111094445227;17818.554536136442;153249.23375383051;849992;872752.1811954752;873994;879207;59416;59515.40484595185;60140.39859601348;60291;60448;1401.7967394727707;1432.9825823665315;1436.095259986202;1447.4355001549404;1448.7754398068316;31172.68827311698;32935.34129317352;33582.49626255657;33598.83200583982;34207.14482137966;52808.73595631997;53215.20177197268;53462.73268633632;53634.73182634062;53678;453163;465436;466651;466703;467928;28934.276643084093;29171.124866254046;29610.259743506584;29651.110466686034;29689.554656679735;49097;49270.26094608512;49763.75118124531;50427.243591345425;50484;40161.39757903575;41919;42320.788396057826;42958.78520607377;43668.344974824766;41231.58768412397;41725.582744173385;42369.576304237795;42409.151816964106;42465.787671061444;35580.82209588936;39396.60603394044;40621.39067914043;40703.59296407116;41598.584014159474;33441.83279083589;36052.87781958571;36154.8192259037;36490.635093649784;36948.81525592462;27523.449531009668;27703.168904932885;28083.438331232854;28175;28210 19:30:13 INFO - PROCESS | 14658 | |2;jquery.html;398.3168865395846;400.50937601438244;403.8505752871438;405.8518640696146;420.0946959302702;18213.18040688169;18996.33512827051;19541.316053938113;19664.606707865834;19728.112234949425;18406.263749450005;18892.81107188931;18975.102489751018;18985.810141898575;19057.237710491598;5489.945100549004;5567.693776842272;5597.3003374578175;5733.082706766918;5745.195672605839;5627.409122042188;5645.491905728483;5655.953648575027;5666.688332141731;5670.121131224667;5334.333208348957;5596.860078498029;5607.971960140194;5627.831165065055;5700.657960522382;5643.4074422185695;5661.801836935708;5689.829305120832;6381.138546296237;6424.196975378078;5748.770049198027;5757.884842303172;5780.479756821906;5782.595218334718;5793.333766616809;14917.925410372987;21922.4519387015;22584.66123008156;22917.656235156486;23034.308970730905;2170.077716970297;2232.5311684546264;2253.8422310438277;2288.599495088353;2386.0813586769045;10150.28947973642;10264.332818366782;10313.432761198206;10409.739756506073;10519.421431821247;1938.4378530226218;1948.902554872265;1973.8716983396178;1977.6736838421643;1991.9004049797597;75004.62497687477;78247.21752782514;78373.21626783774;78899.21100788975;78991;10669.626563070255;11072.837352078077;11271.211015228855;11301;11321.094312455149;15589.922050389901;15609.843901561066;15684.451044213398;15710.9214453927;15774.211289435483;8144.226298501633;8249.092599814016;8249.216324449168;8271;8564.785880352916;7854.567998760009;7936.920630793734;7941.76174714748;8140.552269625109;8152.4293299469655;4681.531846815291;4854.126257273654;4863.221884498464;4878.146324393288;4961.70229786214;1957.1211636828518;1977.1893523655233;1979.8911059891843;2028.7362642856335;2044.9693254601193;940.7507010642186;942.6747772018642;1026.9383836969805;1061.0715623829149;1091.7598128411737;18571.82479148931;18940;19274.32539861126;19302.32441864528;19612.411627651192;941.1905761045496;1012.9566546457161;1016.867807185076;1020.7550187954837;1035.1925498111484;10460.372377657364;10753.51609177589;10813.83779243312;10843.132549396028;10871.402072886067;179382;436474;450828;464168;466088;56448.15327770087;84433;90743;93758.53120734352;94441;1022.4632068164274;1049.4070849969742;1087.9292845964987;1088.6244245735209;1089.0525243038448;17834.10829458548;17970.640587188445;18191.45425637233;18329.90835045816;18391.448256552325;43204.35193472038;43533.34699979566;43755.34366984434;43756.12487750291;43897.78051109724;57649.135262971926;58561;58740.70629646824;59844.70077649584;59889;7653.425993050432;7728.4590078693955;8037.477563958324;8185.281090970725;8767.780805479659;13134.211947283193;13559.796603050765;13619.387127579084;13707.109037912503;13906.304684765924;5854.004819180835;9671.661491847752;11601.303921764722;11882.28706277626;12144.939275303566;11427.257228280136;11749;11907;11942.701432464259;11980.580679676517;8851.911480885108;11749.355090287538;11810.586629467927;12170.14808963364;12381.62855114348;8003.6398362075015;8007.599620019092;8102.554359510284;8212.83574328522;8257.38069644791;10371.896281037092;11615.76768464609;11675.591354302558;11851.111166662362;12042.397880105784 19:30:13 INFO - PROCESS | 14658 | |3;mootools.html;1497.7977972973645;1520.7110648976695;1670.3402156148322;1815.8728888977778;1821.581036361636;8067.717629882955;8673.17604827541;8693;9250.814983700322;9254.768630784225;8935.687250946217;8941.329400294988;8969.19277265046;8987.505687187202;8997.145271199242;2343.250159948813;2380.5952987991996;2382.1305223593436;2382.761723827612;2385.034061205206;2336.5794157051723;2338.5206032763326;2385.0340612052146;2391;2392.4138586046442;2334.3463830127594;2346.249200255919;2354.3996280948336;2359.0563774490256;2371.727251366098;2268;2305.342977251492;2306.4810417656063;2308.953820923589;2333.4866329407505;2262.694536237603;2272.1933713531625;2295.254042436215;2295.6570406312326;2302.8503147295373;8912.8663070054;8927.732168034969;8970.192682658528;9000.684976025874;9014.59434325457;5112.897742045138;5229.424763276036;5293.57651387888;5309.62832601718;5362.785488580452;3296.3736889990823;3355.5470011548373;3399;3502.08945674124;3511.157322242643;1126.1553834624033;1168.0655475619556;1174.6593487888501;1200.0939290835452;1200.519792083165;12689.873101268962;12731.363431828371;12738.80891786624;12744.107912446132;12755.617331479978;4565.954340456619;4651.488336283006;4744.0037592105355;4755.358026666425;4763.833265835679;10583.682489525327;10610.734731631772;10620.203484738675;10622.575096996188;10636.095931845879;5299;5305.787768489217;5323.600729945269;5341.145416733304;5359.249705041298;4276.294411422081;4799;4933.28467372229;4959.355283813081;4965.205567109318;4113.030925157238;4118.444010058603;4146.067134894624;4148.709590328708;4176.540580536139;1294.0618051912477;1294.9935250323688;1312.343828085957;1324.6820763016806;1325.6221976736583;809.9392545559107;905.307439808547;913.5477938420524;925.9721708903112;946.5929650250321;5606.971965140148;5614.63504872182;5806.593538452268;5856.824295271149;5924.437178468039;901.0177609259655;909.7998440343114;917.6237742525666;955.0640372435053;980.1081016275156;3835.9041023974064;3901.180752042046;3930.606939306104;3939.763614183101;4007.8797636070963;10931.781364372668;11289.63827036636;11350.94324528372;11450.083993280517;11478.942605287088;10984.780304393867;11270.605528806453;11303.095752339794;11366.659000230007;11412.258203216765;8367.330613550901;8469.40714150016;8537.573121343908;8546.188112129337;8561;5606.187102870143;5667.489925906688;5695.345035320991;5749.8275051748515;5778.56660750437;10404.479776011018;10535.894641053492;10544.420056896945;10611.681649550526;10641.148708103488;10254.6410875619;10394.68815935493;10541.894581054092;10652.201084918817;10665.093467055387;6288.811335659938;6766.357196066366;6838.52971611106;6924.065251191226;6948.652567371712;8646.740597782076;8669.956650216709;8688.087750786077;8705.303575714055;8734.257588104829;7679;7850.685972561262;7876.6849326028605;7895.565743884142;7931;7515.511491753018;7520.323170914644;7563.357114645317;7590.734324298623;7766.844663106819;6669.899951500634;6725.932740672531;6731.865362692621;6765.391114799691;6785;4711.269753188261;4762.52374762521;4845.53967373099;4879.756012199305;4922.409310882717;4876.073546026244;4914.852554423373;4929.679570827885;4933.654644174873;5007.69953802773 19:30:13 INFO - PROCESS | 14658 | |4;prototype.html;325.4922321178961;333.69800330700707;340.1869531818953;344.9017030146407;346.6914446142932;5540.667559946401;5651.208830763686;5653.717314134292;5676.489115979561;5683.772649094031;5559.833205003846;5568.554515638749;5575.470330318623;5605.663660180392;5612.298462692163;4168.166366726652;4268.317069268917;4374.912501749979;4406.096750166224;4424.269995450747;4365.864875132456;4377.34339849022;4391.27543955247;4401.23950419833;4403.955960440387;4343.478782546099;4361;4384.758838263911;4390.868273951786;4407.471103467572;4273.914521709564;4306.6554675626185;4308.651784777304;4310.633596144316;4360.236958532244;3805.429185622179;3834.5206849143856;3842.9615703842883;3844.480995065658;3864.632859878307;5397.893431846462;5406.270153529302;5440.755166017539;5473.890522189574;5476.780928762844;4865.82969596066;4984.501549845023;4995.225740010268;4996.825111121093;5072.898542029176;5801.448862358111;5830.387809280007;5830.82507524775;5836.161609093165;5898.734556944948;4246.8301267949555;4253.553376895412;4254.7872606369865;4268.701190916637;4269.188854117708;5911.881762364772;5922.31893332268;5983.820485385445;6009.459148676597;6032.306284777263;4275.396726227665;4280.828766849291;4354.477462704433;4361.956380436219;4366.8034938427845;4407.184670835905;4431.313146462304;4433.7118087324225;4440.533743956903;4459.955400445954;4603.861884143481;4868.95131048692;4912.845481311889;4914.975425122851;4982.227754698028;5896.852578685567;5920.661338771161;5925.614835035709;5935.881282374328;5940.851478713067;1467.8404060792068;1470.7352676518115;1482.7108713800922;1491.8806495480335;1498.1086253679043;923.50592433048;944.8850356579302;968.0319680319681;993.4039576254189;995.5663844064524;5568.6658800472105;5615.887682246333;5645.463680950304;5661.264035675418;5686.886262274731;5966.940330596639;6000.939990600125;6039.033754599331;6050.487378155462;6131.601445906002;5455.890882182334;5574.101467237014;5592.86017849557;5639.351474580476;5642.492175704124;3206.486962086055;3222.6616205298574;3222.8710851565675;3230.596175478065;3232.7575431842706;6013.248343957005;6095.146679464879;6139.907901381483;6186.783462578788;6199.194104766351;6050.878982420327;6056.546428857131;6062.514998800086;6098.969505152446;6131.877362452726;6136.207702327812;6185.876282474325;6201.782937597252;6246.220431907757;6257.561970662101;5863.237779088691;6051.455369016633;6058.666773327333;6072.1498990140535;6076.179715738319;5804.100364443518;5871.2073870027;5946.821595352147;6007.219061521974;6009.579329446897;6099.237595300588;6133.631982080911;6193;6201.643375517275;6217;4226.704130710821;4242.618164365222;4256.616904478612;4266.445362102907;4270.893227669333;6011.519078473799;6030.185924900258;6057.878842423039;6069.177832307998;6109.725062372293;5529.751161197675;5877.23595932526;5914.201582786269;5923.4076592340425;5927.644341339534;5839.299284085937;5841;5858.619189752652;5877.000909845251;5906.173135761082;5516.9448305516435;5609;5710.600257981901;5741.16753070794;5752.9712351437975;5782.971085144547;5884.352721200579;5891.3224979126235;5945.167676525203;5945.970270148795;5596.496315331639;5799.913001305068;5803.680797556006;5891.793787217427;5906.202662640489 19:30:13 INFO - PROCESS | 14658 | |5;yui.html;712.2663656433875;719.5826420676009;733.1641928201851;771.3289438188775;810.2869474862123;14890.627734306649;16092.51722448327;16140.354385824583;16170.353185872551;16333.5916602085;13930.373133209005;14023.719525609482;14028.298585070757;14043.578692639212;14049.367778449969;660.4254298760086;768.6464226455809;777.149021821105;790.6125998260868;791.8653828849081;788.8856115863197;789.0807209600808;795.8965334506506;797.1908512859452;800.2317774936068;846.6232526525698;847.2290215903529;852.3181454836138;853.2022558907411;855.4311382930343;832.1844592299519;836.506461187902;837.4431003382743;839.236294971576;839.4040231435657;608.6500262349123;612.4426771637833;612.6599737145926;612.6844674992383;614.342653360904;14257;14263.78604320936;14334.856651433456;14419.71160576793;14442.49451269211;14651;14706.558803235814;14826.184559849204;14875.553733388017;15108.54674359771;11414.315141091478;11466.312021278667;11472.71318217043;11544.653660390119;11970.521179152824;3826.8660596879254;3869.613038696136;3917.373220284769;3922.213092303501;4051.0885050863612;62212;69365.3063469369;69453.65273173602;70574.2942570578;70928.6453567734;10843.1867609928;11003.779924401468;11040.944795275973;11268.492917818718;11474.311541307548;22104;22173.22393716212;22188.334349969526;22199.223027194294;22215.11139554432;7991.800204994805;8270.421070525126;8401.831963360699;8771.736847894574;8822.558872056372;4488.528704486047;4532.161550113174;4563.292689633112;4661.976690116596;4770.880727981758;3465.7747246428903;3515.1036485695986;3578.767380120336;3587.2466781975554;3594.155373487228;621.0311913415087;624.9343818899041;625.627751487864;638.2914964389524;640.724488469953;564.5596434780878;603.3785201242727;628;657.1227411405731;663.7909058646511;8517.276031537265;8703.173198546128;8860.822783544292;9011.63953441855;9029.503377314311;642.7075680565425;661.2329697550817;665.2084020016165;689.689639662154;690.5994523176546;4061.086255592468;4089.754614723126;4198.832046718158;4234.237837189336;4273.081287523135;69979;103744;108343.45828270966;110488.4475577633;114411;82780;94900.52549737207;94998.52500737453;96762.51618741862;97064;86414.56792715997;87279;87800.12199878047;88319.55840220886;88671.55664221638;8188.672453101809;8206.712765053195;8299.543525106177;8332.875006874781;8360.581970901309;50934.906509348766;50989.745051274505;51601.48398515967;51892.740536297075;52643.21035184398;66959;77488;77557.61221193858;77558;77924;10848.620298289521;10894.455277236266;11066.170037247077;11143.2199746017;11145;11980.341081240615;12033.518659253532;12278;12437.315947622968;12777.552785652457;11454.94272528632;11520;11597.13021523406;11939.641810745692;12052.75894482123;11506.942465287955;11507.884921150682;11642.417879105842;11822.290662560274;12242.387880605756;11102.2783519071;11751.529938802694;11940.820887686865;12140.939295303468;12618.242905425705;10579.312344697877;10604.363738175734;10904.781904362027;11113.277636953571;11254.718632034264;10800.837987430037;11132.332060076422;11177.720556985814;11186.04918581897;11258.155638326994 19:30:13 INFO - PROCESS | 14658 | __end_tp_report 19:30:13 INFO - PROCESS | 14658 | __start_cc_report 19:30:13 INFO - PROCESS | 14658 | _x_x_mozilla_cycle_collect,348 19:30:13 INFO - PROCESS | 14658 | __end_cc_report 19:30:13 INFO - PROCESS | 14658 | __startTimestamp1465180213537__endTimestamp 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | ------- Summary: start ------- 19:30:13 INFO - PROCESS | 14658 | Number of tests: 6 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#0] dojo.html Cycles:165 Average:5473.78 Median:5689.97 stddev:744.11 (13.1%) stddev-sans-first:723.40 19:30:13 INFO - PROCESS | 14658 | Values: 3133.9 3152.3 3176.6 3177.9 3200.5 5380.1 5380.8 5441.6 5485.4 5509.9 5400.5 5459.0 5520.9 5540.8 5564.4 4972.2 5004.9 5112.7 5153.3 5203.8 719.7 4931.2 4978.7 5105.6 5140.6 5004.2 5007.7 5039.0 5040.6 5054.1 5065.8 5077.9 5079.7 5082.8 5096.4 4950.6 4997.1 5007.5 5023.7 5037.3 5417.4 5437.1 5453.5 5490.1 5514.7 5701.5 5839.5 5893.5 5893.9 5894.4 5930.0 5972.8 5973.7 5978.0 6045.6 5536.0 5553.4 5555.4 5568.4 5581.7 5920.1 5994.9 6020.5 6095.4 6118.8 5771.9 5774.2 5789.9 5801.9 5812.0 5953.3 5964.6 5967.1 5974.6 5982.5 5838.6 5838.6 5855.3 5864.8 5944.8 5829.8 5870.2 5890.9 5941.7 5951.9 4378.0 4417.3 4453.6 4468.2 4506.5 3908.5 3940.2 3952.8 3979.0 4003.3 5537.4 5565.1 5607.6 5629.2 5658.9 5813.4 5948.2 5954.2 5959.1 5996.5 5579.6 5643.8 5645.9 5656.7 5671.7 5044.2 5098.8 5112.3 5131.2 5165.1 6049.0 6093.4 6184.3 6193.9 6199.4 5966.5 6021.0 6024.5 6031.1 6074.3 6165.6 6220.3 6229.8 6232.3 6245.6 5723.6 5828.3 5866.9 5879.2 5958.6 6039.5 6042.6 6064.5 6067.7 6112.4 5867.9 5908.9 5912.4 5919.7 5924.8 5614.3 5684.3 5700.7 5747.2 5815.3 5651.5 5659.1 5690.0 5693.2 5727.7 5804.5 5820.9 5827.8 5843.0 5867.6 5555.2 5557.9 5631.7 5680.5 5716.7 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#1] ext.html Cycles:180 Average:66048.26 Median:42389.36 stddev:150974.42 (356.2%) stddev-sans-first:151317.88 19:30:13 INFO - PROCESS | 14658 | Values: 564.8 620.0 623.5 644.7 657.5 41116.6 42078.2 45046.0 45143.8 45584.0 45506.0 46418.8 46575.0 46630.5 46647.5 8458.1 8477.7 8529.3 8534.3 8566.5 8808.2 8908.6 8932.9 8945.5 8946.0 8895.8 8919.5 8967.0 9026.6 9043.8 8758.6 8883.0 8935.2 8947.1 8963.9 8732.3 8818.8 8869.2 8887.3 8887.3 42941.4 43030.8 43183.0 43251.4 43416.3 3413.7 3484.9 3554.7 3863.2 3917.1 32661.8 33013.2 33257.7 33323.8 33431.9 4388.0 4401.2 4415.2 4494.5 4500.3 338779.0 338986.0 339953.0 340097.0 340326.0 58472.7 59484.0 59659.0 59664.4 59668.4 36082.8 36598.8 37007.0 56296.2 57114.0 17320.2 17449.4 17468.0 17532.1 17712.1 12203.6 12358.8 12361.4 12378.4 12463.4 19859.4 19910.0 19927.9 20131.5 20144.9 7230.5 7290.0 7358.2 7443.3 7456.4 954.2 1025.6 1058.1 1100.8 1105.8 32734.3 33166.3 33566.3 33849.3 33890.0 1104.5 1112.6 1128.3 1133.4 1199.5 16830.0 17515.4 17621.3 17778.1 17818.6 153249.2 849992.0 872752.2 873994.0 879207.0 59416.0 59515.4 60140.4 60291.0 60448.0 1401.8 1433.0 1436.1 1447.4 1448.8 31172.7 32935.3 33582.5 33598.8 34207.1 52808.7 53215.2 53462.7 53634.7 53678.0 453163.0 465436.0 466651.0 466703.0 467928.0 28934.3 29171.1 29610.3 29651.1 29689.6 49097.0 49270.3 49763.8 50427.2 50484.0 40161.4 41919.0 42320.8 42958.8 43668.3 41231.6 41725.6 42369.6 42409.2 42465.8 35580.8 39396.6 40621.4 40703.6 41598.6 33441.8 36052.9 36154.8 36490.6 36948.8 27523.4 27703.2 28083.4 28175.0 28210.0 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#2] jquery.html Cycles:180 Average:26175.64 Median:12436.63 stddev:68786.99 (553.1%) stddev-sans-first:68952.73 19:30:13 INFO - PROCESS | 14658 | Values: 398.3 400.5 403.9 405.9 420.1 18213.2 18996.3 19541.3 19664.6 19728.1 18406.3 18892.8 18975.1 18985.8 19057.2 5489.9 5567.7 5597.3 5733.1 5745.2 5627.4 5645.5 5656.0 5666.7 5670.1 5334.3 5596.9 5608.0 5627.8 5700.7 5643.4 5661.8 5689.8 6381.1 6424.2 5748.8 5757.9 5780.5 5782.6 5793.3 14917.9 21922.5 22584.7 22917.7 23034.3 2170.1 2232.5 2253.8 2288.6 2386.1 10150.3 10264.3 10313.4 10409.7 10519.4 1938.4 1948.9 1973.9 1977.7 1991.9 75004.6 78247.2 78373.2 78899.2 78991.0 10669.6 11072.8 11271.2 11301.0 11321.1 15589.9 15609.8 15684.5 15710.9 15774.2 8144.2 8249.1 8249.2 8271.0 8564.8 7854.6 7936.9 7941.8 8140.6 8152.4 4681.5 4854.1 4863.2 4878.1 4961.7 1957.1 1977.2 1979.9 2028.7 2045.0 940.8 942.7 1026.9 1061.1 1091.8 18571.8 18940.0 19274.3 19302.3 19612.4 941.2 1013.0 1016.9 1020.8 1035.2 10460.4 10753.5 10813.8 10843.1 10871.4 179382.0 436474.0 450828.0 464168.0 466088.0 56448.2 84433.0 90743.0 93758.5 94441.0 1022.5 1049.4 1087.9 1088.6 1089.1 17834.1 17970.6 18191.5 18329.9 18391.4 43204.4 43533.3 43755.3 43756.1 43897.8 57649.1 58561.0 58740.7 59844.7 59889.0 7653.4 7728.5 8037.5 8185.3 8767.8 13134.2 13559.8 13619.4 13707.1 13906.3 5854.0 9671.7 11601.3 11882.3 12144.9 11427.3 11749.0 11907.0 11942.7 11980.6 8851.9 11749.4 11810.6 12170.1 12381.6 8003.6 8007.6 8102.6 8212.8 8257.4 10371.9 11615.8 11675.6 11851.1 12042.4 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#3] mootools.html Cycles:180 Average:5839.69 Median:4758.94 stddev:3396.57 (71.4%) stddev-sans-first:3390.42 19:30:13 INFO - PROCESS | 14658 | Values: 1497.8 1520.7 1670.3 1815.9 1821.6 8067.7 8673.2 8693.0 9250.8 9254.8 8935.7 8941.3 8969.2 8987.5 8997.1 2343.3 2380.6 2382.1 2382.8 2385.0 2336.6 2338.5 2385.0 2391.0 2392.4 2334.3 2346.2 2354.4 2359.1 2371.7 2268.0 2305.3 2306.5 2309.0 2333.5 2262.7 2272.2 2295.3 2295.7 2302.9 8912.9 8927.7 8970.2 9000.7 9014.6 5112.9 5229.4 5293.6 5309.6 5362.8 3296.4 3355.5 3399.0 3502.1 3511.2 1126.2 1168.1 1174.7 1200.1 1200.5 12689.9 12731.4 12738.8 12744.1 12755.6 4566.0 4651.5 4744.0 4755.4 4763.8 10583.7 10610.7 10620.2 10622.6 10636.1 5299.0 5305.8 5323.6 5341.1 5359.2 4276.3 4799.0 4933.3 4959.4 4965.2 4113.0 4118.4 4146.1 4148.7 4176.5 1294.1 1295.0 1312.3 1324.7 1325.6 809.9 905.3 913.5 926.0 946.6 5607.0 5614.6 5806.6 5856.8 5924.4 901.0 909.8 917.6 955.1 980.1 3835.9 3901.2 3930.6 3939.8 4007.9 10931.8 11289.6 11350.9 11450.1 11478.9 10984.8 11270.6 11303.1 11366.7 11412.3 8367.3 8469.4 8537.6 8546.2 8561.0 5606.2 5667.5 5695.3 5749.8 5778.6 10404.5 10535.9 10544.4 10611.7 10641.1 10254.6 10394.7 10541.9 10652.2 10665.1 6288.8 6766.4 6838.5 6924.1 6948.7 8646.7 8670.0 8688.1 8705.3 8734.3 7679.0 7850.7 7876.7 7895.6 7931.0 7515.5 7520.3 7563.4 7590.7 7766.8 6669.9 6725.9 6731.9 6765.4 6785.0 4711.3 4762.5 4845.5 4879.8 4922.4 4876.1 4914.9 4929.7 4933.7 5007.7 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#4] prototype.html Cycles:180 Average:4935.12 Median:5640.92 stddev:1450.50 (25.7%) stddev-sans-first:1412.70 19:30:13 INFO - PROCESS | 14658 | Values: 325.5 333.7 340.2 344.9 346.7 5540.7 5651.2 5653.7 5676.5 5683.8 5559.8 5568.6 5575.5 5605.7 5612.3 4168.2 4268.3 4374.9 4406.1 4424.3 4365.9 4377.3 4391.3 4401.2 4404.0 4343.5 4361.0 4384.8 4390.9 4407.5 4273.9 4306.7 4308.7 4310.6 4360.2 3805.4 3834.5 3843.0 3844.5 3864.6 5397.9 5406.3 5440.8 5473.9 5476.8 4865.8 4984.5 4995.2 4996.8 5072.9 5801.4 5830.4 5830.8 5836.2 5898.7 4246.8 4253.6 4254.8 4268.7 4269.2 5911.9 5922.3 5983.8 6009.5 6032.3 4275.4 4280.8 4354.5 4362.0 4366.8 4407.2 4431.3 4433.7 4440.5 4460.0 4603.9 4869.0 4912.8 4915.0 4982.2 5896.9 5920.7 5925.6 5935.9 5940.9 1467.8 1470.7 1482.7 1491.9 1498.1 923.5 944.9 968.0 993.4 995.6 5568.7 5615.9 5645.5 5661.3 5686.9 5966.9 6000.9 6039.0 6050.5 6131.6 5455.9 5574.1 5592.9 5639.4 5642.5 3206.5 3222.7 3222.9 3230.6 3232.8 6013.2 6095.1 6139.9 6186.8 6199.2 6050.9 6056.5 6062.5 6099.0 6131.9 6136.2 6185.9 6201.8 6246.2 6257.6 5863.2 6051.5 6058.7 6072.1 6076.2 5804.1 5871.2 5946.8 6007.2 6009.6 6099.2 6133.6 6193.0 6201.6 6217.0 4226.7 4242.6 4256.6 4266.4 4270.9 6011.5 6030.2 6057.9 6069.2 6109.7 5529.8 5877.2 5914.2 5923.4 5927.6 5839.3 5841.0 5858.6 5877.0 5906.2 5516.9 5609.0 5710.6 5741.2 5753.0 5783.0 5884.4 5891.3 5945.2 5946.0 5596.5 5799.9 5803.7 5891.8 5906.2 19:30:13 INFO - PROCESS | 14658 | 19:30:13 INFO - PROCESS | 14658 | [#5] yui.html Cycles:180 Average:19750.32 Median:4547.73 stddev:28390.05 (624.3%) stddev-sans-first:28433.71 19:30:13 INFO - PROCESS | 14658 | Values: 712.3 719.6 733.2 771.3 810.3 14890.6 16092.5 16140.4 16170.4 16333.6 13930.4 14023.7 14028.3 14043.6 14049.4 660.4 768.6 777.1 790.6 791.9 788.9 789.1 795.9 797.2 800.2 846.6 847.2 852.3 853.2 855.4 832.2 836.5 837.4 839.2 839.4 608.7 612.4 612.7 612.7 614.3 14257.0 14263.8 14334.9 14419.7 14442.5 14651.0 14706.6 14826.2 14875.6 15108.5 11414.3 11466.3 11472.7 11544.7 11970.5 3826.9 3869.6 3917.4 3922.2 4051.1 62212.0 69365.3 69453.7 70574.3 70928.6 10843.2 11003.8 11040.9 11268.5 11474.3 22104.0 22173.2 22188.3 22199.2 22215.1 7991.8 8270.4 8401.8 8771.7 8822.6 4488.5 4532.2 4563.3 4662.0 4770.9 3465.8 3515.1 3578.8 3587.2 3594.2 621.0 624.9 625.6 638.3 640.7 564.6 603.4 628.0 657.1 663.8 8517.3 8703.2 8860.8 9011.6 9029.5 642.7 661.2 665.2 689.7 690.6 4061.1 4089.8 4198.8 4234.2 4273.1 69979.0 103744.0 108343.5 110488.4 114411.0 82780.0 94900.5 94998.5 96762.5 97064.0 86414.6 87279.0 87800.1 88319.6 88671.6 8188.7 8206.7 8299.5 8332.9 8360.6 50934.9 50989.7 51601.5 51892.7 52643.2 66959.0 77488.0 77557.6 77558.0 77924.0 10848.6 10894.5 11066.2 11143.2 11145.0 11980.3 12033.5 12278.0 12437.3 12777.6 11454.9 11520.0 11597.1 11939.6 12052.8 11506.9 11507.9 11642.4 11822.3 12242.4 11102.3 11751.5 11940.8 12140.9 12618.2 10579.3 10604.4 10904.8 11113.3 11254.7 10800.8 11132.3 11177.7 11186.0 11258.2 19:30:13 INFO - PROCESS | 14658 | -------- Summary: end -------- 19:30:13 INFO - PROCESS | 14658 | 19:30:14 INFO - TEST-INFO | 14658: exit 0 19:30:14 INFO - TEST-OK | dromaeo_css | took 1110763ms 19:30:14 INFO - TEST-START | kraken 19:30:14 INFO - operating with platform_type : linux_ 19:30:14 INFO - Initialising browser for kraken test... 19:30:14 INFO - TEST-INFO | started process 14896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WCq1N/profile http://localhost:57979/getInfo.html) 19:30:18 INFO - PROCESS | 14896 | __metrics Screen width/height:1600/1200 19:30:18 INFO - PROCESS | 14896 | colorDepth:24 19:30:18 INFO - PROCESS | 14896 | Browser inner width/height: 1024/697 19:30:18 INFO - PROCESS | 14896 | __metrics 19:30:19 ERROR - PROCESS | 14896 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 19:30:20 INFO - TEST-INFO | 14896: exit 0 19:30:20 INFO - Browser initialized. 19:30:20 INFO - Running cycle 1/1 for kraken test... 19:30:20 INFO - TEST-INFO | started process 15016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WCq1N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:31 INFO - PROCESS | 15016 | RSS: Main: 167903232 19:30:31 INFO - PROCESS | 15016 | 19:30:34 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:35 INFO - PROCESS | 15016 | RSS: Main: 172904448 19:30:35 INFO - PROCESS | 15016 | 19:30:38 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-dft) 19:30:38 INFO - PROCESS | 15016 | RSS: Main: 172724224 19:30:38 INFO - PROCESS | 15016 | 19:30:41 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-fft) 19:30:42 INFO - PROCESS | 15016 | RSS: Main: 167337984 19:30:42 INFO - PROCESS | 15016 | 19:30:44 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-oscillator) 19:30:45 INFO - PROCESS | 15016 | RSS: Main: 167960576 19:30:45 INFO - PROCESS | 15016 | 19:30:47 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:47 INFO - PROCESS | 15016 | RSS: Main: 168271872 19:30:47 INFO - PROCESS | 15016 | 19:30:51 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:51 INFO - PROCESS | 15016 | RSS: Main: 168849408 19:30:51 INFO - PROCESS | 15016 | 19:30:55 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:55 INFO - PROCESS | 15016 | RSS: Main: 166227968 19:30:55 INFO - PROCESS | 15016 | 19:30:58 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57979/tests/kraken/driver.html?testName=json-parse-financial) 19:30:59 INFO - PROCESS | 15016 | RSS: Main: 167346176 19:30:59 INFO - PROCESS | 15016 | 19:31:00 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:01 INFO - PROCESS | 15016 | RSS: Main: 167829504 19:31:01 INFO - PROCESS | 15016 | 19:31:03 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:03 INFO - PROCESS | 15016 | RSS: Main: 167862272 19:31:03 INFO - PROCESS | 15016 | 19:31:05 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:06 INFO - PROCESS | 15016 | RSS: Main: 168919040 19:31:06 INFO - PROCESS | 15016 | 19:31:09 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:09 INFO - PROCESS | 15016 | RSS: Main: 168763392 19:31:09 INFO - PROCESS | 15016 | 19:31:12 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:13 INFO - PROCESS | 15016 | RSS: Main: 168755200 19:31:13 INFO - PROCESS | 15016 | 19:31:14 INFO - PROCESS | 15016 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57979/tests/kraken/driver.html?testName=ai-astar) 19:31:15 INFO - PROCESS | 15016 | RSS: Main: 169447424 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | __start_tp_report 19:31:15 INFO - PROCESS | 15016 | _x_x_mozilla_page_load 19:31:15 INFO - PROCESS | 15016 | _x_x_mozilla_page_load_details 19:31:15 INFO - PROCESS | 15016 | |i|pagename|runs| 19:31:15 INFO - PROCESS | 15016 | |0;ai-astar;111;109;113;113;114;113;112;112;112;112 19:31:15 INFO - PROCESS | 15016 | |1;audio-beat-detection;157;126;154;175;129;155;148;127;182;130 19:31:15 INFO - PROCESS | 15016 | |2;audio-dft;163;163;162;161;163;169;166;162;162;160 19:31:15 INFO - PROCESS | 15016 | |3;audio-fft;77;75;75;152;79;77;74;76;161;76 19:31:15 INFO - PROCESS | 15016 | |4;audio-oscillator;85;85;155;85;86;85;133;85;85;149 19:31:15 INFO - PROCESS | 15016 | |5;imaging-gaussian-blur;117;118;118;117;118;117;119;117;117;117 19:31:15 INFO - PROCESS | 15016 | |6;imaging-darkroom;150;150;149;150;149;149;150;150;150;146 19:31:15 INFO - PROCESS | 15016 | |7;imaging-desaturate;96;95;95;95;96;99;95;96;96;95 19:31:15 INFO - PROCESS | 15016 | |8;json-parse-financial;55;58;57;54;55;57;59;58;55;54 19:31:15 INFO - PROCESS | 15016 | |9;json-stringify-tinderbox;61;61;69;62;64;62;61;62;62;61 19:31:15 INFO - PROCESS | 15016 | |10;stanford-crypto-aes;80;86;80;80;80;87;82;82;102;85 19:31:15 INFO - PROCESS | 15016 | |11;stanford-crypto-ccm;123;132;134;121;132;121;123;130;131;128 19:31:15 INFO - PROCESS | 15016 | |12;stanford-crypto-pbkdf2;166;163;166;165;166;163;164;161;162;167 19:31:15 INFO - PROCESS | 15016 | |13;stanford-crypto-sha256-iterative;65;68;64;63;65;65;64;63;67;63 19:31:15 INFO - PROCESS | 15016 | __end_tp_report 19:31:15 INFO - PROCESS | 15016 | __start_cc_report 19:31:15 INFO - PROCESS | 15016 | _x_x_mozilla_cycle_collect,878 19:31:15 INFO - PROCESS | 15016 | __end_cc_report 19:31:15 INFO - PROCESS | 15016 | __startTimestamp1465180275187__endTimestamp 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | ------- Summary: start ------- 19:31:15 INFO - PROCESS | 15016 | Number of tests: 14 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.37 (1.2%) stddev-sans-first:1.39 19:31:15 INFO - PROCESS | 15016 | Values: 111.0 109.0 113.0 113.0 114.0 113.0 112.0 112.0 112.0 112.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:154.50 stddev:20.17 (13.1%) stddev-sans-first:21.14 19:31:15 INFO - PROCESS | 15016 | Values: 157.0 126.0 154.0 175.0 129.0 155.0 148.0 127.0 182.0 130.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.60 (1.6%) stddev-sans-first:2.76 19:31:15 INFO - PROCESS | 15016 | Values: 163.0 163.0 162.0 161.0 163.0 169.0 166.0 162.0 162.0 160.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:33.98 (44.7%) stddev-sans-first:35.60 19:31:15 INFO - PROCESS | 15016 | Values: 77.0 75.0 75.0 152.0 79.0 77.0 74.0 76.0 161.0 76.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:85.00 stddev:29.72 (35.0%) stddev-sans-first:30.78 19:31:15 INFO - PROCESS | 15016 | Values: 85.0 85.0 155.0 85.0 86.0 85.0 133.0 85.0 85.0 149.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:31:15 INFO - PROCESS | 15016 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 119.0 117.0 117.0 117.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 19:31:15 INFO - PROCESS | 15016 | Values: 150.0 150.0 149.0 150.0 149.0 149.0 150.0 150.0 150.0 146.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 19:31:15 INFO - PROCESS | 15016 | Values: 96.0 95.0 95.0 95.0 96.0 99.0 95.0 96.0 96.0 95.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.87 19:31:15 INFO - PROCESS | 15016 | Values: 55.0 58.0 57.0 54.0 55.0 57.0 59.0 58.0 55.0 54.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:2.46 (4.0%) stddev-sans-first:2.55 19:31:15 INFO - PROCESS | 15016 | Values: 61.0 61.0 69.0 62.0 64.0 62.0 61.0 62.0 62.0 61.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:6.74 (8.2%) stddev-sans-first:6.95 19:31:15 INFO - PROCESS | 15016 | Values: 80.0 86.0 80.0 80.0 80.0 87.0 82.0 82.0 102.0 85.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:130.50 stddev:5.02 (3.8%) stddev-sans-first:5.05 19:31:15 INFO - PROCESS | 15016 | Values: 123.0 132.0 134.0 121.0 132.0 121.0 123.0 130.0 131.0 128.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:165.50 stddev:2.00 (1.2%) stddev-sans-first:2.03 19:31:15 INFO - PROCESS | 15016 | Values: 166.0 163.0 166.0 165.0 166.0 163.0 164.0 161.0 162.0 167.0 19:31:15 INFO - PROCESS | 15016 | 19:31:15 INFO - PROCESS | 15016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.70 (2.6%) stddev-sans-first:1.80 19:31:15 INFO - PROCESS | 15016 | Values: 65.0 68.0 64.0 63.0 65.0 65.0 64.0 63.0 67.0 63.0 19:31:15 INFO - PROCESS | 15016 | -------- Summary: end -------- 19:31:15 INFO - PROCESS | 15016 | 19:31:16 INFO - TEST-INFO | 15016: exit 0 19:31:16 INFO - TEST-OK | kraken | took 61917ms 19:31:16 INFO - SUITE-END | took 1172s 19:31:16 INFO - Completed test suite (00:19:32) 19:31:16 INFO - javascript benchmark 19:31:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7302.650998891322, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8903138390156, 3152.29073458472, 3176.6029246344206, 3177.904662860114, 3200.471922132847, 5380.05848976429, 5380.757865896035, 5441.646292990958, 5485.396606373306, 5509.889802203954, 5400.486953739398, 5458.972705136469, 5520.889582208353, 5540.833774986747, 5564.443555644433, 4972.179590367594, 5004.924926126111, 5112.693238405707, 5153.304303918979, 5203.843884683465, 719.6604450407921, 4931.211006239003, 4978.726170060645, 5105.5660268877, 5140.640155189139, 5004.249362595603, 5007.674501157431, 5038.974805125988, 5040.59675225981, 5054.115529782292, 5065.822696205615, 5077.949220507785, 5079.720615366154, 5082.822101226477, 5096.388433388017, 4950.603951683893, 4997.075541024922, 5007.524285192901, 5023.673461225008, 5037.345145131146, 5417.431169727161, 5437.075697131497, 5453.509184173404, 5490.066688662937, 5514.696691681956, 5701.515371193454, 5839.503642190419, 5893.499052580536, 5893.852653683649, 5894.351621321651, 5929.9703501482645, 5972.790952316648, 5973.701314934279, 5977.970110149465, 6045.576809623328, 5536.0, 5553.444655534414, 5555.416681248451, 5568.443155684439, 5581.748821303092, 5920.052791553331, 5994.880102397928, 6020.488258498077, 6095.420935011167, 6118.755249789959, 5771.884562308815, 5774.249347584787, 5789.94210057894, 5801.9419805802245, 5812.041013232853, 5953.255843019622, 5964.5526585505395, 5967.075103358986, 5974.641521508724, 5982.49148822355, 5838.591298609142, 5838.649681019152, 5855.268091488564, 5864.824055278348, 5944.762209511571, 5829.795957141479, 5870.207521984563, 5890.8821823563285, 5941.70291485424, 5951.851203719855, 4377.9781101094295, 4417.315316126005, 4453.643708503312, 4468.151051300242, 4506.459224893034, 3908.5309762828642, 3940.2316548273384, 3952.7628342299554, 3979.0251388410024, 4003.279409706281, 5537.418571050062, 5565.1095824667855, 5607.551395888319, 5629.211910332557, 5658.886822263532, 5813.389594092644, 5948.196993405835, 5954.225950626477, 5959.135925290895, 5996.5202783777195, 5579.581531385163, 5643.830685079454, 5645.915311270334, 5656.717164141776, 5671.659700417906, 5044.243363495505, 5098.796048158107, 5112.335396398445, 5131.230315452712, 5165.121929271958, 6049.0, 6093.4440451109185, 6184.288806787277, 6193.907091393633, 6199.411055949678, 5966.492848107872, 6021.006533922029, 6024.487918526975, 6031.09533569968, 6074.331823499323, 6165.565672796567, 6220.346863579259, 6229.750809967551, 6232.314445411092, 6245.594036387621, 5723.570732195185, 5828.271466066742, 5866.911996319973, 5879.235699359056, 5958.612690175298, 6039.516838652809, 6042.577019608585, 6064.484518815773, 6067.726952287069, 6112.419320164578, 5867.882642347215, 5908.940910590839, 5912.408759124225, 5919.733611987557, 5924.763009479572, 5614.326280846324, 5684.289463817023, 5700.657960522382, 5747.224124743107, 5815.302163740378, 5651.519620832275, 5659.066254068197, 5689.971550142222, 5693.174489699053, 5727.656340619576, 5804.5356371491025, 5820.912686309794, 5827.79602713903, 5843.0, 5867.647941123546, 5555.194496797861, 5557.944420555905, 5631.7184140793615, 5680.460356266148, 5716.685582292847], "value": 5423.789155934018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7853815550093, 619.987600247995, 623.4949690750492, 644.6905485367025, 657.4838751580011, 41116.58883411165, 42078.15843683128, 45045.999999999956, 45143.77428112855, 45584.0, 45506.0, 46418.76790616051, 46575.0, 46630.53369466304, 46647.533524664745, 8458.069612342653, 8477.66089356425, 8529.275011624019, 8534.317254619615, 8566.486010839339, 8808.207261346477, 8908.599113039929, 8932.8660070099, 8945.507997060158, 8945.95527022364, 8895.777605559848, 8919.464832110094, 8967.0, 9026.593803278836, 9043.773905652346, 8758.605862736193, 8883.0, 8935.151160639729, 8947.060558641346, 8963.910360896372, 8732.345074119467, 8818.779530511725, 8869.201771840566, 8887.289016878634, 8887.333449991276, 42941.35587966183, 43030.78484607588, 43183.0, 43251.351229731576, 43416.348754768704, 3413.675700808444, 3484.9303013939834, 3554.662307080823, 3863.2466668999555, 3917.0599056226583, 32661.835581290597, 33013.17467063342, 33257.6674233257, 33323.83338083318, 33431.85091780836, 4387.978060109711, 4401.22978478765, 4415.249407600716, 4494.505604383515, 4500.321665278597, 338779.0, 338986.0, 339953.0, 340097.0, 340326.0, 58472.70763646239, 59484.0, 59659.0, 59664.403355965886, 59668.40331596629, 36082.8195859019, 36598.8170059148, 37007.0, 56296.155557666665, 57114.0, 17320.220590073477, 17449.389271375694, 17468.0, 17532.123393830258, 17712.114394280492, 12203.572874949334, 12358.814617780741, 12361.443735031946, 12378.381080945917, 12463.376831158406, 19859.404217873485, 19910.0, 19927.900360498104, 20131.496712582302, 20144.89927550353, 7230.517079410799, 7289.963550182215, 7358.227386124487, 7443.255674432514, 7456.440766942501, 954.188939401517, 1025.600015993763, 1058.142904247562, 1100.834874768775, 1105.7567335186245, 32734.345313093603, 33166.33667326688, 33566.3286734264, 33849.32301353959, 33889.98330050102, 1104.5471356743858, 1112.6328311657135, 1128.2553514680435, 1133.4162906103363, 1199.508201637342, 16830.0, 17515.36587906704, 17621.295148194185, 17778.111094445227, 17818.554536136442, 153249.23375383051, 849992.0, 872752.1811954752, 873994.0, 879207.0, 59416.0, 59515.40484595185, 60140.39859601348, 60291.0, 60448.0, 1401.7967394727707, 1432.9825823665315, 1436.095259986202, 1447.4355001549404, 1448.7754398068316, 31172.68827311698, 32935.34129317352, 33582.49626255657, 33598.83200583982, 34207.14482137966, 52808.73595631997, 53215.20177197268, 53462.73268633632, 53634.73182634062, 53678.0, 453163.0, 465436.0, 466651.0, 466703.0, 467928.0, 28934.276643084093, 29171.124866254046, 29610.259743506584, 29651.110466686034, 29689.554656679735, 49097.0, 49270.26094608512, 49763.75118124531, 50427.243591345425, 50484.0, 40161.39757903575, 41919.0, 42320.788396057826, 42958.78520607377, 43668.344974824766, 41231.58768412397, 41725.582744173385, 42369.576304237795, 42409.151816964106, 42465.787671061444, 35580.82209588936, 39396.60603394044, 40621.39067914043, 40703.59296407116, 41598.584014159474, 33441.83279083589, 36052.87781958571, 36154.8192259037, 36490.635093649784, 36948.81525592462, 27523.449531009668, 27703.168904932885, 28083.438331232854, 28175.0, 28210.0], "value": 20492.866356016122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.3168865395846, 400.50937601438244, 403.8505752871438, 405.8518640696146, 420.0946959302702, 18213.18040688169, 18996.33512827051, 19541.316053938113, 19664.606707865834, 19728.112234949425, 18406.263749450005, 18892.81107188931, 18975.102489751018, 18985.810141898575, 19057.237710491598, 5489.945100549004, 5567.693776842272, 5597.3003374578175, 5733.082706766918, 5745.195672605839, 5627.409122042188, 5645.491905728483, 5655.953648575027, 5666.688332141731, 5670.121131224667, 5334.333208348957, 5596.860078498029, 5607.971960140194, 5627.831165065055, 5700.657960522382, 5643.4074422185695, 5661.801836935708, 5689.829305120832, 6381.138546296237, 6424.196975378078, 5748.770049198027, 5757.884842303172, 5780.479756821906, 5782.595218334718, 5793.333766616809, 14917.925410372987, 21922.4519387015, 22584.66123008156, 22917.656235156486, 23034.308970730905, 2170.077716970297, 2232.5311684546264, 2253.8422310438277, 2288.599495088353, 2386.0813586769045, 10150.28947973642, 10264.332818366782, 10313.432761198206, 10409.739756506073, 10519.421431821247, 1938.4378530226218, 1948.902554872265, 1973.8716983396178, 1977.6736838421643, 1991.9004049797597, 75004.62497687477, 78247.21752782514, 78373.21626783774, 78899.21100788975, 78991.0, 10669.626563070255, 11072.837352078077, 11271.211015228855, 11301.0, 11321.094312455149, 15589.922050389901, 15609.843901561066, 15684.451044213398, 15710.9214453927, 15774.211289435483, 8144.226298501633, 8249.092599814016, 8249.216324449168, 8271.0, 8564.785880352916, 7854.567998760009, 7936.920630793734, 7941.76174714748, 8140.552269625109, 8152.4293299469655, 4681.531846815291, 4854.126257273654, 4863.221884498464, 4878.146324393288, 4961.70229786214, 1957.1211636828518, 1977.1893523655233, 1979.8911059891843, 2028.7362642856335, 2044.9693254601193, 940.7507010642186, 942.6747772018642, 1026.9383836969805, 1061.0715623829149, 1091.7598128411737, 18571.82479148931, 18940.0, 19274.32539861126, 19302.32441864528, 19612.411627651192, 941.1905761045496, 1012.9566546457161, 1016.867807185076, 1020.7550187954837, 1035.1925498111484, 10460.372377657364, 10753.51609177589, 10813.83779243312, 10843.132549396028, 10871.402072886067, 179382.0, 436474.0, 450828.0, 464168.0, 466088.0, 56448.15327770087, 84433.0, 90743.0, 93758.53120734352, 94441.0, 1022.4632068164274, 1049.4070849969742, 1087.9292845964987, 1088.6244245735209, 1089.0525243038448, 17834.10829458548, 17970.640587188445, 18191.45425637233, 18329.90835045816, 18391.448256552325, 43204.35193472038, 43533.34699979566, 43755.34366984434, 43756.12487750291, 43897.78051109724, 57649.135262971926, 58561.0, 58740.70629646824, 59844.70077649584, 59889.0, 7653.425993050432, 7728.4590078693955, 8037.477563958324, 8185.281090970725, 8767.780805479659, 13134.211947283193, 13559.796603050765, 13619.387127579084, 13707.109037912503, 13906.304684765924, 5854.004819180835, 9671.661491847752, 11601.303921764722, 11882.28706277626, 12144.939275303566, 11427.257228280136, 11749.0, 11907.0, 11942.701432464259, 11980.580679676517, 8851.911480885108, 11749.355090287538, 11810.586629467927, 12170.14808963364, 12381.62855114348, 8003.6398362075015, 8007.599620019092, 8102.554359510284, 8212.83574328522, 8257.38069644791, 10371.896281037092, 11615.76768464609, 11675.591354302558, 11851.111166662362, 12042.397880105784], "value": 9129.883646503227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.7977972973645, 1520.7110648976695, 1670.3402156148322, 1815.8728888977778, 1821.581036361636, 8067.717629882955, 8673.17604827541, 8693.0, 9250.814983700322, 9254.768630784225, 8935.687250946217, 8941.329400294988, 8969.19277265046, 8987.505687187202, 8997.145271199242, 2343.250159948813, 2380.5952987991996, 2382.1305223593436, 2382.761723827612, 2385.034061205206, 2336.5794157051723, 2338.5206032763326, 2385.0340612052146, 2391.0, 2392.4138586046442, 2334.3463830127594, 2346.249200255919, 2354.3996280948336, 2359.0563774490256, 2371.727251366098, 2268.0, 2305.342977251492, 2306.4810417656063, 2308.953820923589, 2333.4866329407505, 2262.694536237603, 2272.1933713531625, 2295.254042436215, 2295.6570406312326, 2302.8503147295373, 8912.8663070054, 8927.732168034969, 8970.192682658528, 9000.684976025874, 9014.59434325457, 5112.897742045138, 5229.424763276036, 5293.57651387888, 5309.62832601718, 5362.785488580452, 3296.3736889990823, 3355.5470011548373, 3399.0, 3502.08945674124, 3511.157322242643, 1126.1553834624033, 1168.0655475619556, 1174.6593487888501, 1200.0939290835452, 1200.519792083165, 12689.873101268962, 12731.363431828371, 12738.80891786624, 12744.107912446132, 12755.617331479978, 4565.954340456619, 4651.488336283006, 4744.0037592105355, 4755.358026666425, 4763.833265835679, 10583.682489525327, 10610.734731631772, 10620.203484738675, 10622.575096996188, 10636.095931845879, 5299.0, 5305.787768489217, 5323.600729945269, 5341.145416733304, 5359.249705041298, 4276.294411422081, 4799.0, 4933.28467372229, 4959.355283813081, 4965.205567109318, 4113.030925157238, 4118.444010058603, 4146.067134894624, 4148.709590328708, 4176.540580536139, 1294.0618051912477, 1294.9935250323688, 1312.343828085957, 1324.6820763016806, 1325.6221976736583, 809.9392545559107, 905.307439808547, 913.5477938420524, 925.9721708903112, 946.5929650250321, 5606.971965140148, 5614.63504872182, 5806.593538452268, 5856.824295271149, 5924.437178468039, 901.0177609259655, 909.7998440343114, 917.6237742525666, 955.0640372435053, 980.1081016275156, 3835.9041023974064, 3901.180752042046, 3930.606939306104, 3939.763614183101, 4007.8797636070963, 10931.781364372668, 11289.63827036636, 11350.94324528372, 11450.083993280517, 11478.942605287088, 10984.780304393867, 11270.605528806453, 11303.095752339794, 11366.659000230007, 11412.258203216765, 8367.330613550901, 8469.40714150016, 8537.573121343908, 8546.188112129337, 8561.0, 5606.187102870143, 5667.489925906688, 5695.345035320991, 5749.8275051748515, 5778.56660750437, 10404.479776011018, 10535.894641053492, 10544.420056896945, 10611.681649550526, 10641.148708103488, 10254.6410875619, 10394.68815935493, 10541.894581054092, 10652.201084918817, 10665.093467055387, 6288.811335659938, 6766.357196066366, 6838.52971611106, 6924.065251191226, 6948.652567371712, 8646.740597782076, 8669.956650216709, 8688.087750786077, 8705.303575714055, 8734.257588104829, 7679.0, 7850.685972561262, 7876.6849326028605, 7895.565743884142, 7931.0, 7515.511491753018, 7520.323170914644, 7563.357114645317, 7590.734324298623, 7766.844663106819, 6669.899951500634, 6725.932740672531, 6731.865362692621, 6765.391114799691, 6785.0, 4711.269753188261, 4762.52374762521, 4845.53967373099, 4879.756012199305, 4922.409310882717, 4876.073546026244, 4914.852554423373, 4929.679570827885, 4933.654644174873, 5007.69953802773], "value": 4654.506623660698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.4922321178961, 333.69800330700707, 340.1869531818953, 344.9017030146407, 346.6914446142932, 5540.667559946401, 5651.208830763686, 5653.717314134292, 5676.489115979561, 5683.772649094031, 5559.833205003846, 5568.554515638749, 5575.470330318623, 5605.663660180392, 5612.298462692163, 4168.166366726652, 4268.317069268917, 4374.912501749979, 4406.096750166224, 4424.269995450747, 4365.864875132456, 4377.34339849022, 4391.27543955247, 4401.23950419833, 4403.955960440387, 4343.478782546099, 4361.0, 4384.758838263911, 4390.868273951786, 4407.471103467572, 4273.914521709564, 4306.6554675626185, 4308.651784777304, 4310.633596144316, 4360.236958532244, 3805.429185622179, 3834.5206849143856, 3842.9615703842883, 3844.480995065658, 3864.632859878307, 5397.893431846462, 5406.270153529302, 5440.755166017539, 5473.890522189574, 5476.780928762844, 4865.82969596066, 4984.501549845023, 4995.225740010268, 4996.825111121093, 5072.898542029176, 5801.448862358111, 5830.387809280007, 5830.82507524775, 5836.161609093165, 5898.734556944948, 4246.8301267949555, 4253.553376895412, 4254.7872606369865, 4268.701190916637, 4269.188854117708, 5911.881762364772, 5922.31893332268, 5983.820485385445, 6009.459148676597, 6032.306284777263, 4275.396726227665, 4280.828766849291, 4354.477462704433, 4361.956380436219, 4366.8034938427845, 4407.184670835905, 4431.313146462304, 4433.7118087324225, 4440.533743956903, 4459.955400445954, 4603.861884143481, 4868.95131048692, 4912.845481311889, 4914.975425122851, 4982.227754698028, 5896.852578685567, 5920.661338771161, 5925.614835035709, 5935.881282374328, 5940.851478713067, 1467.8404060792068, 1470.7352676518115, 1482.7108713800922, 1491.8806495480335, 1498.1086253679043, 923.50592433048, 944.8850356579302, 968.0319680319681, 993.4039576254189, 995.5663844064524, 5568.6658800472105, 5615.887682246333, 5645.463680950304, 5661.264035675418, 5686.886262274731, 5966.940330596639, 6000.939990600125, 6039.033754599331, 6050.487378155462, 6131.601445906002, 5455.890882182334, 5574.101467237014, 5592.86017849557, 5639.351474580476, 5642.492175704124, 3206.486962086055, 3222.6616205298574, 3222.8710851565675, 3230.596175478065, 3232.7575431842706, 6013.248343957005, 6095.146679464879, 6139.907901381483, 6186.783462578788, 6199.194104766351, 6050.878982420327, 6056.546428857131, 6062.514998800086, 6098.969505152446, 6131.877362452726, 6136.207702327812, 6185.876282474325, 6201.782937597252, 6246.220431907757, 6257.561970662101, 5863.237779088691, 6051.455369016633, 6058.666773327333, 6072.1498990140535, 6076.179715738319, 5804.100364443518, 5871.2073870027, 5946.821595352147, 6007.219061521974, 6009.579329446897, 6099.237595300588, 6133.631982080911, 6193.0, 6201.643375517275, 6217.0, 4226.704130710821, 4242.618164365222, 4256.616904478612, 4266.445362102907, 4270.893227669333, 6011.519078473799, 6030.185924900258, 6057.878842423039, 6069.177832307998, 6109.725062372293, 5529.751161197675, 5877.23595932526, 5914.201582786269, 5923.4076592340425, 5927.644341339534, 5839.299284085937, 5841.0, 5858.619189752652, 5877.000909845251, 5906.173135761082, 5516.9448305516435, 5609.0, 5710.600257981901, 5741.16753070794, 5752.9712351437975, 5782.971085144547, 5884.352721200579, 5891.3224979126235, 5945.167676525203, 5945.970270148795, 5596.496315331639, 5799.913001305068, 5803.680797556006, 5891.793787217427, 5906.202662640489], "value": 4465.517119884174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.2663656433875, 719.5826420676009, 733.1641928201851, 771.3289438188775, 810.2869474862123, 14890.627734306649, 16092.51722448327, 16140.354385824583, 16170.353185872551, 16333.5916602085, 13930.373133209005, 14023.719525609482, 14028.298585070757, 14043.578692639212, 14049.367778449969, 660.4254298760086, 768.6464226455809, 777.149021821105, 790.6125998260868, 791.8653828849081, 788.8856115863197, 789.0807209600808, 795.8965334506506, 797.1908512859452, 800.2317774936068, 846.6232526525698, 847.2290215903529, 852.3181454836138, 853.2022558907411, 855.4311382930343, 832.1844592299519, 836.506461187902, 837.4431003382743, 839.236294971576, 839.4040231435657, 608.6500262349123, 612.4426771637833, 612.6599737145926, 612.6844674992383, 614.342653360904, 14257.0, 14263.78604320936, 14334.856651433456, 14419.71160576793, 14442.49451269211, 14651.0, 14706.558803235814, 14826.184559849204, 14875.553733388017, 15108.54674359771, 11414.315141091478, 11466.312021278667, 11472.71318217043, 11544.653660390119, 11970.521179152824, 3826.8660596879254, 3869.613038696136, 3917.373220284769, 3922.213092303501, 4051.0885050863612, 62212.0, 69365.3063469369, 69453.65273173602, 70574.2942570578, 70928.6453567734, 10843.1867609928, 11003.779924401468, 11040.944795275973, 11268.492917818718, 11474.311541307548, 22104.0, 22173.22393716212, 22188.334349969526, 22199.223027194294, 22215.11139554432, 7991.800204994805, 8270.421070525126, 8401.831963360699, 8771.736847894574, 8822.558872056372, 4488.528704486047, 4532.161550113174, 4563.292689633112, 4661.976690116596, 4770.880727981758, 3465.7747246428903, 3515.1036485695986, 3578.767380120336, 3587.2466781975554, 3594.155373487228, 621.0311913415087, 624.9343818899041, 625.627751487864, 638.2914964389524, 640.724488469953, 564.5596434780878, 603.3785201242727, 628.0, 657.1227411405731, 663.7909058646511, 8517.276031537265, 8703.173198546128, 8860.822783544292, 9011.63953441855, 9029.503377314311, 642.7075680565425, 661.2329697550817, 665.2084020016165, 689.689639662154, 690.5994523176546, 4061.086255592468, 4089.754614723126, 4198.832046718158, 4234.237837189336, 4273.081287523135, 69979.0, 103744.0, 108343.45828270966, 110488.4475577633, 114411.0, 82780.0, 94900.52549737207, 94998.52500737453, 96762.51618741862, 97064.0, 86414.56792715997, 87279.0, 87800.12199878047, 88319.55840220886, 88671.55664221638, 8188.672453101809, 8206.712765053195, 8299.543525106177, 8332.875006874781, 8360.581970901309, 50934.906509348766, 50989.745051274505, 51601.48398515967, 51892.740536297075, 52643.21035184398, 66959.0, 77488.0, 77557.61221193858, 77558.0, 77924.0, 10848.620298289521, 10894.455277236266, 11066.170037247077, 11143.2199746017, 11145.0, 11980.341081240615, 12033.518659253532, 12278.0, 12437.315947622968, 12777.552785652457, 11454.94272528632, 11520.0, 11597.13021523406, 11939.641810745692, 12052.75894482123, 11506.942465287955, 11507.884921150682, 11642.417879105842, 11822.290662560274, 12242.387880605756, 11102.2783519071, 11751.529938802694, 11940.820887686865, 12140.939295303468, 12618.242905425705, 10579.312344697877, 10604.363738175734, 10904.781904362027, 11113.277636953571, 11254.718632034264, 10800.837987430037, 11132.332060076422, 11177.720556985814, 11186.04918581897, 11258.155638326994], "value": 7189.921560586864, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 113.0, 113.0, 114.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 154.0, 175.0, 129.0, 155.0, 148.0, 127.0, 182.0, 130.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 163.0, 169.0, 166.0, 162.0, 162.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 152.0, 79.0, 77.0, 74.0, 76.0, 161.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 155.0, 85.0, 86.0, 85.0, 133.0, 85.0, 85.0, 149.0], "value": 103.3, "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, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0, 146.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 99.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 54.0, 55.0, 57.0, 59.0, 58.0, 55.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 69.0, 62.0, 64.0, 62.0, 61.0, 62.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 80.0, 80.0, 80.0, 87.0, 82.0, 82.0, 102.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 134.0, 121.0, 132.0, 121.0, 123.0, 130.0, 131.0, 128.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 166.0, 165.0, 166.0, 163.0, 164.0, 161.0, 162.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 64.0, 63.0, 65.0, 65.0, 64.0, 63.0, 67.0, 63.0], "value": 64.7, "unit": "score"}]}]} 19:31:16 INFO - Return code: 0 19:31:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:16 ERROR - # TBPL SUCCESS # 19:31:16 INFO - Running post-action listener: _resource_record_post_action 19:31:16 INFO - ##### 19:31:16 INFO - ##### Finished run-tests step (success) 19:31:16 INFO - ##### 19:31:16 INFO - Running post-run listener: _resource_record_post_run 19:31:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403931136; Read time: 8; Write time: 356840 19:31:16 INFO - TinderboxPrint: CPU usage
13.4% 19:31:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:31:16 INFO - TinderboxPrint: I/O write bytes / time
403,931,136 / 356,840 19:31:16 INFO - TinderboxPrint: CPU idle
8,224.4 (86.5%) 19:31:16 INFO - TinderboxPrint: CPU user
1,224.0 (12.9%) 19:31:16 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109903872; Read time: 0; Write time: 94604 19:31:16 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294027264; Read time: 8; Write time: 262236 19:31:17 INFO - Running post-run listener: _upload_blobber_files 19:31:17 INFO - Blob upload gear active. 19:31:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:17 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 19:31:17 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'] 19:31:17 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 19:31:17 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:18 INFO - (blobuploader) - INFO - Done attempting. 19:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:19 INFO - (blobuploader) - INFO - Done attempting. 19:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:23 INFO - (blobuploader) - INFO - Done attempting. 19:31:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:23 INFO - Return code: 0 19:31:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e767107df623d7c25566f7a4969d313e3b3b637607351ad056c7f3a64c6687cad16e430d4dd2d3814f99411b08fbe1b10f0f4e44797d26a1cef15bebc16b196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f221a2c99c8283a4eb67ebb162f5c164d7f67c4608f77653f8a8ed11ecaf0894a3154c0751a763a636a2bc9cb01db8eae1424cc002d70ab72977161649f035e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d278900354cb14fa4eb42b1918d64b500c5c729526ea75539f692f0c595f1b4dbe66be5bfad78000141d2212def9d511bc36b903b473a2ea7f864f8fc32dcd5c"} 19:31:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:23 INFO - Contents: 19:31:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e767107df623d7c25566f7a4969d313e3b3b637607351ad056c7f3a64c6687cad16e430d4dd2d3814f99411b08fbe1b10f0f4e44797d26a1cef15bebc16b196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f221a2c99c8283a4eb67ebb162f5c164d7f67c4608f77653f8a8ed11ecaf0894a3154c0751a763a636a2bc9cb01db8eae1424cc002d70ab72977161649f035e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d278900354cb14fa4eb42b1918d64b500c5c729526ea75539f692f0c595f1b4dbe66be5bfad78000141d2212def9d511bc36b903b473a2ea7f864f8fc32dcd5c"} 19:31:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:23 INFO - Copying logs to upload dir... 19:31:23 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.219689 ========= master_lag: 5.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-05 19:31:28.925123) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 19:31:28.929083) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 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/2e767107df623d7c25566f7a4969d313e3b3b637607351ad056c7f3a64c6687cad16e430d4dd2d3814f99411b08fbe1b10f0f4e44797d26a1cef15bebc16b196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f221a2c99c8283a4eb67ebb162f5c164d7f67c4608f77653f8a8ed11ecaf0894a3154c0751a763a636a2bc9cb01db8eae1424cc002d70ab72977161649f035e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d278900354cb14fa4eb42b1918d64b500c5c729526ea75539f692f0c595f1b4dbe66be5bfad78000141d2212def9d511bc36b903b473a2ea7f864f8fc32dcd5c"} build_url:https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/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/2e767107df623d7c25566f7a4969d313e3b3b637607351ad056c7f3a64c6687cad16e430d4dd2d3814f99411b08fbe1b10f0f4e44797d26a1cef15bebc16b196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f221a2c99c8283a4eb67ebb162f5c164d7f67c4608f77653f8a8ed11ecaf0894a3154c0751a763a636a2bc9cb01db8eae1424cc002d70ab72977161649f035e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d278900354cb14fa4eb42b1918d64b500c5c729526ea75539f692f0c595f1b4dbe66be5bfad78000141d2212def9d511bc36b903b473a2ea7f864f8fc32dcd5c"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 19:31:29.081035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:31:29.081347) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465172839.3626-515748813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:31:29.097357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 19:31:29.097629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 19:31:29.097893) ========= ========= Total master_lag: 5.80 =========