builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1470094293.38 results: success (0) buildid: 20160801123750 builduid: 5a38664472d84844bb6ee371e0c4ddcd revision: 3998308ce6053f95dbb3bd814a72eaafb7b31fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.381404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.382307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.382672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.397999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.398568) ========= 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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 16:31:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.7M=0s 2016-08-01 16:31:33 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.547056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.547782) ========= 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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016677 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:33.601696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 16:31:33.602413) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3998308ce6053f95dbb3bd814a72eaafb7b31fae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3998308ce6053f95dbb3bd814a72eaafb7b31fae --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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 16:31:33,615 truncating revision to first 12 chars 2016-08-01 16:31:33,615 Setting DEBUG logging. 2016-08-01 16:31:33,616 attempt 1/10 2016-08-01 16:31:33,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3998308ce605?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 16:31:34,753 unpacking tar archive at: mozilla-beta-3998308ce605/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 16:31:35.092174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:35.092577) ========= script_repo_revision: 3998308ce6053f95dbb3bd814a72eaafb7b31fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:35.093064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:35.093426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 16:31:35.104283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-01 16:31:35.104816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:35 INFO - MultiFileLogger online at 20160801 16:31:35 in /builds/slave/test 16:31:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:31:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:35 INFO - {'append_to_log': False, 16:31:35 INFO - 'base_work_dir': '/builds/slave/test', 16:31:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:31:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:35 INFO - 'branch': 'Mozilla-Beta', 16:31:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:35 INFO - 'config_files': ('talos/linux_config.py',), 16:31:35 INFO - 'default_actions': ('clobber', 16:31:35 INFO - 'read-buildbot-config', 16:31:35 INFO - 'download-and-extract', 16:31:35 INFO - 'populate-webroot', 16:31:35 INFO - 'create-virtualenv', 16:31:35 INFO - 'install', 16:31:35 INFO - 'run-tests'), 16:31:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:35 INFO - 'download_minidump_stackwalk': True, 16:31:35 INFO - 'download_symbols': 'ondemand', 16:31:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:35 INFO - 'installer_path': 'installer.exe', 16:31:35 INFO - 'log_level': 'info', 16:31:35 INFO - 'log_name': 'talos', 16:31:35 INFO - 'log_to_console': True, 16:31:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:35 INFO - 'opt_config_files': (), 16:31:35 INFO - 'pip_index': False, 16:31:35 INFO - 'sps_profile': False, 16:31:35 INFO - 'sps_profile_interval': 0, 16:31:35 INFO - 'suite': 'dromaeojs-e10s', 16:31:35 INFO - 'system_bits': '32', 16:31:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:35 INFO - 'title': 'talos-linux64-ix-059', 16:31:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:35 INFO - 'use_talos_json': True, 16:31:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:35 INFO - 'work_dir': 'build'} 16:31:35 INFO - ##### 16:31:35 INFO - ##### Running clobber step. 16:31:35 INFO - ##### 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: clobber 16:31:35 INFO - rmtree: /builds/slave/test/build 16:31:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - ##### 16:31:35 INFO - ##### Finished clobber step (success) 16:31:35 INFO - ##### 16:31:35 INFO - ##### 16:31:35 INFO - ##### Running read-buildbot-config step. 16:31:35 INFO - ##### 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: read_buildbot_config 16:31:35 INFO - Using buildbot properties: 16:31:35 INFO - { 16:31:35 INFO - "project": "", 16:31:35 INFO - "product": "firefox", 16:31:35 INFO - "script_repo_revision": "production", 16:31:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:31:35 INFO - "repository": "", 16:31:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:31:35 INFO - "buildid": "20160801123750", 16:31:35 INFO - "pgo_build": "True", 16:31:35 INFO - "basedir": "/builds/slave/test", 16:31:35 INFO - "buildnumber": 191, 16:31:35 INFO - "slavename": "talos-linux64-ix-059", 16:31:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:31:35 INFO - "platform": "ubuntu64_hw", 16:31:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:31:35 INFO - "branch": "mozilla-beta", 16:31:35 INFO - "repo_path": "releases/mozilla-beta", 16:31:35 INFO - "revision": "3998308ce6053f95dbb3bd814a72eaafb7b31fae", 16:31:35 INFO - "stage_platform": "linux64-pgo", 16:31:35 INFO - "builduid": "5a38664472d84844bb6ee371e0c4ddcd", 16:31:35 INFO - "slavebuilddir": "test" 16:31:35 INFO - } 16:31:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - ##### 16:31:35 INFO - ##### Finished read-buildbot-config step (success) 16:31:35 INFO - ##### 16:31:35 INFO - ##### 16:31:35 INFO - ##### Running download-and-extract step. 16:31:35 INFO - ##### 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: download_and_extract 16:31:35 INFO - mkdir: /builds/slave/test/build/tests 16:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:35 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:31:36 INFO - Downloaded 1327 bytes. 16:31:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:31:36 INFO - Using the following test package requirements: 16:31:36 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 16:31:36 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:36 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 16:31:36 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'jsshell-linux-x86_64.zip'], 16:31:36 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:36 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 16:31:36 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 16:31:36 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 16:31:36 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:36 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 16:31:36 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:36 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31:36 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')]} 16:31:36 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:37 INFO - Downloaded 21967605 bytes. 16:31:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:31:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:31:38 INFO - Return code: 0 16:31:38 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:38 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 16:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:39 INFO - Downloaded 21967605 bytes. 16:31:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:31:40 INFO - Return code: 0 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 16:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 16:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 16:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:31:41 INFO - Downloaded 10833369 bytes. 16:31:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:31:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:31:41 INFO - Return code: 0 16:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:41 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 16:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 16:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 16:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:31:43 INFO - Downloaded 55283573 bytes. 16:31:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 16:31:43 INFO - mkdir: /builds/slave/test/properties 16:31:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:43 INFO - Contents: 16:31:43 INFO - build_url:https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 16:31:43 INFO - Running post-action listener: _resource_record_post_action 16:31:43 INFO - Running post-action listener: set_extra_try_arguments 16:31:43 INFO - ##### 16:31:43 INFO - ##### Finished download-and-extract step (success) 16:31:43 INFO - ##### 16:31:43 INFO - ##### 16:31:43 INFO - ##### Running populate-webroot step. 16:31:43 INFO - ##### 16:31:43 INFO - Running pre-action listener: _resource_record_pre_action 16:31:43 INFO - Running main action method: populate_webroot 16:31:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:43 INFO - '--tppagecycles', 16:31:43 INFO - '7'], 16:31:43 INFO - 'tests': ['tsvgm']}}, 16:31:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['damp', 'tps']}, 16:31:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'tests': ['damp', 'tps']}, 16:31:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['dromaeo_dom']}, 16:31:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['a11yr', 16:31:43 INFO - 'ts_paint', 16:31:43 INFO - 'tpaint', 16:31:43 INFO - 'sessionrestore', 16:31:43 INFO - 'sessionrestore_no_auto_restore', 16:31:43 INFO - 'tabpaint']}, 16:31:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['tsvgx', 16:31:43 INFO - 'tsvgr_opacity', 16:31:43 INFO - 'tart', 16:31:43 INFO - 'tscrollx', 16:31:43 INFO - 'cart']}, 16:31:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:43 INFO - 'tsvgr_opacity', 16:31:43 INFO - 'tart', 16:31:43 INFO - 'tscrollx', 16:31:43 INFO - 'cart']}, 16:31:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'talos_options': ['--disable-e10s'], 16:31:43 INFO - 'tests': ['tp5o']}, 16:31:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'tests': ['tp5o']}, 16:31:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'talos_options': ['--disable-e10s', 16:31:43 INFO - '--xperf_path', 16:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:43 INFO - 'tests': ['tp5n']}, 16:31:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:43 INFO - 'talos_options': ['--xperf_path', 16:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:43 INFO - 'tests': ['tp5n']}}, 16:31:43 INFO - 'talos.zip': {'path': '', 16:31:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:43 INFO - Running post-action listener: _resource_record_post_action 16:31:43 INFO - ##### 16:31:43 INFO - ##### Finished populate-webroot step (success) 16:31:43 INFO - ##### 16:31:43 INFO - ##### 16:31:43 INFO - ##### Running create-virtualenv step. 16:31:43 INFO - ##### 16:31:43 INFO - Running pre-action listener: _resource_record_pre_action 16:31:43 INFO - Running main action method: create_virtualenv 16:31:43 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:43 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 16:31:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:43 INFO - Using real prefix '/usr' 16:31:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:46 INFO - Installing pip.................done. 16:31:46 INFO - Return code: 0 16:31:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:46 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 16:31:46 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 16:31:46 INFO - Using env: {'DISPLAY': ':0', 16:31:46 INFO - 'HOME': '/home/cltbld', 16:31:46 INFO - 'LANG': 'en_US.UTF-8', 16:31:46 INFO - 'LANGUAGE': 'en_US:en', 16:31:46 INFO - 'LOGNAME': 'cltbld', 16:31:46 INFO - 'MAIL': '/var/mail/cltbld', 16:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:46 INFO - 'MOZ_NO_REMOTE': '1', 16:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:46 INFO - 'NO_EM_RESTART': '1', 16:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:46 INFO - 'PWD': '/builds/slave/test', 16:31:46 INFO - 'SHELL': '/bin/bash', 16:31:46 INFO - 'SHLVL': '1', 16:31:46 INFO - 'TERM': 'linux', 16:31:46 INFO - 'TMOUT': '86400', 16:31:46 INFO - 'USER': 'cltbld', 16:31:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:46 INFO - '_': '/tools/buildbot/bin/python'} 16:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:46 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 16:31:46 INFO - Cleaning up... 16:31:46 INFO - Return code: 0 16:31:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:46 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 16:31:46 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 16:31:46 INFO - Using env: {'DISPLAY': ':0', 16:31:46 INFO - 'HOME': '/home/cltbld', 16:31:46 INFO - 'LANG': 'en_US.UTF-8', 16:31:46 INFO - 'LANGUAGE': 'en_US:en', 16:31:46 INFO - 'LOGNAME': 'cltbld', 16:31:46 INFO - 'MAIL': '/var/mail/cltbld', 16:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:46 INFO - 'MOZ_NO_REMOTE': '1', 16:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:46 INFO - 'NO_EM_RESTART': '1', 16:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:46 INFO - 'PWD': '/builds/slave/test', 16:31:46 INFO - 'SHELL': '/bin/bash', 16:31:46 INFO - 'SHLVL': '1', 16:31:46 INFO - 'TERM': 'linux', 16:31:46 INFO - 'TMOUT': '86400', 16:31:46 INFO - 'USER': 'cltbld', 16:31:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:46 INFO - '_': '/tools/buildbot/bin/python'} 16:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:47 INFO - Downloading/unpacking psutil>=3.1.1 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:49 INFO - Installing collected packages: psutil 16:31:49 INFO - Running setup.py install for psutil 16:31:49 INFO - building 'psutil._psutil_linux' extension 16:31:49 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 16:31:49 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 16:31:49 INFO - building 'psutil._psutil_posix' extension 16:31:49 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 16:31:49 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 16:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:49 INFO - Successfully installed psutil 16:31:49 INFO - Cleaning up... 16:31:49 INFO - Return code: 0 16:31:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:49 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:49 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 16:31:49 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 16:31:49 INFO - Using env: {'DISPLAY': ':0', 16:31:49 INFO - 'HOME': '/home/cltbld', 16:31:49 INFO - 'LANG': 'en_US.UTF-8', 16:31:49 INFO - 'LANGUAGE': 'en_US:en', 16:31:49 INFO - 'LOGNAME': 'cltbld', 16:31:49 INFO - 'MAIL': '/var/mail/cltbld', 16:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:49 INFO - 'MOZ_NO_REMOTE': '1', 16:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:49 INFO - 'NO_EM_RESTART': '1', 16:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:49 INFO - 'PWD': '/builds/slave/test', 16:31:49 INFO - 'SHELL': '/bin/bash', 16:31:49 INFO - 'SHLVL': '1', 16:31:49 INFO - 'TERM': 'linux', 16:31:49 INFO - 'TMOUT': '86400', 16:31:49 INFO - 'USER': 'cltbld', 16:31:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:49 INFO - '_': '/tools/buildbot/bin/python'} 16:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:51 INFO - Installing collected packages: mozsystemmonitor 16:31:51 INFO - Running setup.py install for mozsystemmonitor 16:31:52 INFO - Successfully installed mozsystemmonitor 16:31:52 INFO - Cleaning up... 16:31:52 INFO - Return code: 0 16:31:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:52 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:52 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 16:31:52 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 16:31:52 INFO - Using env: {'DISPLAY': ':0', 16:31:52 INFO - 'HOME': '/home/cltbld', 16:31:52 INFO - 'LANG': 'en_US.UTF-8', 16:31:52 INFO - 'LANGUAGE': 'en_US:en', 16:31:52 INFO - 'LOGNAME': 'cltbld', 16:31:52 INFO - 'MAIL': '/var/mail/cltbld', 16:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:52 INFO - 'MOZ_NO_REMOTE': '1', 16:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:52 INFO - 'NO_EM_RESTART': '1', 16:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:52 INFO - 'PWD': '/builds/slave/test', 16:31:52 INFO - 'SHELL': '/bin/bash', 16:31:52 INFO - 'SHLVL': '1', 16:31:52 INFO - 'TERM': 'linux', 16:31:52 INFO - 'TMOUT': '86400', 16:31:52 INFO - 'USER': 'cltbld', 16:31:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:52 INFO - '_': '/tools/buildbot/bin/python'} 16:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:54 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 16:31:54 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 16:31:54 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 16:31:54 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 16:31:54 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 16:31:54 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 16:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:55 INFO - warning: no files found matching '*.txt' 16:31:55 INFO - no previously-included directories found matching 'build' 16:31:55 INFO - no previously-included directories found matching 'dist' 16:31:55 INFO - no previously-included directories found matching '.git*' 16:31:55 INFO - Installing collected packages: jsonschema, functools32 16:31:55 INFO - Running setup.py install for functools32 16:31:55 INFO - warning: no files found matching '*.txt' 16:31:55 INFO - no previously-included directories found matching 'build' 16:31:55 INFO - no previously-included directories found matching 'dist' 16:31:55 INFO - no previously-included directories found matching '.git*' 16:31:55 INFO - Successfully installed jsonschema functools32 16:31:55 INFO - Cleaning up... 16:31:55 INFO - Return code: 0 16:31:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:55 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:55 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 16:31:55 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 16:31:55 INFO - Using env: {'DISPLAY': ':0', 16:31:55 INFO - 'HOME': '/home/cltbld', 16:31:55 INFO - 'LANG': 'en_US.UTF-8', 16:31:55 INFO - 'LANGUAGE': 'en_US:en', 16:31:55 INFO - 'LOGNAME': 'cltbld', 16:31:55 INFO - 'MAIL': '/var/mail/cltbld', 16:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:55 INFO - 'MOZ_NO_REMOTE': '1', 16:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:55 INFO - 'NO_EM_RESTART': '1', 16:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:55 INFO - 'PWD': '/builds/slave/test', 16:31:55 INFO - 'SHELL': '/bin/bash', 16:31:55 INFO - 'SHLVL': '1', 16:31:55 INFO - 'TERM': 'linux', 16:31:55 INFO - 'TMOUT': '86400', 16:31:55 INFO - 'USER': 'cltbld', 16:31:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:55 INFO - '_': '/tools/buildbot/bin/python'} 16:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:57 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 16:31:58 INFO - Downloading docopt-0.6.1.tar.gz 16:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:58 INFO - Running setup.py install for blobuploader 16:31:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:58 INFO - Running setup.py install for requests 16:31:58 INFO - Running setup.py install for docopt 16:31:58 INFO - Successfully installed blobuploader requests docopt 16:31:58 INFO - Cleaning up... 16:31:58 INFO - Return code: 0 16:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:31:58 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 16:31:58 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 16:31:58 INFO - Using env: {'DISPLAY': ':0', 16:31:58 INFO - 'HOME': '/home/cltbld', 16:31:58 INFO - 'LANG': 'en_US.UTF-8', 16:31:58 INFO - 'LANGUAGE': 'en_US:en', 16:31:58 INFO - 'LOGNAME': 'cltbld', 16:31:58 INFO - 'MAIL': '/var/mail/cltbld', 16:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:58 INFO - 'MOZ_NO_REMOTE': '1', 16:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:58 INFO - 'NO_EM_RESTART': '1', 16:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:58 INFO - 'PWD': '/builds/slave/test', 16:31:58 INFO - 'SHELL': '/bin/bash', 16:31:58 INFO - 'SHLVL': '1', 16:31:58 INFO - 'TERM': 'linux', 16:31:58 INFO - 'TMOUT': '86400', 16:31:58 INFO - 'USER': 'cltbld', 16:31:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:58 INFO - '_': '/tools/buildbot/bin/python'} 16:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:59 INFO - Running setup.py (path:/tmp/pip-KMawAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:59 INFO - Running setup.py (path:/tmp/pip-flYx6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:59 INFO - Running setup.py (path:/tmp/pip-I75Ghs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:59 INFO - Running setup.py (path:/tmp/pip-flNItQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:59 INFO - Running setup.py (path:/tmp/pip-GvqniG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:59 INFO - Running setup.py (path:/tmp/pip-blRxmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:59 INFO - Running setup.py (path:/tmp/pip-A149d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:59 INFO - Running setup.py (path:/tmp/pip-34U8t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:59 INFO - Running setup.py (path:/tmp/pip-2k9ssz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:59 INFO - Running setup.py (path:/tmp/pip-R2eZ_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:59 INFO - Running setup.py (path:/tmp/pip-zcIPui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:59 INFO - Running setup.py (path:/tmp/pip-HUN9b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:59 INFO - Running setup.py (path:/tmp/pip-WQ3HyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:00 INFO - Running setup.py (path:/tmp/pip-CllpXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:00 INFO - Running setup.py (path:/tmp/pip-DJ5Qdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:00 INFO - Running setup.py (path:/tmp/pip-1XSQdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:00 INFO - Running setup.py (path:/tmp/pip-Du_Kxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:00 INFO - Running setup.py install for manifestparser 16:32:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:00 INFO - Running setup.py install for mozcrash 16:32:00 INFO - Running setup.py install for mozdebug 16:32:00 INFO - Running setup.py install for mozdevice 16:32:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:00 INFO - Running setup.py install for mozfile 16:32:00 INFO - Running setup.py install for mozhttpd 16:32:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:00 INFO - Running setup.py install for mozinfo 16:32:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for mozInstall 16:32:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for mozleak 16:32:01 INFO - Running setup.py install for mozlog 16:32:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for moznetwork 16:32:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for mozprocess 16:32:01 INFO - Running setup.py install for mozprofile 16:32:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for mozrunner 16:32:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:01 INFO - Running setup.py install for mozscreenshot 16:32:01 INFO - Running setup.py install for moztest 16:32:01 INFO - Running setup.py install for mozversion 16:32:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:02 INFO - Cleaning up... 16:32:02 INFO - Return code: 0 16:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:02 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')]} 16:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:02 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')]} 16:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:02 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:32:02 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 16:32:02 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 16:32:02 INFO - Using env: {'DISPLAY': ':0', 16:32:02 INFO - 'HOME': '/home/cltbld', 16:32:02 INFO - 'LANG': 'en_US.UTF-8', 16:32:02 INFO - 'LANGUAGE': 'en_US:en', 16:32:02 INFO - 'LOGNAME': 'cltbld', 16:32:02 INFO - 'MAIL': '/var/mail/cltbld', 16:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:02 INFO - 'MOZ_NO_REMOTE': '1', 16:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:02 INFO - 'NO_EM_RESTART': '1', 16:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:02 INFO - 'PWD': '/builds/slave/test', 16:32:02 INFO - 'SHELL': '/bin/bash', 16:32:02 INFO - 'SHLVL': '1', 16:32:02 INFO - 'TERM': 'linux', 16:32:02 INFO - 'TMOUT': '86400', 16:32:02 INFO - 'USER': 'cltbld', 16:32:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:02 INFO - '_': '/tools/buildbot/bin/python'} 16:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:02 INFO - Running setup.py (path:/tmp/pip-ETOvVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:02 INFO - Running setup.py (path:/tmp/pip-qIcURU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:02 INFO - Running setup.py (path:/tmp/pip-fWwzP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:02 INFO - Running setup.py (path:/tmp/pip-7DbJl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:02 INFO - Running setup.py (path:/tmp/pip-FjS3u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:02 INFO - Running setup.py (path:/tmp/pip-RonSPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:02 INFO - Running setup.py (path:/tmp/pip-jDpTiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:02 INFO - Running setup.py (path:/tmp/pip-NYrFDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:02 INFO - Running setup.py (path:/tmp/pip-5RbzPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:02 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)) 16:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:03 INFO - Running setup.py (path:/tmp/pip-bIcQNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:03 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:03 INFO - Running setup.py (path:/tmp/pip-b90j8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:03 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:03 INFO - Running setup.py (path:/tmp/pip-Xsms2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:03 INFO - Running setup.py (path:/tmp/pip-pGzfhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:03 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:03 INFO - Running setup.py (path:/tmp/pip-N2Uk3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:03 INFO - Running setup.py (path:/tmp/pip-6EXQmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:03 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:03 INFO - Running setup.py (path:/tmp/pip-0FiO_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:03 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)) 16:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:03 INFO - Running setup.py (path:/tmp/pip-n5A35j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:03 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)) 16:32:03 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)) 16:32:03 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)) 16:32:03 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)) 16:32:03 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)) 16:32:03 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)) 16:32:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:05 INFO - Downloading blessings-1.6.tar.gz 16:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:05 INFO - Installing collected packages: blessings 16:32:05 INFO - Running setup.py install for blessings 16:32:05 INFO - Successfully installed blessings 16:32:05 INFO - Cleaning up... 16:32:05 INFO - Return code: 0 16:32:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:05 INFO - Reading from file tmpfile_stdout 16:32:05 INFO - Current package versions: 16:32:05 INFO - argparse == 1.2.1 16:32:05 INFO - blessings == 1.6 16:32:05 INFO - blobuploader == 1.2.4 16:32:05 INFO - docopt == 0.6.1 16:32:05 INFO - functools32 == 3.2.3-2 16:32:05 INFO - jsonschema == 2.5.1 16:32:05 INFO - manifestparser == 1.1 16:32:05 INFO - mozInstall == 1.12 16:32:05 INFO - mozcrash == 0.17 16:32:05 INFO - mozdebug == 0.1 16:32:05 INFO - mozdevice == 0.48 16:32:05 INFO - mozfile == 1.2 16:32:05 INFO - mozhttpd == 0.7 16:32:05 INFO - mozinfo == 0.9 16:32:05 INFO - mozleak == 0.1 16:32:05 INFO - mozlog == 3.2 16:32:05 INFO - moznetwork == 0.27 16:32:05 INFO - mozprocess == 0.23 16:32:05 INFO - mozprofile == 0.28 16:32:05 INFO - mozrunner == 6.12 16:32:05 INFO - mozscreenshot == 0.1 16:32:05 INFO - mozsystemmonitor == 0.3 16:32:05 INFO - moztest == 0.7 16:32:05 INFO - mozversion == 1.4 16:32:05 INFO - psutil == 3.1.1 16:32:05 INFO - requests == 1.2.3 16:32:05 INFO - wsgiref == 0.1.2 16:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:05 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 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:32:05 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 16:32:05 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 16:32:05 INFO - Using env: {'DISPLAY': ':0', 16:32:05 INFO - 'HOME': '/home/cltbld', 16:32:05 INFO - 'LANG': 'en_US.UTF-8', 16:32:05 INFO - 'LANGUAGE': 'en_US:en', 16:32:05 INFO - 'LOGNAME': 'cltbld', 16:32:05 INFO - 'MAIL': '/var/mail/cltbld', 16:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:05 INFO - 'MOZ_NO_REMOTE': '1', 16:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:05 INFO - 'NO_EM_RESTART': '1', 16:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:05 INFO - 'PWD': '/builds/slave/test', 16:32:05 INFO - 'SHELL': '/bin/bash', 16:32:05 INFO - 'SHLVL': '1', 16:32:05 INFO - 'TERM': 'linux', 16:32:05 INFO - 'TMOUT': '86400', 16:32:05 INFO - 'USER': 'cltbld', 16:32:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:05 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 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)) 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:32: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', 'jsonschema'] in /builds/slave/test/build 16:32: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 jsonschema 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0466ca5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2824350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, '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': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', '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 16:32: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', 'flake8'] in /builds/slave/test/build 16:32: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 flake8 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 INFO - Downloading/unpacking flake8 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:32:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:32:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:09 INFO - no previously-included directories found matching 'docs/_build' 16:32:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:32:09 INFO - Running setup.py install for pep8 16:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:09 INFO - no previously-included directories found matching 'docs/_build' 16:32:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:32:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:32:09 INFO - Cleaning up... 16:32:09 INFO - Return code: 0 16:32:09 INFO - Running post-action listener: _resource_record_post_action 16:32:09 INFO - Running post-action listener: _start_resource_monitoring 16:32:09 INFO - Starting resource monitoring. 16:32:09 INFO - ##### 16:32:09 INFO - ##### Finished create-virtualenv step (success) 16:32:09 INFO - ##### 16:32:09 INFO - ##### 16:32:09 INFO - ##### Running install step. 16:32:09 INFO - ##### 16:32:09 INFO - Running pre-action listener: _resource_record_pre_action 16:32:09 INFO - Running main action method: install 16:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:09 INFO - Reading from file tmpfile_stdout 16:32:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:09 INFO - Reading from file tmpfile_stdout 16:32:09 INFO - Output received: 16:32:09 INFO - Usage: mozinstall [options] installer 16:32:09 INFO - Options: 16:32:09 INFO - -h, --help show this help message and exit 16:32:09 INFO - -d DEST, --destination=DEST 16:32:09 INFO - Directory to install application into. [default: 16:32:09 INFO - "/builds/slave/test"] 16:32:09 INFO - --app=APP Application being installed. [default: firefox] 16:32:09 INFO - mkdir: /builds/slave/test/build/application 16:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:32:22 INFO - Reading from file tmpfile_stdout 16:32:22 INFO - Output received: 16:32:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:22 INFO - Running post-action listener: _resource_record_post_action 16:32:22 INFO - ##### 16:32:22 INFO - ##### Finished install step (success) 16:32:22 INFO - ##### 16:32:22 INFO - ##### 16:32:22 INFO - ##### Running run-tests step. 16:32:22 INFO - ##### 16:32:22 INFO - Running pre-action listener: _resource_record_pre_action 16:32:22 INFO - Running main action method: run_tests 16:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:22 INFO - Python 2.7.3 16:32:22 INFO - Return code: 0 16:32:22 INFO - grabbing minidump binary from tooltool 16:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:22 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 0x28b31c0>, '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 0x28b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:22 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 16:32:22 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 16:32:22 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 16:32:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:22 INFO - Return code: 0 16:32:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:32:23 INFO - Return code: 0 16:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 16:32:23 INFO - Using env: {'DISPLAY': ':0', 16:32:23 INFO - 'HOME': '/home/cltbld', 16:32:23 INFO - 'LANG': 'en_US.UTF-8', 16:32:23 INFO - 'LANGUAGE': 'en_US:en', 16:32:23 INFO - 'LOGNAME': 'cltbld', 16:32:23 INFO - 'MAIL': '/var/mail/cltbld', 16:32:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:23 INFO - 'MOZ_NO_REMOTE': '1', 16:32:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:23 INFO - 'NO_EM_RESTART': '1', 16:32:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:23 INFO - 'PWD': '/builds/slave/test', 16:32:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:23 INFO - 'SHELL': '/bin/bash', 16:32:23 INFO - 'SHLVL': '1', 16:32:23 INFO - 'TERM': 'linux', 16:32:23 INFO - 'TMOUT': '86400', 16:32:23 INFO - 'USER': 'cltbld', 16:32:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401', 16:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:23 INFO - '_': '/tools/buildbot/bin/python'} 16:32:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:32:24 INFO - mozversion application_buildid: 20160801123750 16:32:24 INFO - mozversion application_changeset: 3998308ce6053f95dbb3bd814a72eaafb7b31fae 16:32:24 INFO - mozversion application_display_name: Firefox 16:32:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:24 INFO - mozversion application_name: Firefox 16:32:24 INFO - mozversion application_remotingname: firefox 16:32:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:24 INFO - mozversion application_vendor: Mozilla 16:32:24 INFO - mozversion application_version: 49.0 16:32:24 INFO - mozversion platform_buildid: 20160801123750 16:32:24 INFO - mozversion platform_changeset: 3998308ce6053f95dbb3bd814a72eaafb7b31fae 16:32:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:24 INFO - mozversion platform_version: 49.0 16:32:24 INFO - using testdate: 1470094344 16:32:24 INFO - actual date: 1470094344 16:32:24 INFO - starting webserver on 'localhost:43576' 16:32:24 INFO - SUITE-START | Running 2 tests 16:32:24 INFO - TEST-START | dromaeo_css 16:32:24 INFO - operating with platform_type : linux_ 16:32:24 INFO - Initialising browser for dromaeo_css test... 16:32:24 INFO - TEST-INFO | started process 4424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoFYqZ/profile http://localhost:43576/getInfo.html) 16:32:28 INFO - PROCESS | 4424 | __metrics Screen width/height:1600/1200 16:32:28 INFO - PROCESS | 4424 | colorDepth:24 16:32:28 INFO - PROCESS | 4424 | Browser inner width/height: 1024/697 16:32:28 INFO - PROCESS | 4424 | __metrics 16:32:29 ERROR - PROCESS | 4424 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:32:30 INFO - TEST-INFO | 4424: exit 0 16:32:30 INFO - Browser initialized. 16:32:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:30 INFO - TEST-INFO | started process 4554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoFYqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:41 INFO - PROCESS | 4554 | RSS: Main: 152825856 16:32:41 INFO - PROCESS | 4554 | 16:33:31 INFO - PROCESS | 4554 | 1470094411403 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] 16:35:39 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43576/tests/dromaeo/cssquery-ext.html) 16:35:40 INFO - PROCESS | 4554 | RSS: Main: 156942336 16:35:40 INFO - PROCESS | 4554 | 16:38:42 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-ext.html (next: http://localhost:43576/tests/dromaeo/cssquery-jquery.html) 16:38:42 INFO - PROCESS | 4554 | RSS: Main: 154107904 16:38:42 INFO - PROCESS | 4554 | 16:41:44 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43576/tests/dromaeo/cssquery-mootools.html) 16:41:45 INFO - PROCESS | 4554 | RSS: Main: 153862144 16:41:45 INFO - PROCESS | 4554 | 16:44:47 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43576/tests/dromaeo/cssquery-prototype.html) 16:44:47 INFO - PROCESS | 4554 | RSS: Main: 155381760 16:44:47 INFO - PROCESS | 4554 | 16:47:49 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43576/tests/dromaeo/cssquery-yui.html) 16:47:50 INFO - PROCESS | 4554 | RSS: Main: 154710016 16:47:50 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-yui.html (next: http://localhost:43576/tests/dromaeo/cssquery-dojo.html) 16:50:52 INFO - PROCESS | 4554 | RSS: Main: 158523392 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | __start_tp_report 16:50:52 INFO - PROCESS | 4554 | _x_x_mozilla_page_load 16:50:52 INFO - PROCESS | 4554 | _x_x_mozilla_page_load_details 16:50:52 INFO - PROCESS | 4554 | |i|pagename|runs| 16:50:52 INFO - PROCESS | 4554 | |0;dojo.html;3349.0287816533205;3350.09547422196;3378.290558982614;3395.9660403395974;3401.8469168887395;5534.535943536553;5552.250446189763;5577.912307100112;5631;5643.5767317451255;5576.86057848554;5591.161325801122;5639.238702775124;5643.887122257563;5652.293463317085;5029.170186919154;5075.187969924795;5077.365329333833;5118.513741194581;5125.846224613268;5006.249062640615;5030.245463180516;5113.463086375933;5119.513646203604;5141.048905952411;4959.900801983958;4981.750912454381;5040.848774536751;5053;5062.519060689228;5085.5423011928915;5140.614453915971;5146.073706732768;5162.354705661793;5164.509371609691;4844.249141383091;5060.924086138711;5067.721275329855;5116.539511443951;5117.667351622133;5370.812021579226;5417.83746487606;5439.700816455093;5445.727713614343;5451.100568406208;5939.177812765398;5976.7908123215475;5978.8505287367725;5989.880202395928;6014.75940962361;5899.439553242435;5970.910436343458;6047.909281360783;6063.636181829104;6088.878222435571;5624.15637654351;5681.971590142064;5687.40282270364;5692.17463467799;5719.3136823581435;6177.320494745574;6181.721822517998;6185.536084793568;6195.659238741912;6205.5345849061505;5705.885882282331;5788.739506722208;5831.708414579339;5933.732982015733;5936.347001829795;5981.880362392728;5999.820005399845;6004.249468816398;6043.063325184604;6046.576739628272;5936.7922122725495;5949.762009519657;5970.373110823388;5970.9701451492465;6005.789797357072;5824.825255242265;5872.941270587239;5885.264341957255;5935.970320148372;6019.608725432833;4637.049404871993;4639.559241872017;4650.116477869262;4654.325122857167;4659.603933665609;4111.403846442249;4129.91740165201;4138.627523522898;4145.626893579592;4177.039280965395;5643.379228284885;5722.399148089474;5774.538036957033;5795.623284486495;5832.125181222766;5942.286925568959;5977.133315669291;6052.092186172109;6091.299500557404;6125.663088530174;5655.971720141373;5849.151872978479;5862.677552734641;5863.560232982543;5871.6183448075735;5141.408737995103;5150.098732721759;5196.9740151299;5210;5292.655977361459;6251.429366902311;6293.181886354744;6319.24169099711;6328.240611126695;6340.175777148941;6076.3012253591405;6083.66539840313;6088.665123418077;6090.665013424305;6109.9002179607205;6071.878562428638;6188.597741146991;6223.844403889939;6269.0909818075215;6349.809505714836;5920.970395147997;5969.552283578662;5973.313068997121;5974.074018527135;6009.038553831366;5920.585559010828;6112.72492737819;6129.785457508966;6131.110988906673;6136.631802091889;5841.883162336814;5870.735816888165;5910.083936989773;5924.7926322578505;5958.821235362946;5942.494887934401;5945.762169513171;5953.434423729739;5954.345022047658;5961.701914904324;5679.74441150141;5739.942600574108;5836.591438599257;5855.765769369177;5871.882562348815;5862.355140934408;5917.319508256605;5980.073088671263;5988.580799344179;5996.700164991646;5842.123681447647;5846.503047240862;5850.707464626837;5855.502282306052;5870.17817505541 16:50:52 INFO - PROCESS | 4554 | |1;ext.html;593.3206478582024;653.6894974886926;657.0440009785763;660.1714847865925;661.6294874870075;33223.66776332236;36585.45121823175;44944.3258351125;45392.63822085338;45429.7728511357;46702.53297467024;47085.52914470863;47298.763506182506;47300.290495642505;47396.289055664194;8992.145746154105;9120.361574689774;9136.451812891215;9139.908600914005;9156.084391560824;8860.689875854347;8913.420627659214;8940.64237430502;8944.821103577924;8946;8927.151920567569;8958.148975847316;8963.865542016874;8968.282537396992;9004.054574269705;8816.294696424302;8873.467591944504;8924.509151996637;8931.330150238726;8968.551572421386;8904.065073167289;8965;8993.280537557046;9004.189622933902;9042.728718138467;43070.56929430728;43340.13319733619;43427.13145737068;43607.56392436067;43627.78186109081;3502.702270307027;3678.1356381250653;3726.4782930389765;3736.196717705679;3844.38489841624;33808.323833523435;33958;34160.14599635029;34170.487442688376;34201.48697769511;4723.645726570521;4766.52334766524;4831.299461578052;5029.84910452687;5042.0168067226905;355017;355980;356562;357272;357329;37106;37710.81144594259;37739.05652358658;63218.36781632217;63956.68021659862;38445.423318650246;38568;38607;38625.22749544994;38679.41980870289;14070;14141.929290353688;14149.29253537319;14228.28858557068;14250.073745206528;11347.489362978686;11554.826677599844;11581.88418115808;11605.30368177912;11621.128415368712;8900;9075.727728168165;9087.273018158532;9116.817663646823;9137.314701397421;3532.4171511700797;3566.465030245484;3576.9595843533307;3584.462330650423;3645.5989841117457;1045.4563626913962;1093.469885007374;1124.1681155944705;1166.0787977497682;1206.843110395643;32751.18122046968;33189;33355.332893342;33503.3299334012;33895.661043389744;1084.4415126210008;1171.917965742407;1207.8731733168067;1209.2623499665197;1236.4930378544934;17201.655966880844;17202.397916072878;17261.56846078833;17400.39098631542;17454.476365708793;167515;847510;864770;896765.0646987024;908963;58367;59101.70449147727;59296;59303.40696592979;59404.70297648571;1438.6475313548249;1472.1976522795317;1473.6094934842276;1485.532057401915;1507.3744396075506;29927.85036074893;30418;30974.22564435907;31064.534031989086;31584.684153159094;48413;49173.26240106473;49230.507694924025;49233;49271;396976;402393;403336;406048;408065;29051.12846614605;29687.406251875273;30452.390952181275;31006.22484437907;31168.376632467676;50320;50634.240486391995;51082;51094.48905510897;52014;43222.351664724425;43486.34770478508;43736.78131609321;44383.55616443924;44601.77699111614;42821;42979.28082876775;43592.782036089615;43832.56167438285;44158.33762493629;42483.57516424796;42916.570834292506;43961.56038439574;44092.33861492144;44124.55875441204;37092.62907371;37670.434943475324;37970.81014594909;38304.616953830104;38624.42063369108;28948.710512894602;29573.556396653636;29595.60838073953;29745.405091898472;29985.850070749508 16:50:52 INFO - PROCESS | 4554 | |2;jquery.html;401.0935286253067;406.8291317646588;408.2997659014789;411.41373542701655;415.21317104087757;16568.50294491164;18834.15246313916;20527.794722052775;20654.793452065474;20944.581108377824;12940.611781646543;13113.606591802261;13384.799228011587;13388.93305533471;13474.393652285646;5251.711155886424;5415.079436495806;5425.701586412746;5435.130379139338;5458.1266997280445;5049.4698056704065;5377.46225377463;5381.704006279653;5391.379991301012;5394.02907476656;5331.253624492574;5339.305890234284;5372.435894231088;5373;5380.408155102936;5422.53908417785;5843.561732870052;5874.118882167666;5879.176915231871;5899.73451194693;5182.896342073137;5316.627836051478;5325.813596524103;5339.839804805862;5371.677699338014;14285.78571321431;14297.285135743276;21221.045052972655;24141.034358625635;24266.514669706685;2418.6492958520917;2451.767082127195;2475.8885850136785;2478.876056197201;2704.1346769033917;9972.700818975442;10670.199735019827;10891.183161262938;14247.928760356235;14286.214258215794;1970.8324792392664;2044.2947183221765;2049.2929939170963;2055.496403381166;2057.86623869448;80627;84199;85293.57353213194;85485.57257213673;86005.13994860034;11374.431278436045;11485.942570287096;11513.078953683686;11656.358900260397;11740.119491038206;15949.760753588705;16028.358865645478;16102.75845862313;16192.919035404748;16205;7932.920670793334;7940.0868900076075;7999.080105787909;8012.879806802903;8226.341892648574;7446.962765186139;7518.924810751932;7519.285667861654;7627.961860190663;7718.112417071996;4790.329353890458;4839.080574690868;4859.805607775649;4915.090708218991;4934.062528119646;2047.6109539187805;2071.3475255294534;2083.2812679625504;2085.0929845516944;2124.2458927080665;905.3933864310927;977.6675930183771;1015.3958394755109;1066.3069005146563;1096.5415996724496;19336;19742.210311587376;19758.40724778259;19823;19903.701444478345;980.2060331131806;1013.9391636501833;1027.3219675014454;1056.3187292286375;1062.6705721226444;10733;11081.224314297922;11171.72070698239;11175.10599152082;11224.775504489864;498928;514395;523533;523741;528676;90559;91885.54057229671;93599;94286;94621.5268923651;1046.8011077895176;1046.8796088449926;1062.0706881478707;1066.7599790047332;1072.7157303314627;17319.913400432917;17331.13344332753;17688.73466897972;17761.644767104845;17908.820911790714;30097;38397.808010960885;40272;41250.79374603108;41549.37675934803;55498;56473.43526564682;57319.7134014344;57718.42281577131;57887;8896.866547001671;8966.23786978088;9163;9192.942811576755;9286.814263714552;12456;12631.178973366701;12631.368431578569;12743.553975610808;12914.418851151533;10801.513931873242;11384;11406.543738250377;11598.072154227473;11819.409029548317;10997.835032474359;11079.446027698745;11213.15901307389;11631.127665424958;11836.46735896904;11840.45430232504;12215.511379544718;12228.266304021787;12272.693182670148;12387;9041.954790226007;9054.502002389669;9115.088491150831;9187;9215.216706580015;9321.39410938314;11782.410879455821;12007.699807504881;12082.395880205779;12183.573574925189 16:50:52 INFO - PROCESS | 4554 | |3;mootools.html;1567.1380740592672;1606.7348887433573;1799.8110198429165;1890;1906.8855868647881;8343.290820280268;9176.632934682604;9301.7674558136;9981.600735970562;10005.099541041305;9091.863622045657;9288.164065234128;9468.053194680546;9543.284253680968;9557.952210238938;2365.6451532270166;2412.6381042843536;2420.1045613123083;2423.624338227569;2427.5630386530415;2380.797632201265;2458.385403649088;2475.0718480569785;2484.6645702830156;2489.2781093482868;2404.2426635609813;2423.164008417093;2434.7200071991683;2436.0377650827913;2454.6931633545805;2387.8806059696944;2389.1160270699866;2390.8565486070806;2391.904323827036;2418.2503423938633;2367.0886708617136;2376.750441203666;2380.416797884512;2380.9642855357183;2394.257780088178;9413.38812977161;9569.856452153223;9586.760330991781;9591.664291749756;9604.855927161097;5480.561555075585;5597.076482380402;5609.971950140264;5610.326760788732;5623.100303951389;3548.361294966905;3596.28074385124;3664.120611053355;3675.72432067596;3701.2967536168044;1172.4606680926784;1183.9644810655693;1217.713837248246;1221.6212973978006;1226.1355744200407;13388.464461421532;13562.118462300017;13608.523701670492;13642.113262637897;13672.31638418075;4777.3072904429355;4783.545563171493;4859.1496488114435;4886.169351210303;4910.21436570147;11461.885381146249;11475.139364547693;11518;11518.136139789549;11524.481398337095;5505.532029777433;5590.888182236333;5597.916031259534;5606.663600183921;5618.494335509824;4862.927056094161;5020.3724534433195;5083.262926875656;5091.159958606789;5131.461196574306;3862.497875276252;3904;3934.803259836997;3952.664023557972;3959.9010024749036;1137.698509894862;1144.7424329525957;1147.5983405807901;1156.4506859241792;1182.5683625476638;991.3556188477403;996.8853581838182;1004.7842111045717;1014.3153371474225;1025.8102251083574;6172.413620706116;6338.30278669346;6422.2293324800385;6528.37980391862;6551.377619126175;452.82266108118625;455.9270516717309;463.6707937364442;464.7861983487566;468.7117422784963;4376.409184760017;4511.639068874482;4561.29299958507;4574.45106587205;4582.060677561092;11064.834027489595;11291.604793832177;11309.71725706864;11338.659840204808;11369.147313951487;11106.555737770399;11237.83143252852;11244.156688248415;11245.212835101463;11262.155338349656;8585.957070214608;8926.553672316488;8937.195652391316;9212;9223.677171299107;6139.72371243304;6341.460975817107;6418.839529011812;6484.254310754135;6491.058796474579;10610.416427096583;10897.128229741444;11008.119350452105;11138.10895128404;11145.275557088764;11156.776864462827;11355.97796198346;11397.145214108808;11405.714857128307;11446.313221206754;8103.959480202561;8212.712555060543;8295.543745094077;8357.498550087013;8532.701355452778;9318.254539636948;9359;9367.906320936976;9410.635457858436;9411.858822117536;8109.59452027408;8409.621567029377;8431.831363372576;8462.534560599226;8552.572371381282;8145.877811832946;8155.1437099106115;8173.591320433836;8177.018757749108;8243.629036693243;7182.569045857265;7471;7541.132769731332;7563.773086807405;7594.734184303523;5473.124300111963;5535.225068490495;5559.916601251065;5592.916106258491;5634.408387119293;5341.893162136813;5367;5410.83767486976;5424.077906755782;5532.1425179097305 16:50:52 INFO - PROCESS | 4554 | |4;prototype.html;320.4344332253572;322.13185465171375;330.5454999375858;338.2879039621595;342.4213079894979;5822.9417705822925;5843.853903652411;5850.250382320308;5868.943590153771;5896.5282777377815;5690.5447564194865;5751.338596061454;5757.769689212437;5763.510101641355;5792.189093526909;4196.139791342775;4288.078063216408;4296.914061718764;4314.37441570972;4349.282368409209;4263.8081286342185;4279.48646162461;4304.483461984566;4338.739675619473;4342.934855977162;4281.67887408444;4296.5273819879785;4318.956810431887;4320.97839510802;4324;4172.935901345168;4270.743755374688;4289.562996396211;4297.77513408677;4339.804708788112;3672.247189326182;3680.043188770912;3683.889483315505;3698.0754811297174;3704;5528.778848846041;5529.424114127454;5534.501894829485;5554.944450555483;5581.134924086773;4828.179209534387;4957.082939656139;4966.776495057731;4973.477784832613;5013.949860501385;5918.437748413894;5941.494972927307;5952.494038006775;5971.790437538095;6034.275886893601;4093.9385909211387;4098.897527561805;4117.402976568381;4118.835246590133;4128.91742165158;6127.264728232596;6206.190202593027;6276.403741644536;6277;6282.811515654537;4285.485741710952;4289.198536614629;4293.785310734451;4293.914121717548;4298.290782020994;4322.481302243751;4333;4344.522102568715;4366.607005369532;4414.713043652217;4897.534734200245;4975.950240497621;4979.253112033224;4992.201247800334;5045.445001049881;5994.400559944058;5995.010823214121;6023.849403764941;6031.42701443371;6036.758529658764;1485.3241774992352;1506.7438535449;1516.4616561120863;1522.439499513008;1526.5496678479876;946.129560804062;949.1268033409142;988.9554970026367;991.4943378876825;1013.3615822032073;5850.4149585042005;5867.589268751147;5897.911531327033;5899.970500147472;5904.852378690567;6148.479123559408;6194.862772343534;6202.28673702521;6203.7828675996125;6257.342978987232;5607.327120745536;5885.646861188342;5923.20914614647;5960.165576819162;5960.821175364746;3312.585926759155;3316.35331110436;3322.7175690066133;3329.783564068328;3336.282699219679;6227.408396202353;6460.741570337228;6462.870742585122;6467.902981455282;6516.2506311773805;6313.779017734358;6334.429901308904;6342.746290148435;6353.078803573456;6365.61806291624;6215.906761398493;6488.513361497812;6544.934550654432;6556.6396097404895;6595.967020164964;6242.534198991464;6269.185005949197;6271.027990661455;6277.811665650038;6287.685615719287;6184.257889053342;6194.4115309045565;6206.379362063757;6218.139655758221;6226.3151053385;6338.82731694638;6506.3818937200895;6526.869462610816;6532.248791389051;6534.215894092739;4282.687348831596;4323.762193079411;4330.090680957034;4348.565143485626;4356.215881141425;6107.358727333743;6318.526110541636;6359.586626869239;6380.074889141141;6380.266269378895;6077.359113039543;6113.84715382119;6145.539084568586;6159.168512250789;6183.876322473615;6070.453659170696;6096.329403765671;6101.633901965896;6113.84715382119;6156.569040167325;5770.2689193242695;5879.118132280021;6018.8796224074395;6029.728662210299;6053.910296146736;6111.755529778937;6114.205153330038;6134.631922084689;6143;6152.969235153795;5852.302832178791;5911.91132133027;5993.220881285405;6019.277686677627;6045.244344456943 16:50:52 INFO - PROCESS | 4554 | |5;yui.html;660.1484085529664;708.0653537330722;715.3097261143002;783.525966790092;841.0832192909727;14399.712005759891;14993.62515937102;15085.019473734214;15097.84902150978;15333.616659583517;12605.30670813105;13717.862821371784;13876.37556309966;14009.719805603881;14317.713645727079;834.6619619054293;843.5234092737584;848.4145939301862;849.7663142635794;849.9532525711084;854.0349405172146;855.4140413816524;856.2593356746431;856.4133568505594;859.3168431097262;886.2821114896922;887.6138879587401;889.6752685269895;890.6971629645919;895.3463971300954;876.7413612984185;883.1742320929951;884.2748945864394;885.8981217160012;887.951162686052;653.6404977262534;654.0385633119307;654.3554598720257;655.6557807151236;656.4059526128862;12992.155509891922;13062.085654004224;13086.607401777866;13137.080404371698;13735.45058197671;12518.436670349856;12602.117851750381;12645.873541264562;12659.050571207197;12678.239305641691;10992.340459572451;11058.22592418531;11244.775104497947;11290.266132701348;11459;3804.353259945788;3818.923621527582;3820.4842346283176;3832.597577254376;3895.357266051098;75424;75570.62214688891;75626.24373756303;75703.24296757017;76169.23830761678;9452.149306562442;9495;9586.520673966274;9642.807143857084;9661.372010819274;18710.25158993652;18833.717494237597;18856.905715471334;18874.716879246822;18932.43202703921;7934.523928564305;8111.9594402027615;8158.102608713037;8191.139930307351;8314.459560128573;4507.4365704286965;4598.632109431237;4754.976225118852;4762.928556071662;4763.571278584944;3428.057284246852;3556.87550935716;3563.9287214256087;3565.6969157621893;3572.071261472036;626.9373062693694;653.3042309939899;654.9017647352936;679.7960611816534;682.4233522673333;815.2621877201143;828.494618282847;843.3337663245967;844.6494704697604;856.3063918226256;10023.225755332278;10268.897311026943;10314.690559283234;10328.793424131625;10414.323069000491;748.8015675845905;812.6505602590825;813.515958004986;829.6308142876483;840.4495055738502;4868.975655121772;4917;4940.728259945738;4965.453800081988;4995.675281106789;79683.20316796874;120682;122777;124375.3781231088;127051.3647431757;80250;89241;97311.51344243233;99406.5029674847;99936.50031749795;90253.09746902579;90314.54842725744;92287.07712922919;92437.5378123105;95104;9819.754506137118;9912.00879912003;10200.693979180636;10310.742231444274;10314.174866010851;54360.72819635877;54795;56486.71756641355;56916.43083569111;57218.42781572131;67467;67722;69848.30151698622;73730;77367;10717.196210284104;10867.836982445428;11062.668119956414;12256.693582660148;12822.358882056047;12666.683332916751;12927.870721292667;13793.448262069405;14325.426982920982;14665.120092794466;13763.174209547458;13783.448662053406;14029.649258768612;14042.297885105909;14046.367913444124;12966.157199781985;13210.867891320964;13335.866641333463;13430.328483575588;13489.39297731624;12967.675808104872;12985.155964862253;13070.80393794075;13406.195628262336;13526.39131239077;10674.786504269716;10945.671629851116;10956.233063685466;11237.943810280896;11446.42767861587;10163.644272450429;10603.204759642904;10621.89378106209;11129.499172537417;11276.32342059479 16:50:52 INFO - PROCESS | 4554 | __end_tp_report 16:50:52 INFO - PROCESS | 4554 | __start_cc_report 16:50:52 INFO - PROCESS | 4554 | _x_x_mozilla_cycle_collect,330 16:50:52 INFO - PROCESS | 4554 | __end_cc_report 16:50:52 INFO - PROCESS | 4554 | __startTimestamp1470095452853__endTimestamp 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | ------- Summary: start ------- 16:50:52 INFO - PROCESS | 4554 | Number of tests: 6 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#0] dojo.html Cycles:165 Average:5596.75 Median:5850.71 stddev:629.27 (10.8%) stddev-sans-first:605.99 16:50:52 INFO - PROCESS | 4554 | Values: 3349.0 3350.1 3378.3 3396.0 3401.8 5534.5 5552.3 5577.9 5631.0 5643.6 5576.9 5591.2 5639.2 5643.9 5652.3 5029.2 5075.2 5077.4 5118.5 5125.8 5006.2 5030.2 5113.5 5119.5 5141.0 4959.9 4981.8 5040.8 5053.0 5062.5 5085.5 5140.6 5146.1 5162.4 5164.5 4844.2 5060.9 5067.7 5116.5 5117.7 5370.8 5417.8 5439.7 5445.7 5451.1 5939.2 5976.8 5978.9 5989.9 6014.8 5899.4 5970.9 6047.9 6063.6 6088.9 5624.2 5682.0 5687.4 5692.2 5719.3 6177.3 6181.7 6185.5 6195.7 6205.5 5705.9 5788.7 5831.7 5933.7 5936.3 5981.9 5999.8 6004.2 6043.1 6046.6 5936.8 5949.8 5970.4 5971.0 6005.8 5824.8 5872.9 5885.3 5936.0 6019.6 4637.0 4639.6 4650.1 4654.3 4659.6 4111.4 4129.9 4138.6 4145.6 4177.0 5643.4 5722.4 5774.5 5795.6 5832.1 5942.3 5977.1 6052.1 6091.3 6125.7 5656.0 5849.2 5862.7 5863.6 5871.6 5141.4 5150.1 5197.0 5210.0 5292.7 6251.4 6293.2 6319.2 6328.2 6340.2 6076.3 6083.7 6088.7 6090.7 6109.9 6071.9 6188.6 6223.8 6269.1 6349.8 5921.0 5969.6 5973.3 5974.1 6009.0 5920.6 6112.7 6129.8 6131.1 6136.6 5841.9 5870.7 5910.1 5924.8 5958.8 5942.5 5945.8 5953.4 5954.3 5961.7 5679.7 5739.9 5836.6 5855.8 5871.9 5862.4 5917.3 5980.1 5988.6 5996.7 5842.1 5846.5 5850.7 5855.5 5870.2 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#1] ext.html Cycles:180 Average:64297.11 Median:225274.29 stddev:149249.71 (66.3%) stddev-sans-first:149591.75 16:50:52 INFO - PROCESS | 4554 | Values: 593.3 653.7 657.0 660.2 661.6 33223.7 36585.5 44944.3 45392.6 45429.8 46702.5 47085.5 47298.8 47300.3 47396.3 8992.1 9120.4 9136.5 9139.9 9156.1 8860.7 8913.4 8940.6 8944.8 8946.0 8927.2 8958.1 8963.9 8968.3 9004.1 8816.3 8873.5 8924.5 8931.3 8968.6 8904.1 8965.0 8993.3 9004.2 9042.7 43070.6 43340.1 43427.1 43607.6 43627.8 3502.7 3678.1 3726.5 3736.2 3844.4 33808.3 33958.0 34160.1 34170.5 34201.5 4723.6 4766.5 4831.3 5029.8 5042.0 355017.0 355980.0 356562.0 357272.0 357329.0 37106.0 37710.8 37739.1 63218.4 63956.7 38445.4 38568.0 38607.0 38625.2 38679.4 14070.0 14141.9 14149.3 14228.3 14250.1 11347.5 11554.8 11581.9 11605.3 11621.1 8900.0 9075.7 9087.3 9116.8 9137.3 3532.4 3566.5 3577.0 3584.5 3645.6 1045.5 1093.5 1124.2 1166.1 1206.8 32751.2 33189.0 33355.3 33503.3 33895.7 1084.4 1171.9 1207.9 1209.3 1236.5 17201.7 17202.4 17261.6 17400.4 17454.5 167515.0 847510.0 864770.0 896765.1 908963.0 58367.0 59101.7 59296.0 59303.4 59404.7 1438.6 1472.2 1473.6 1485.5 1507.4 29927.9 30418.0 30974.2 31064.5 31584.7 48413.0 49173.3 49230.5 49233.0 49271.0 396976.0 402393.0 403336.0 406048.0 408065.0 29051.1 29687.4 30452.4 31006.2 31168.4 50320.0 50634.2 51082.0 51094.5 52014.0 43222.4 43486.3 43736.8 44383.6 44601.8 42821.0 42979.3 43592.8 43832.6 44158.3 42483.6 42916.6 43961.6 44092.3 44124.6 37092.6 37670.4 37970.8 38304.6 38624.4 28948.7 29573.6 29595.6 29745.4 29985.9 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#2] jquery.html Cycles:180 Average:29610.97 Median:13359.14 stddev:85338.87 (638.8%) stddev-sans-first:85550.08 16:50:52 INFO - PROCESS | 4554 | Values: 401.1 406.8 408.3 411.4 415.2 16568.5 18834.2 20527.8 20654.8 20944.6 12940.6 13113.6 13384.8 13388.9 13474.4 5251.7 5415.1 5425.7 5435.1 5458.1 5049.5 5377.5 5381.7 5391.4 5394.0 5331.3 5339.3 5372.4 5373.0 5380.4 5422.5 5843.6 5874.1 5879.2 5899.7 5182.9 5316.6 5325.8 5339.8 5371.7 14285.8 14297.3 21221.0 24141.0 24266.5 2418.6 2451.8 2475.9 2478.9 2704.1 9972.7 10670.2 10891.2 14247.9 14286.2 1970.8 2044.3 2049.3 2055.5 2057.9 80627.0 84199.0 85293.6 85485.6 86005.1 11374.4 11485.9 11513.1 11656.4 11740.1 15949.8 16028.4 16102.8 16192.9 16205.0 7932.9 7940.1 7999.1 8012.9 8226.3 7447.0 7518.9 7519.3 7628.0 7718.1 4790.3 4839.1 4859.8 4915.1 4934.1 2047.6 2071.3 2083.3 2085.1 2124.2 905.4 977.7 1015.4 1066.3 1096.5 19336.0 19742.2 19758.4 19823.0 19903.7 980.2 1013.9 1027.3 1056.3 1062.7 10733.0 11081.2 11171.7 11175.1 11224.8 498928.0 514395.0 523533.0 523741.0 528676.0 90559.0 91885.5 93599.0 94286.0 94621.5 1046.8 1046.9 1062.1 1066.8 1072.7 17319.9 17331.1 17688.7 17761.6 17908.8 30097.0 38397.8 40272.0 41250.8 41549.4 55498.0 56473.4 57319.7 57718.4 57887.0 8896.9 8966.2 9163.0 9192.9 9286.8 12456.0 12631.2 12631.4 12743.6 12914.4 10801.5 11384.0 11406.5 11598.1 11819.4 10997.8 11079.4 11213.2 11631.1 11836.5 11840.5 12215.5 12228.3 12272.7 12387.0 9042.0 9054.5 9115.1 9187.0 9215.2 9321.4 11782.4 12007.7 12082.4 12183.6 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#3] mootools.html Cycles:180 Average:6205.98 Median:2522.87 stddev:3618.04 (143.4%) stddev-sans-first:3611.40 16:50:52 INFO - PROCESS | 4554 | Values: 1567.1 1606.7 1799.8 1890.0 1906.9 8343.3 9176.6 9301.8 9981.6 10005.1 9091.9 9288.2 9468.1 9543.3 9558.0 2365.6 2412.6 2420.1 2423.6 2427.6 2380.8 2458.4 2475.1 2484.7 2489.3 2404.2 2423.2 2434.7 2436.0 2454.7 2387.9 2389.1 2390.9 2391.9 2418.3 2367.1 2376.8 2380.4 2381.0 2394.3 9413.4 9569.9 9586.8 9591.7 9604.9 5480.6 5597.1 5610.0 5610.3 5623.1 3548.4 3596.3 3664.1 3675.7 3701.3 1172.5 1184.0 1217.7 1221.6 1226.1 13388.5 13562.1 13608.5 13642.1 13672.3 4777.3 4783.5 4859.1 4886.2 4910.2 11461.9 11475.1 11518.0 11518.1 11524.5 5505.5 5590.9 5597.9 5606.7 5618.5 4862.9 5020.4 5083.3 5091.2 5131.5 3862.5 3904.0 3934.8 3952.7 3959.9 1137.7 1144.7 1147.6 1156.5 1182.6 991.4 996.9 1004.8 1014.3 1025.8 6172.4 6338.3 6422.2 6528.4 6551.4 452.8 455.9 463.7 464.8 468.7 4376.4 4511.6 4561.3 4574.5 4582.1 11064.8 11291.6 11309.7 11338.7 11369.1 11106.6 11237.8 11244.2 11245.2 11262.2 8586.0 8926.6 8937.2 9212.0 9223.7 6139.7 6341.5 6418.8 6484.3 6491.1 10610.4 10897.1 11008.1 11138.1 11145.3 11156.8 11356.0 11397.1 11405.7 11446.3 8104.0 8212.7 8295.5 8357.5 8532.7 9318.3 9359.0 9367.9 9410.6 9411.9 8109.6 8409.6 8431.8 8462.5 8552.6 8145.9 8155.1 8173.6 8177.0 8243.6 7182.6 7471.0 7541.1 7563.8 7594.7 5473.1 5535.2 5559.9 5592.9 5634.4 5341.9 5367.0 5410.8 5424.1 5532.1 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#4] prototype.html Cycles:180 Average:5059.85 Median:5882.38 stddev:1545.61 (26.3%) stddev-sans-first:1508.46 16:50:52 INFO - PROCESS | 4554 | Values: 320.4 322.1 330.5 338.3 342.4 5822.9 5843.9 5850.3 5868.9 5896.5 5690.5 5751.3 5757.8 5763.5 5792.2 4196.1 4288.1 4296.9 4314.4 4349.3 4263.8 4279.5 4304.5 4338.7 4342.9 4281.7 4296.5 4319.0 4321.0 4324.0 4172.9 4270.7 4289.6 4297.8 4339.8 3672.2 3680.0 3683.9 3698.1 3704.0 5528.8 5529.4 5534.5 5554.9 5581.1 4828.2 4957.1 4966.8 4973.5 5013.9 5918.4 5941.5 5952.5 5971.8 6034.3 4093.9 4098.9 4117.4 4118.8 4128.9 6127.3 6206.2 6276.4 6277.0 6282.8 4285.5 4289.2 4293.8 4293.9 4298.3 4322.5 4333.0 4344.5 4366.6 4414.7 4897.5 4976.0 4979.3 4992.2 5045.4 5994.4 5995.0 6023.8 6031.4 6036.8 1485.3 1506.7 1516.5 1522.4 1526.5 946.1 949.1 989.0 991.5 1013.4 5850.4 5867.6 5897.9 5900.0 5904.9 6148.5 6194.9 6202.3 6203.8 6257.3 5607.3 5885.6 5923.2 5960.2 5960.8 3312.6 3316.4 3322.7 3329.8 3336.3 6227.4 6460.7 6462.9 6467.9 6516.3 6313.8 6334.4 6342.7 6353.1 6365.6 6215.9 6488.5 6544.9 6556.6 6596.0 6242.5 6269.2 6271.0 6277.8 6287.7 6184.3 6194.4 6206.4 6218.1 6226.3 6338.8 6506.4 6526.9 6532.2 6534.2 4282.7 4323.8 4330.1 4348.6 4356.2 6107.4 6318.5 6359.6 6380.1 6380.3 6077.4 6113.8 6145.5 6159.2 6183.9 6070.5 6096.3 6101.6 6113.8 6156.6 5770.3 5879.1 6018.9 6029.7 6053.9 6111.8 6114.2 6134.6 6143.0 6153.0 5852.3 5911.9 5993.2 6019.3 6045.2 16:50:52 INFO - PROCESS | 4554 | 16:50:52 INFO - PROCESS | 4554 | [#5] yui.html Cycles:180 Average:20482.30 Median:4763.25 stddev:30071.67 (631.3%) stddev-sans-first:30119.19 16:50:52 INFO - PROCESS | 4554 | Values: 660.1 708.1 715.3 783.5 841.1 14399.7 14993.6 15085.0 15097.8 15333.6 12605.3 13717.9 13876.4 14009.7 14317.7 834.7 843.5 848.4 849.8 850.0 854.0 855.4 856.3 856.4 859.3 886.3 887.6 889.7 890.7 895.3 876.7 883.2 884.3 885.9 888.0 653.6 654.0 654.4 655.7 656.4 12992.2 13062.1 13086.6 13137.1 13735.5 12518.4 12602.1 12645.9 12659.1 12678.2 10992.3 11058.2 11244.8 11290.3 11459.0 3804.4 3818.9 3820.5 3832.6 3895.4 75424.0 75570.6 75626.2 75703.2 76169.2 9452.1 9495.0 9586.5 9642.8 9661.4 18710.3 18833.7 18856.9 18874.7 18932.4 7934.5 8112.0 8158.1 8191.1 8314.5 4507.4 4598.6 4755.0 4762.9 4763.6 3428.1 3556.9 3563.9 3565.7 3572.1 626.9 653.3 654.9 679.8 682.4 815.3 828.5 843.3 844.6 856.3 10023.2 10268.9 10314.7 10328.8 10414.3 748.8 812.7 813.5 829.6 840.4 4869.0 4917.0 4940.7 4965.5 4995.7 79683.2 120682.0 122777.0 124375.4 127051.4 80250.0 89241.0 97311.5 99406.5 99936.5 90253.1 90314.5 92287.1 92437.5 95104.0 9819.8 9912.0 10200.7 10310.7 10314.2 54360.7 54795.0 56486.7 56916.4 57218.4 67467.0 67722.0 69848.3 73730.0 77367.0 10717.2 10867.8 11062.7 12256.7 12822.4 12666.7 12927.9 13793.4 14325.4 14665.1 13763.2 13783.4 14029.6 14042.3 14046.4 12966.2 13210.9 13335.9 13430.3 13489.4 12967.7 12985.2 13070.8 13406.2 13526.4 10674.8 10945.7 10956.2 11237.9 11446.4 10163.6 10603.2 10621.9 11129.5 11276.3 16:50:52 INFO - PROCESS | 4554 | -------- Summary: end -------- 16:50:52 INFO - PROCESS | 4554 | 16:50:53 INFO - TEST-INFO | 4554: exit 0 16:50:53 INFO - TEST-OK | dromaeo_css | took 1109447ms 16:50:53 INFO - TEST-START | kraken 16:50:53 INFO - operating with platform_type : linux_ 16:50:53 INFO - Initialising browser for kraken test... 16:50:53 INFO - TEST-INFO | started process 4796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeysR9b/profile http://localhost:43576/getInfo.html) 16:50:57 INFO - PROCESS | 4796 | __metrics Screen width/height:1600/1200 16:50:57 INFO - PROCESS | 4796 | colorDepth:24 16:50:57 INFO - PROCESS | 4796 | Browser inner width/height: 1024/697 16:50:57 INFO - PROCESS | 4796 | __metrics 16:50:58 ERROR - PROCESS | 4796 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:50:59 INFO - TEST-INFO | 4796: exit 0 16:50:59 INFO - Browser initialized. 16:50:59 INFO - Running cycle 1/1 for kraken test... 16:50:59 INFO - TEST-INFO | started process 4926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeysR9b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:10 INFO - PROCESS | 4926 | RSS: Main: 152543232 16:51:10 INFO - PROCESS | 4926 | 16:51:13 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:14 INFO - PROCESS | 4926 | RSS: Main: 158040064 16:51:14 INFO - PROCESS | 4926 | 16:51:16 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-dft) 16:51:17 INFO - PROCESS | 4926 | RSS: Main: 156917760 16:51:17 INFO - PROCESS | 4926 | 16:51:20 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-fft) 16:51:20 INFO - PROCESS | 4926 | RSS: Main: 157974528 16:51:20 INFO - PROCESS | 4926 | 16:51:23 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-oscillator) 16:51:23 INFO - PROCESS | 4926 | RSS: Main: 157855744 16:51:23 INFO - PROCESS | 4926 | 16:51:25 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:26 INFO - PROCESS | 4926 | RSS: Main: 157786112 16:51:26 INFO - PROCESS | 4926 | 16:51:29 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:30 INFO - PROCESS | 4926 | RSS: Main: 156770304 16:51:30 INFO - PROCESS | 4926 | 16:51:33 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:34 INFO - PROCESS | 4926 | RSS: Main: 157315072 16:51:34 INFO - PROCESS | 4926 | 16:51:36 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43576/tests/kraken/driver.html?testName=json-parse-financial) 16:51:37 INFO - PROCESS | 4926 | RSS: Main: 158433280 16:51:37 INFO - PROCESS | 4926 | 16:51:39 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:39 INFO - PROCESS | 4926 | RSS: Main: 158105600 16:51:39 INFO - PROCESS | 4926 | 16:51:41 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:42 INFO - PROCESS | 4926 | RSS: Main: 157917184 16:51:42 INFO - PROCESS | 4926 | 16:51:44 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:44 INFO - PROCESS | 4926 | RSS: Main: 158052352 16:51:44 INFO - PROCESS | 4926 | 16:51:47 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:47 INFO - PROCESS | 4926 | RSS: Main: 158490624 16:51:47 INFO - PROCESS | 4926 | 16:51:50 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:51 INFO - PROCESS | 4926 | RSS: Main: 158285824 16:51:51 INFO - PROCESS | 4926 | 16:51:52 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43576/tests/kraken/driver.html?testName=ai-astar) 16:51:53 INFO - PROCESS | 4926 | RSS: Main: 158855168 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | __start_tp_report 16:51:53 INFO - PROCESS | 4926 | _x_x_mozilla_page_load 16:51:53 INFO - PROCESS | 4926 | _x_x_mozilla_page_load_details 16:51:53 INFO - PROCESS | 4926 | |i|pagename|runs| 16:51:53 INFO - PROCESS | 4926 | |0;ai-astar;111;104;111;111;114;112;110;111;111;111 16:51:53 INFO - PROCESS | 4926 | |1;audio-beat-detection;150;126;156;186;124;152;153;125;179;125 16:51:53 INFO - PROCESS | 4926 | |2;audio-dft;164;162;162;161;162;164;162;159;164;162 16:51:53 INFO - PROCESS | 4926 | |3;audio-fft;75;75;75;169;76;76;75;76;167;76 16:51:53 INFO - PROCESS | 4926 | |4;audio-oscillator;85;85;138;86;84;84;130;85;85;152 16:51:53 INFO - PROCESS | 4926 | |5;imaging-gaussian-blur;117;117;117;118;116;118;118;117;118;117 16:51:53 INFO - PROCESS | 4926 | |6;imaging-darkroom;150;146;146;146;147;147;148;148;146;146 16:51:53 INFO - PROCESS | 4926 | |7;imaging-desaturate;95;95;95;97;95;94;94;96;96;96 16:51:53 INFO - PROCESS | 4926 | |8;json-parse-financial;53;54;52;53;55;53;55;54;54;52 16:51:53 INFO - PROCESS | 4926 | |9;json-stringify-tinderbox;59;60;59;59;59;59;59;60;60;60 16:51:53 INFO - PROCESS | 4926 | |10;stanford-crypto-aes;75;83;78;76;78;77;77;82;107;77 16:51:53 INFO - PROCESS | 4926 | |11;stanford-crypto-ccm;122;121;138;129;128;121;135;124;121;121 16:51:53 INFO - PROCESS | 4926 | |12;stanford-crypto-pbkdf2;159;156;157;159;155;153;153;160;161;158 16:51:53 INFO - PROCESS | 4926 | |13;stanford-crypto-sha256-iterative;68;62;62;63;64;63;62;61;62;63 16:51:53 INFO - PROCESS | 4926 | __end_tp_report 16:51:53 INFO - PROCESS | 4926 | __start_cc_report 16:51:53 INFO - PROCESS | 4926 | _x_x_mozilla_cycle_collect,847 16:51:53 INFO - PROCESS | 4926 | __end_cc_report 16:51:53 INFO - PROCESS | 4926 | __startTimestamp1470095513051__endTimestamp 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | ------- Summary: start ------- 16:51:53 INFO - PROCESS | 4926 | Number of tests: 14 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.55 (2.3%) stddev-sans-first:2.70 16:51:53 INFO - PROCESS | 4926 | Values: 111.0 104.0 111.0 111.0 114.0 112.0 110.0 111.0 111.0 111.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.50 stddev:22.68 (14.9%) stddev-sans-first:24.04 16:51:53 INFO - PROCESS | 4926 | Values: 150.0 126.0 156.0 186.0 124.0 152.0 153.0 125.0 179.0 125.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.50 16:51:53 INFO - PROCESS | 4926 | Values: 164.0 162.0 162.0 161.0 162.0 164.0 162.0 159.0 164.0 162.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.01 (51.7%) stddev-sans-first:40.76 16:51:53 INFO - PROCESS | 4926 | Values: 75.0 75.0 75.0 169.0 76.0 76.0 75.0 76.0 167.0 76.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:85.00 stddev:27.15 (31.9%) stddev-sans-first:28.15 16:51:53 INFO - PROCESS | 4926 | Values: 85.0 85.0 138.0 86.0 84.0 84.0 130.0 85.0 85.0 152.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:51:53 INFO - PROCESS | 4926 | Values: 117.0 117.0 117.0 118.0 116.0 118.0 118.0 117.0 118.0 117.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.33 (0.9%) stddev-sans-first:0.87 16:51:53 INFO - PROCESS | 4926 | Values: 150.0 146.0 146.0 146.0 147.0 147.0 148.0 148.0 146.0 146.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 16:51:53 INFO - PROCESS | 4926 | Values: 95.0 95.0 95.0 97.0 95.0 94.0 94.0 96.0 96.0 96.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 16:51:53 INFO - PROCESS | 4926 | Values: 53.0 54.0 52.0 53.0 55.0 53.0 55.0 54.0 54.0 52.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:51:53 INFO - PROCESS | 4926 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 60.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:77.50 stddev:9.48 (12.2%) stddev-sans-first:9.80 16:51:53 INFO - PROCESS | 4926 | Values: 75.0 83.0 78.0 76.0 78.0 77.0 77.0 82.0 107.0 77.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:6.31 (5.0%) stddev-sans-first:6.52 16:51:53 INFO - PROCESS | 4926 | Values: 122.0 121.0 138.0 129.0 128.0 121.0 135.0 124.0 121.0 121.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:158.50 stddev:2.81 (1.8%) stddev-sans-first:2.89 16:51:53 INFO - PROCESS | 4926 | Values: 159.0 156.0 157.0 159.0 155.0 153.0 153.0 160.0 161.0 158.0 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - PROCESS | 4926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.94 (3.1%) stddev-sans-first:0.88 16:51:53 INFO - PROCESS | 4926 | Values: 68.0 62.0 62.0 63.0 64.0 63.0 62.0 61.0 62.0 63.0 16:51:53 INFO - PROCESS | 4926 | -------- Summary: end -------- 16:51:53 INFO - PROCESS | 4926 | 16:51:53 INFO - TEST-INFO | 4926: exit 0 16:51:53 INFO - TEST-OK | kraken | took 60442ms 16:51:53 INFO - SUITE-END | took 1169s 16:51:54 INFO - Completed test suite (00:19:30) 16:51:54 INFO - javascript benchmark 16:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7403.604794446612, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.0287816533205, 3350.09547422196, 3378.290558982614, 3395.9660403395974, 3401.8469168887395, 5534.535943536553, 5552.250446189763, 5577.912307100112, 5631.0, 5643.5767317451255, 5576.86057848554, 5591.161325801122, 5639.238702775124, 5643.887122257563, 5652.293463317085, 5029.170186919154, 5075.187969924795, 5077.365329333833, 5118.513741194581, 5125.846224613268, 5006.249062640615, 5030.245463180516, 5113.463086375933, 5119.513646203604, 5141.048905952411, 4959.900801983958, 4981.750912454381, 5040.848774536751, 5053.0, 5062.519060689228, 5085.5423011928915, 5140.614453915971, 5146.073706732768, 5162.354705661793, 5164.509371609691, 4844.249141383091, 5060.924086138711, 5067.721275329855, 5116.539511443951, 5117.667351622133, 5370.812021579226, 5417.83746487606, 5439.700816455093, 5445.727713614343, 5451.100568406208, 5939.177812765398, 5976.7908123215475, 5978.8505287367725, 5989.880202395928, 6014.75940962361, 5899.439553242435, 5970.910436343458, 6047.909281360783, 6063.636181829104, 6088.878222435571, 5624.15637654351, 5681.971590142064, 5687.40282270364, 5692.17463467799, 5719.3136823581435, 6177.320494745574, 6181.721822517998, 6185.536084793568, 6195.659238741912, 6205.5345849061505, 5705.885882282331, 5788.739506722208, 5831.708414579339, 5933.732982015733, 5936.347001829795, 5981.880362392728, 5999.820005399845, 6004.249468816398, 6043.063325184604, 6046.576739628272, 5936.7922122725495, 5949.762009519657, 5970.373110823388, 5970.9701451492465, 6005.789797357072, 5824.825255242265, 5872.941270587239, 5885.264341957255, 5935.970320148372, 6019.608725432833, 4637.049404871993, 4639.559241872017, 4650.116477869262, 4654.325122857167, 4659.603933665609, 4111.403846442249, 4129.91740165201, 4138.627523522898, 4145.626893579592, 4177.039280965395, 5643.379228284885, 5722.399148089474, 5774.538036957033, 5795.623284486495, 5832.125181222766, 5942.286925568959, 5977.133315669291, 6052.092186172109, 6091.299500557404, 6125.663088530174, 5655.971720141373, 5849.151872978479, 5862.677552734641, 5863.560232982543, 5871.6183448075735, 5141.408737995103, 5150.098732721759, 5196.9740151299, 5210.0, 5292.655977361459, 6251.429366902311, 6293.181886354744, 6319.24169099711, 6328.240611126695, 6340.175777148941, 6076.3012253591405, 6083.66539840313, 6088.665123418077, 6090.665013424305, 6109.9002179607205, 6071.878562428638, 6188.597741146991, 6223.844403889939, 6269.0909818075215, 6349.809505714836, 5920.970395147997, 5969.552283578662, 5973.313068997121, 5974.074018527135, 6009.038553831366, 5920.585559010828, 6112.72492737819, 6129.785457508966, 6131.110988906673, 6136.631802091889, 5841.883162336814, 5870.735816888165, 5910.083936989773, 5924.7926322578505, 5958.821235362946, 5942.494887934401, 5945.762169513171, 5953.434423729739, 5954.345022047658, 5961.701914904324, 5679.74441150141, 5739.942600574108, 5836.591438599257, 5855.765769369177, 5871.882562348815, 5862.355140934408, 5917.319508256605, 5980.073088671263, 5988.580799344179, 5996.700164991646, 5842.123681447647, 5846.503047240862, 5850.707464626837, 5855.502282306052, 5870.17817505541], "value": 5555.553366436311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.3206478582024, 653.6894974886926, 657.0440009785763, 660.1714847865925, 661.6294874870075, 33223.66776332236, 36585.45121823175, 44944.3258351125, 45392.63822085338, 45429.7728511357, 46702.53297467024, 47085.52914470863, 47298.763506182506, 47300.290495642505, 47396.289055664194, 8992.145746154105, 9120.361574689774, 9136.451812891215, 9139.908600914005, 9156.084391560824, 8860.689875854347, 8913.420627659214, 8940.64237430502, 8944.821103577924, 8946.0, 8927.151920567569, 8958.148975847316, 8963.865542016874, 8968.282537396992, 9004.054574269705, 8816.294696424302, 8873.467591944504, 8924.509151996637, 8931.330150238726, 8968.551572421386, 8904.065073167289, 8965.0, 8993.280537557046, 9004.189622933902, 9042.728718138467, 43070.56929430728, 43340.13319733619, 43427.13145737068, 43607.56392436067, 43627.78186109081, 3502.702270307027, 3678.1356381250653, 3726.4782930389765, 3736.196717705679, 3844.38489841624, 33808.323833523435, 33958.0, 34160.14599635029, 34170.487442688376, 34201.48697769511, 4723.645726570521, 4766.52334766524, 4831.299461578052, 5029.84910452687, 5042.0168067226905, 355017.0, 355980.0, 356562.0, 357272.0, 357329.0, 37106.0, 37710.81144594259, 37739.05652358658, 63218.36781632217, 63956.68021659862, 38445.423318650246, 38568.0, 38607.0, 38625.22749544994, 38679.41980870289, 14070.0, 14141.929290353688, 14149.29253537319, 14228.28858557068, 14250.073745206528, 11347.489362978686, 11554.826677599844, 11581.88418115808, 11605.30368177912, 11621.128415368712, 8900.0, 9075.727728168165, 9087.273018158532, 9116.817663646823, 9137.314701397421, 3532.4171511700797, 3566.465030245484, 3576.9595843533307, 3584.462330650423, 3645.5989841117457, 1045.4563626913962, 1093.469885007374, 1124.1681155944705, 1166.0787977497682, 1206.843110395643, 32751.18122046968, 33189.0, 33355.332893342, 33503.3299334012, 33895.661043389744, 1084.4415126210008, 1171.917965742407, 1207.8731733168067, 1209.2623499665197, 1236.4930378544934, 17201.655966880844, 17202.397916072878, 17261.56846078833, 17400.39098631542, 17454.476365708793, 167515.0, 847510.0, 864770.0, 896765.0646987024, 908963.0, 58367.0, 59101.70449147727, 59296.0, 59303.40696592979, 59404.70297648571, 1438.6475313548249, 1472.1976522795317, 1473.6094934842276, 1485.532057401915, 1507.3744396075506, 29927.85036074893, 30418.0, 30974.22564435907, 31064.534031989086, 31584.684153159094, 48413.0, 49173.26240106473, 49230.507694924025, 49233.0, 49271.0, 396976.0, 402393.0, 403336.0, 406048.0, 408065.0, 29051.12846614605, 29687.406251875273, 30452.390952181275, 31006.22484437907, 31168.376632467676, 50320.0, 50634.240486391995, 51082.0, 51094.48905510897, 52014.0, 43222.351664724425, 43486.34770478508, 43736.78131609321, 44383.55616443924, 44601.77699111614, 42821.0, 42979.28082876775, 43592.782036089615, 43832.56167438285, 44158.33762493629, 42483.57516424796, 42916.570834292506, 43961.56038439574, 44092.33861492144, 44124.55875441204, 37092.62907371, 37670.434943475324, 37970.81014594909, 38304.616953830104, 38624.42063369108, 28948.710512894602, 29573.556396653636, 29595.60838073953, 29745.405091898472, 29985.850070749508], "value": 19537.28449442273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.0935286253067, 406.8291317646588, 408.2997659014789, 411.41373542701655, 415.21317104087757, 16568.50294491164, 18834.15246313916, 20527.794722052775, 20654.793452065474, 20944.581108377824, 12940.611781646543, 13113.606591802261, 13384.799228011587, 13388.93305533471, 13474.393652285646, 5251.711155886424, 5415.079436495806, 5425.701586412746, 5435.130379139338, 5458.1266997280445, 5049.4698056704065, 5377.46225377463, 5381.704006279653, 5391.379991301012, 5394.02907476656, 5331.253624492574, 5339.305890234284, 5372.435894231088, 5373.0, 5380.408155102936, 5422.53908417785, 5843.561732870052, 5874.118882167666, 5879.176915231871, 5899.73451194693, 5182.896342073137, 5316.627836051478, 5325.813596524103, 5339.839804805862, 5371.677699338014, 14285.78571321431, 14297.285135743276, 21221.045052972655, 24141.034358625635, 24266.514669706685, 2418.6492958520917, 2451.767082127195, 2475.8885850136785, 2478.876056197201, 2704.1346769033917, 9972.700818975442, 10670.199735019827, 10891.183161262938, 14247.928760356235, 14286.214258215794, 1970.8324792392664, 2044.2947183221765, 2049.2929939170963, 2055.496403381166, 2057.86623869448, 80627.0, 84199.0, 85293.57353213194, 85485.57257213673, 86005.13994860034, 11374.431278436045, 11485.942570287096, 11513.078953683686, 11656.358900260397, 11740.119491038206, 15949.760753588705, 16028.358865645478, 16102.75845862313, 16192.919035404748, 16205.0, 7932.920670793334, 7940.0868900076075, 7999.080105787909, 8012.879806802903, 8226.341892648574, 7446.962765186139, 7518.924810751932, 7519.285667861654, 7627.961860190663, 7718.112417071996, 4790.329353890458, 4839.080574690868, 4859.805607775649, 4915.090708218991, 4934.062528119646, 2047.6109539187805, 2071.3475255294534, 2083.2812679625504, 2085.0929845516944, 2124.2458927080665, 905.3933864310927, 977.6675930183771, 1015.3958394755109, 1066.3069005146563, 1096.5415996724496, 19336.0, 19742.210311587376, 19758.40724778259, 19823.0, 19903.701444478345, 980.2060331131806, 1013.9391636501833, 1027.3219675014454, 1056.3187292286375, 1062.6705721226444, 10733.0, 11081.224314297922, 11171.72070698239, 11175.10599152082, 11224.775504489864, 498928.0, 514395.0, 523533.0, 523741.0, 528676.0, 90559.0, 91885.54057229671, 93599.0, 94286.0, 94621.5268923651, 1046.8011077895176, 1046.8796088449926, 1062.0706881478707, 1066.7599790047332, 1072.7157303314627, 17319.913400432917, 17331.13344332753, 17688.73466897972, 17761.644767104845, 17908.820911790714, 30097.0, 38397.808010960885, 40272.0, 41250.79374603108, 41549.37675934803, 55498.0, 56473.43526564682, 57319.7134014344, 57718.42281577131, 57887.0, 8896.866547001671, 8966.23786978088, 9163.0, 9192.942811576755, 9286.814263714552, 12456.0, 12631.178973366701, 12631.368431578569, 12743.553975610808, 12914.418851151533, 10801.513931873242, 11384.0, 11406.543738250377, 11598.072154227473, 11819.409029548317, 10997.835032474359, 11079.446027698745, 11213.15901307389, 11631.127665424958, 11836.46735896904, 11840.45430232504, 12215.511379544718, 12228.266304021787, 12272.693182670148, 12387.0, 9041.954790226007, 9054.502002389669, 9115.088491150831, 9187.0, 9215.216706580015, 9321.39410938314, 11782.410879455821, 12007.699807504881, 12082.395880205779, 12183.573574925189], "value": 9198.692759052634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1567.1380740592672, 1606.7348887433573, 1799.8110198429165, 1890.0, 1906.8855868647881, 8343.290820280268, 9176.632934682604, 9301.7674558136, 9981.600735970562, 10005.099541041305, 9091.863622045657, 9288.164065234128, 9468.053194680546, 9543.284253680968, 9557.952210238938, 2365.6451532270166, 2412.6381042843536, 2420.1045613123083, 2423.624338227569, 2427.5630386530415, 2380.797632201265, 2458.385403649088, 2475.0718480569785, 2484.6645702830156, 2489.2781093482868, 2404.2426635609813, 2423.164008417093, 2434.7200071991683, 2436.0377650827913, 2454.6931633545805, 2387.8806059696944, 2389.1160270699866, 2390.8565486070806, 2391.904323827036, 2418.2503423938633, 2367.0886708617136, 2376.750441203666, 2380.416797884512, 2380.9642855357183, 2394.257780088178, 9413.38812977161, 9569.856452153223, 9586.760330991781, 9591.664291749756, 9604.855927161097, 5480.561555075585, 5597.076482380402, 5609.971950140264, 5610.326760788732, 5623.100303951389, 3548.361294966905, 3596.28074385124, 3664.120611053355, 3675.72432067596, 3701.2967536168044, 1172.4606680926784, 1183.9644810655693, 1217.713837248246, 1221.6212973978006, 1226.1355744200407, 13388.464461421532, 13562.118462300017, 13608.523701670492, 13642.113262637897, 13672.31638418075, 4777.3072904429355, 4783.545563171493, 4859.1496488114435, 4886.169351210303, 4910.21436570147, 11461.885381146249, 11475.139364547693, 11518.0, 11518.136139789549, 11524.481398337095, 5505.532029777433, 5590.888182236333, 5597.916031259534, 5606.663600183921, 5618.494335509824, 4862.927056094161, 5020.3724534433195, 5083.262926875656, 5091.159958606789, 5131.461196574306, 3862.497875276252, 3904.0, 3934.803259836997, 3952.664023557972, 3959.9010024749036, 1137.698509894862, 1144.7424329525957, 1147.5983405807901, 1156.4506859241792, 1182.5683625476638, 991.3556188477403, 996.8853581838182, 1004.7842111045717, 1014.3153371474225, 1025.8102251083574, 6172.413620706116, 6338.30278669346, 6422.2293324800385, 6528.37980391862, 6551.377619126175, 452.82266108118625, 455.9270516717309, 463.6707937364442, 464.7861983487566, 468.7117422784963, 4376.409184760017, 4511.639068874482, 4561.29299958507, 4574.45106587205, 4582.060677561092, 11064.834027489595, 11291.604793832177, 11309.71725706864, 11338.659840204808, 11369.147313951487, 11106.555737770399, 11237.83143252852, 11244.156688248415, 11245.212835101463, 11262.155338349656, 8585.957070214608, 8926.553672316488, 8937.195652391316, 9212.0, 9223.677171299107, 6139.72371243304, 6341.460975817107, 6418.839529011812, 6484.254310754135, 6491.058796474579, 10610.416427096583, 10897.128229741444, 11008.119350452105, 11138.10895128404, 11145.275557088764, 11156.776864462827, 11355.97796198346, 11397.145214108808, 11405.714857128307, 11446.313221206754, 8103.959480202561, 8212.712555060543, 8295.543745094077, 8357.498550087013, 8532.701355452778, 9318.254539636948, 9359.0, 9367.906320936976, 9410.635457858436, 9411.858822117536, 8109.59452027408, 8409.621567029377, 8431.831363372576, 8462.534560599226, 8552.572371381282, 8145.877811832946, 8155.1437099106115, 8173.591320433836, 8177.018757749108, 8243.629036693243, 7182.569045857265, 7471.0, 7541.132769731332, 7563.773086807405, 7594.734184303523, 5473.124300111963, 5535.225068490495, 5559.916601251065, 5592.916106258491, 5634.408387119293, 5341.893162136813, 5367.0, 5410.83767486976, 5424.077906755782, 5532.1425179097305], "value": 4828.906689763902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.4344332253572, 322.13185465171375, 330.5454999375858, 338.2879039621595, 342.4213079894979, 5822.9417705822925, 5843.853903652411, 5850.250382320308, 5868.943590153771, 5896.5282777377815, 5690.5447564194865, 5751.338596061454, 5757.769689212437, 5763.510101641355, 5792.189093526909, 4196.139791342775, 4288.078063216408, 4296.914061718764, 4314.37441570972, 4349.282368409209, 4263.8081286342185, 4279.48646162461, 4304.483461984566, 4338.739675619473, 4342.934855977162, 4281.67887408444, 4296.5273819879785, 4318.956810431887, 4320.97839510802, 4324.0, 4172.935901345168, 4270.743755374688, 4289.562996396211, 4297.77513408677, 4339.804708788112, 3672.247189326182, 3680.043188770912, 3683.889483315505, 3698.0754811297174, 3704.0, 5528.778848846041, 5529.424114127454, 5534.501894829485, 5554.944450555483, 5581.134924086773, 4828.179209534387, 4957.082939656139, 4966.776495057731, 4973.477784832613, 5013.949860501385, 5918.437748413894, 5941.494972927307, 5952.494038006775, 5971.790437538095, 6034.275886893601, 4093.9385909211387, 4098.897527561805, 4117.402976568381, 4118.835246590133, 4128.91742165158, 6127.264728232596, 6206.190202593027, 6276.403741644536, 6277.0, 6282.811515654537, 4285.485741710952, 4289.198536614629, 4293.785310734451, 4293.914121717548, 4298.290782020994, 4322.481302243751, 4333.0, 4344.522102568715, 4366.607005369532, 4414.713043652217, 4897.534734200245, 4975.950240497621, 4979.253112033224, 4992.201247800334, 5045.445001049881, 5994.400559944058, 5995.010823214121, 6023.849403764941, 6031.42701443371, 6036.758529658764, 1485.3241774992352, 1506.7438535449, 1516.4616561120863, 1522.439499513008, 1526.5496678479876, 946.129560804062, 949.1268033409142, 988.9554970026367, 991.4943378876825, 1013.3615822032073, 5850.4149585042005, 5867.589268751147, 5897.911531327033, 5899.970500147472, 5904.852378690567, 6148.479123559408, 6194.862772343534, 6202.28673702521, 6203.7828675996125, 6257.342978987232, 5607.327120745536, 5885.646861188342, 5923.20914614647, 5960.165576819162, 5960.821175364746, 3312.585926759155, 3316.35331110436, 3322.7175690066133, 3329.783564068328, 3336.282699219679, 6227.408396202353, 6460.741570337228, 6462.870742585122, 6467.902981455282, 6516.2506311773805, 6313.779017734358, 6334.429901308904, 6342.746290148435, 6353.078803573456, 6365.61806291624, 6215.906761398493, 6488.513361497812, 6544.934550654432, 6556.6396097404895, 6595.967020164964, 6242.534198991464, 6269.185005949197, 6271.027990661455, 6277.811665650038, 6287.685615719287, 6184.257889053342, 6194.4115309045565, 6206.379362063757, 6218.139655758221, 6226.3151053385, 6338.82731694638, 6506.3818937200895, 6526.869462610816, 6532.248791389051, 6534.215894092739, 4282.687348831596, 4323.762193079411, 4330.090680957034, 4348.565143485626, 4356.215881141425, 6107.358727333743, 6318.526110541636, 6359.586626869239, 6380.074889141141, 6380.266269378895, 6077.359113039543, 6113.84715382119, 6145.539084568586, 6159.168512250789, 6183.876322473615, 6070.453659170696, 6096.329403765671, 6101.633901965896, 6113.84715382119, 6156.569040167325, 5770.2689193242695, 5879.118132280021, 6018.8796224074395, 6029.728662210299, 6053.910296146736, 6111.755529778937, 6114.205153330038, 6134.631922084689, 6143.0, 6152.969235153795, 5852.302832178791, 5911.91132133027, 5993.220881285405, 6019.277686677627, 6045.244344456943], "value": 4556.579800654831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.1484085529664, 708.0653537330722, 715.3097261143002, 783.525966790092, 841.0832192909727, 14399.712005759891, 14993.62515937102, 15085.019473734214, 15097.84902150978, 15333.616659583517, 12605.30670813105, 13717.862821371784, 13876.37556309966, 14009.719805603881, 14317.713645727079, 834.6619619054293, 843.5234092737584, 848.4145939301862, 849.7663142635794, 849.9532525711084, 854.0349405172146, 855.4140413816524, 856.2593356746431, 856.4133568505594, 859.3168431097262, 886.2821114896922, 887.6138879587401, 889.6752685269895, 890.6971629645919, 895.3463971300954, 876.7413612984185, 883.1742320929951, 884.2748945864394, 885.8981217160012, 887.951162686052, 653.6404977262534, 654.0385633119307, 654.3554598720257, 655.6557807151236, 656.4059526128862, 12992.155509891922, 13062.085654004224, 13086.607401777866, 13137.080404371698, 13735.45058197671, 12518.436670349856, 12602.117851750381, 12645.873541264562, 12659.050571207197, 12678.239305641691, 10992.340459572451, 11058.22592418531, 11244.775104497947, 11290.266132701348, 11459.0, 3804.353259945788, 3818.923621527582, 3820.4842346283176, 3832.597577254376, 3895.357266051098, 75424.0, 75570.62214688891, 75626.24373756303, 75703.24296757017, 76169.23830761678, 9452.149306562442, 9495.0, 9586.520673966274, 9642.807143857084, 9661.372010819274, 18710.25158993652, 18833.717494237597, 18856.905715471334, 18874.716879246822, 18932.43202703921, 7934.523928564305, 8111.9594402027615, 8158.102608713037, 8191.139930307351, 8314.459560128573, 4507.4365704286965, 4598.632109431237, 4754.976225118852, 4762.928556071662, 4763.571278584944, 3428.057284246852, 3556.87550935716, 3563.9287214256087, 3565.6969157621893, 3572.071261472036, 626.9373062693694, 653.3042309939899, 654.9017647352936, 679.7960611816534, 682.4233522673333, 815.2621877201143, 828.494618282847, 843.3337663245967, 844.6494704697604, 856.3063918226256, 10023.225755332278, 10268.897311026943, 10314.690559283234, 10328.793424131625, 10414.323069000491, 748.8015675845905, 812.6505602590825, 813.515958004986, 829.6308142876483, 840.4495055738502, 4868.975655121772, 4917.0, 4940.728259945738, 4965.453800081988, 4995.675281106789, 79683.20316796874, 120682.0, 122777.0, 124375.3781231088, 127051.3647431757, 80250.0, 89241.0, 97311.51344243233, 99406.5029674847, 99936.50031749795, 90253.09746902579, 90314.54842725744, 92287.07712922919, 92437.5378123105, 95104.0, 9819.754506137118, 9912.00879912003, 10200.693979180636, 10310.742231444274, 10314.174866010851, 54360.72819635877, 54795.0, 56486.71756641355, 56916.43083569111, 57218.42781572131, 67467.0, 67722.0, 69848.30151698622, 73730.0, 77367.0, 10717.196210284104, 10867.836982445428, 11062.668119956414, 12256.693582660148, 12822.358882056047, 12666.683332916751, 12927.870721292667, 13793.448262069405, 14325.426982920982, 14665.120092794466, 13763.174209547458, 13783.448662053406, 14029.649258768612, 14042.297885105909, 14046.367913444124, 12966.157199781985, 13210.867891320964, 13335.866641333463, 13430.328483575588, 13489.39297731624, 12967.675808104872, 12985.155964862253, 13070.80393794075, 13406.195628262336, 13526.39131239077, 10674.786504269716, 10945.671629851116, 10956.233063685466, 11237.943810280896, 11446.42767861587, 10163.644272450429, 10603.204759642904, 10621.89378106209, 11129.499172537417, 11276.32342059479], "value": 7495.750182088407, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 114.0, 112.0, 110.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 156.0, 186.0, 124.0, 152.0, 153.0, 125.0, 179.0, 125.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 162.0, 164.0, 162.0, 159.0, 164.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 169.0, 76.0, 76.0, 75.0, 76.0, 167.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 138.0, 86.0, 84.0, 84.0, 130.0, 85.0, 85.0, 152.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 94.0, 94.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 53.0, 55.0, 53.0, 55.0, 54.0, 54.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 78.0, 76.0, 78.0, 77.0, 77.0, 82.0, 107.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 138.0, 129.0, 128.0, 121.0, 135.0, 124.0, 121.0, 121.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 157.0, 159.0, 155.0, 153.0, 153.0, 160.0, 161.0, 158.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 62.0, 63.0, 64.0, 63.0, 62.0, 61.0, 62.0, 63.0], "value": 63.0, "unit": "score"}]}]} 16:51:54 INFO - Return code: 0 16:51:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:54 ERROR - # TBPL SUCCESS # 16:51:54 INFO - Running post-action listener: _resource_record_post_action 16:51:54 INFO - ##### 16:51:54 INFO - ##### Finished run-tests step (success) 16:51:54 INFO - ##### 16:51:54 INFO - Running post-run listener: _resource_record_post_run 16:51:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 450560; Write bytes: 221220864; Read time: 72; Write time: 126896 16:51:54 INFO - TinderboxPrint: CPU usage
13.3% 16:51:54 INFO - TinderboxPrint: I/O read bytes / time
450,560 / 72 16:51:54 INFO - TinderboxPrint: I/O write bytes / time
221,220,864 / 126,896 16:51:54 INFO - TinderboxPrint: CPU idle
8,194.7 (86.7%) 16:51:54 INFO - TinderboxPrint: CPU user
1,204.4 (12.7%) 16:51:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:51:54 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 823296; Read time: 0; Write time: 44 16:51:54 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 425984; Write bytes: 219783168; Read time: 56; Write time: 126852 16:51:54 INFO - Running post-run listener: _upload_blobber_files 16:51:54 INFO - Blob upload gear active. 16:51:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:54 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 16:51:54 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:54 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:56 INFO - (blobuploader) - INFO - Done attempting. 16:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:00 INFO - (blobuploader) - INFO - Done attempting. 16:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:01 INFO - (blobuploader) - INFO - Done attempting. 16:52:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:01 INFO - Return code: 0 16:52:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb651769464787b42e27745790afadc80ea49300cbd42394ddcf697d32a9bf10c2f84abbbf6dfb5f3849ebf0082a719b7d66c2e41cd6a0f85699da6e5f408134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa8721a3f35687c709562a73c45c4ebcff66f7a2bd9816793c6548c14f77ee00d6b15196de1b9cf88f7285acab003119bc0ac1099d83eaeaedb7955936f37199", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0acb7638ba058a23883d18ed12098a413c665a952ea25010c8250e2f6c09d449d15327d3b362bfdbbd13465bdeb8c9b558bb652bbe306422aa4f23dd693b7c6b"} 16:52:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:01 INFO - Contents: 16:52:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb651769464787b42e27745790afadc80ea49300cbd42394ddcf697d32a9bf10c2f84abbbf6dfb5f3849ebf0082a719b7d66c2e41cd6a0f85699da6e5f408134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa8721a3f35687c709562a73c45c4ebcff66f7a2bd9816793c6548c14f77ee00d6b15196de1b9cf88f7285acab003119bc0ac1099d83eaeaedb7955936f37199", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0acb7638ba058a23883d18ed12098a413c665a952ea25010c8250e2f6c09d449d15327d3b362bfdbbd13465bdeb8c9b558bb652bbe306422aa4f23dd693b7c6b"} 16:52:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:01 INFO - Copying logs to upload dir... 16:52:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.058695 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-01 16:52:01.173292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:01.180759) ========= 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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 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-Beta/sha512/cb651769464787b42e27745790afadc80ea49300cbd42394ddcf697d32a9bf10c2f84abbbf6dfb5f3849ebf0082a719b7d66c2e41cd6a0f85699da6e5f408134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa8721a3f35687c709562a73c45c4ebcff66f7a2bd9816793c6548c14f77ee00d6b15196de1b9cf88f7285acab003119bc0ac1099d83eaeaedb7955936f37199", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0acb7638ba058a23883d18ed12098a413c665a952ea25010c8250e2f6c09d449d15327d3b362bfdbbd13465bdeb8c9b558bb652bbe306422aa4f23dd693b7c6b"} build_url:https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb651769464787b42e27745790afadc80ea49300cbd42394ddcf697d32a9bf10c2f84abbbf6dfb5f3849ebf0082a719b7d66c2e41cd6a0f85699da6e5f408134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa8721a3f35687c709562a73c45c4ebcff66f7a2bd9816793c6548c14f77ee00d6b15196de1b9cf88f7285acab003119bc0ac1099d83eaeaedb7955936f37199", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0acb7638ba058a23883d18ed12098a413c665a952ea25010c8250e2f6c09d449d15327d3b362bfdbbd13465bdeb8c9b558bb652bbe306422aa4f23dd693b7c6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:01.205420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:01.205728) ========= 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=3a3620fb28aea1604ab609ef000001d2-1470094292.583423-983407401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 16:52:01.291015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 16:52:01.291321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 16:52:01.294642) ========= ========= Total master_lag: 0.18 =========