builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1470171387.43 results: success (0) buildid: 20160802111448 builduid: 228d52a7017145f7882f1752b2d7cca7 revision: 5eb264c7ddfb972a051341a373a268e841bd4cb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.433275) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.433776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.434068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.449039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.449362) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 13:56:28-- 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% 42.4M=0s 2016-08-02 13:56:28 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.546065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.546382) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016196 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:27.596193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 13:56:27.596547) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5eb264c7ddfb972a051341a373a268e841bd4cb4 --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 5eb264c7ddfb972a051341a373a268e841bd4cb4 --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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 13:56:28,210 truncating revision to first 12 chars 2016-08-02 13:56:28,210 Setting DEBUG logging. 2016-08-02 13:56:28,210 attempt 1/10 2016-08-02 13:56:28,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5eb264c7ddfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 13:56:29,034 unpacking tar archive at: mozilla-beta-5eb264c7ddfb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.132656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 13:56:28.743005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:28.743329) ========= script_repo_revision: 5eb264c7ddfb972a051341a373a268e841bd4cb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:28.743734) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:28.744013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 13:56:28.753026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-02 13:56:28.753491) ========= /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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:56:29 INFO - MultiFileLogger online at 20160802 13:56:29 in /builds/slave/test 13:56:29 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 13:56:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:56:29 INFO - {'append_to_log': False, 13:56:29 INFO - 'base_work_dir': '/builds/slave/test', 13:56:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:56:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:56:29 INFO - 'branch': 'Mozilla-Beta', 13:56:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:29 INFO - 'config_files': ('talos/linux_config.py',), 13:56:29 INFO - 'default_actions': ('clobber', 13:56:29 INFO - 'read-buildbot-config', 13:56:29 INFO - 'download-and-extract', 13:56:29 INFO - 'populate-webroot', 13:56:29 INFO - 'create-virtualenv', 13:56:29 INFO - 'install', 13:56:29 INFO - 'run-tests'), 13:56:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:29 INFO - 'download_minidump_stackwalk': True, 13:56:29 INFO - 'download_symbols': 'ondemand', 13:56:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:29 INFO - 'installer_path': 'installer.exe', 13:56:29 INFO - 'log_level': 'info', 13:56:29 INFO - 'log_name': 'talos', 13:56:29 INFO - 'log_to_console': True, 13:56:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:56:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:56:29 INFO - 'opt_config_files': (), 13:56:29 INFO - 'pip_index': False, 13:56:29 INFO - 'sps_profile': False, 13:56:29 INFO - 'sps_profile_interval': 0, 13:56:29 INFO - 'suite': 'dromaeojs-e10s', 13:56:29 INFO - 'system_bits': '32', 13:56:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:29 INFO - 'title': 'talos-linux64-ix-011', 13:56:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:29 INFO - 'use_talos_json': True, 13:56:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:56:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:29 INFO - 'work_dir': 'build'} 13:56:29 INFO - ##### 13:56:29 INFO - ##### Running clobber step. 13:56:29 INFO - ##### 13:56:29 INFO - Running pre-action listener: _resource_record_pre_action 13:56:29 INFO - Running main action method: clobber 13:56:29 INFO - rmtree: /builds/slave/test/build 13:56:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:29 INFO - Running post-action listener: _resource_record_post_action 13:56:29 INFO - ##### 13:56:29 INFO - ##### Finished clobber step (success) 13:56:29 INFO - ##### 13:56:29 INFO - ##### 13:56:29 INFO - ##### Running read-buildbot-config step. 13:56:29 INFO - ##### 13:56:29 INFO - Running pre-action listener: _resource_record_pre_action 13:56:29 INFO - Running main action method: read_buildbot_config 13:56:29 INFO - Using buildbot properties: 13:56:29 INFO - { 13:56:29 INFO - "project": "", 13:56:29 INFO - "product": "firefox", 13:56:29 INFO - "script_repo_revision": "production", 13:56:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:56:29 INFO - "repository": "", 13:56:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 13:56:29 INFO - "buildid": "20160802111448", 13:56:29 INFO - "pgo_build": "True", 13:56:29 INFO - "basedir": "/builds/slave/test", 13:56:29 INFO - "buildnumber": 67, 13:56:29 INFO - "slavename": "talos-linux64-ix-011", 13:56:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:56:29 INFO - "platform": "ubuntu64_hw", 13:56:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:56:29 INFO - "branch": "mozilla-beta", 13:56:29 INFO - "repo_path": "releases/mozilla-beta", 13:56:29 INFO - "revision": "5eb264c7ddfb972a051341a373a268e841bd4cb4", 13:56:29 INFO - "stage_platform": "linux64-pgo", 13:56:29 INFO - "builduid": "228d52a7017145f7882f1752b2d7cca7", 13:56:29 INFO - "slavebuilddir": "test" 13:56:29 INFO - } 13:56:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 13:56:29 INFO - Running post-action listener: _resource_record_post_action 13:56:29 INFO - ##### 13:56:29 INFO - ##### Finished read-buildbot-config step (success) 13:56:29 INFO - ##### 13:56:29 INFO - ##### 13:56:29 INFO - ##### Running download-and-extract step. 13:56:29 INFO - ##### 13:56:29 INFO - Running pre-action listener: _resource_record_pre_action 13:56:29 INFO - Running main action method: download_and_extract 13:56:29 INFO - mkdir: /builds/slave/test/build/tests 13:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:29 INFO - https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 13:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 13:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:30 INFO - Downloaded 1327 bytes. 13:56:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 13:56:30 INFO - Using the following test package requirements: 13:56:30 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 13:56:30 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:56:30 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 13:56:30 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'jsshell-linux-x86_64.zip'], 13:56:30 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:56:30 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 13:56:30 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 13:56:30 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 13:56:30 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:56:30 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 13:56:30 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:56:30 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:30 INFO - https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 13:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 13:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:31 INFO - Downloaded 21968980 bytes. 13:56:31 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'] 13:56:31 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 13:56:32 INFO - Return code: 0 13:56:32 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 13:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:32 INFO - https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 13:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 13:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:33 INFO - Downloaded 21968980 bytes. 13:56:33 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'] 13:56:33 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 13:56:35 INFO - Return code: 0 13:56: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')]} 13:56:35 INFO - https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 13:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 13:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:36 INFO - Downloaded 10833369 bytes. 13:56:36 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'] 13:56:36 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 13:56:36 INFO - Return code: 0 13:56: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')]} 13:56:36 INFO - https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 13:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 13:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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 13:56:38 INFO - Downloaded 55270624 bytes. 13:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 13:56:38 INFO - mkdir: /builds/slave/test/properties 13:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:56:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:56:38 INFO - Contents: 13:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 13:56:39 INFO - Running post-action listener: _resource_record_post_action 13:56:39 INFO - Running post-action listener: set_extra_try_arguments 13:56:39 INFO - ##### 13:56:39 INFO - ##### Finished download-and-extract step (success) 13:56:39 INFO - ##### 13:56:39 INFO - ##### 13:56:39 INFO - ##### Running populate-webroot step. 13:56:39 INFO - ##### 13:56:39 INFO - Running pre-action listener: _resource_record_pre_action 13:56:39 INFO - Running main action method: populate_webroot 13:56:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:39 INFO - '--tppagecycles', 13:56:39 INFO - '7'], 13:56:39 INFO - 'tests': ['tsvgm']}}, 13:56:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:56:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:56:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:56:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['damp', 'tps']}, 13:56:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'tests': ['damp', 'tps']}, 13:56:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['dromaeo_dom']}, 13:56:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tsvgx', 13:56:39 INFO - 'tsvgr_opacity', 13:56:39 INFO - 'tart', 13:56:39 INFO - 'tscrollx', 13:56:39 INFO - 'cart']}, 13:56:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:56:39 INFO - 'tsvgr_opacity', 13:56:39 INFO - 'tart', 13:56:39 INFO - 'tscrollx', 13:56:39 INFO - 'cart']}, 13:56:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tp5o']}, 13:56:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'tests': ['tp5o']}, 13:56:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s', 13:56:39 INFO - '--xperf_path', 13:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:39 INFO - 'tests': ['tp5n']}, 13:56:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:39 INFO - 'talos_options': ['--xperf_path', 13:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:39 INFO - 'tests': ['tp5n']}}, 13:56:39 INFO - 'talos.zip': {'path': '', 13:56:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:39 INFO - Running post-action listener: _resource_record_post_action 13:56:39 INFO - ##### 13:56:39 INFO - ##### Finished populate-webroot step (success) 13:56:39 INFO - ##### 13:56:39 INFO - ##### 13:56:39 INFO - ##### Running create-virtualenv step. 13:56:39 INFO - ##### 13:56:39 INFO - Running pre-action listener: _resource_record_pre_action 13:56:39 INFO - Running main action method: create_virtualenv 13:56:39 INFO - Creating virtualenv /builds/slave/test/build/venv 13:56:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:56:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:56:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:39 INFO - Using real prefix '/usr' 13:56:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:56:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:56:42 INFO - Installing pip.................done. 13:56:42 INFO - Return code: 0 13:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:42 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:56:42 INFO - Using env: {'DISPLAY': ':0', 13:56:42 INFO - 'HOME': '/home/cltbld', 13:56:42 INFO - 'LANG': 'en_US.UTF-8', 13:56:42 INFO - 'LANGUAGE': 'en_US:en', 13:56:42 INFO - 'LOGNAME': 'cltbld', 13:56:42 INFO - 'MAIL': '/var/mail/cltbld', 13:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:42 INFO - 'MOZ_NO_REMOTE': '1', 13:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:42 INFO - 'NO_EM_RESTART': '1', 13:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:42 INFO - 'PWD': '/builds/slave/test', 13:56:42 INFO - 'SHELL': '/bin/bash', 13:56:42 INFO - 'SHLVL': '1', 13:56:42 INFO - 'TERM': 'linux', 13:56:42 INFO - 'TMOUT': '86400', 13:56:42 INFO - 'USER': 'cltbld', 13:56:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:42 INFO - '_': '/tools/buildbot/bin/python'} 13:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:56:42 INFO - Cleaning up... 13:56:42 INFO - Return code: 0 13:56:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:42 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:56:42 INFO - Using env: {'DISPLAY': ':0', 13:56:42 INFO - 'HOME': '/home/cltbld', 13:56:42 INFO - 'LANG': 'en_US.UTF-8', 13:56:42 INFO - 'LANGUAGE': 'en_US:en', 13:56:42 INFO - 'LOGNAME': 'cltbld', 13:56:42 INFO - 'MAIL': '/var/mail/cltbld', 13:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:42 INFO - 'MOZ_NO_REMOTE': '1', 13:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:42 INFO - 'NO_EM_RESTART': '1', 13:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:42 INFO - 'PWD': '/builds/slave/test', 13:56:42 INFO - 'SHELL': '/bin/bash', 13:56:42 INFO - 'SHLVL': '1', 13:56:42 INFO - 'TERM': 'linux', 13:56:42 INFO - 'TMOUT': '86400', 13:56:42 INFO - 'USER': 'cltbld', 13:56:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:42 INFO - '_': '/tools/buildbot/bin/python'} 13:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:42 INFO - Downloading/unpacking psutil>=3.1.1 13:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:44 INFO - Installing collected packages: psutil 13:56:44 INFO - Running setup.py install for psutil 13:56:44 INFO - building 'psutil._psutil_linux' extension 13:56:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:56:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:56:44 INFO - building 'psutil._psutil_posix' extension 13:56:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:56:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:45 INFO - Successfully installed psutil 13:56:45 INFO - Cleaning up... 13:56:45 INFO - Return code: 0 13:56:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:45 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:56:45 INFO - Using env: {'DISPLAY': ':0', 13:56:45 INFO - 'HOME': '/home/cltbld', 13:56:45 INFO - 'LANG': 'en_US.UTF-8', 13:56:45 INFO - 'LANGUAGE': 'en_US:en', 13:56:45 INFO - 'LOGNAME': 'cltbld', 13:56:45 INFO - 'MAIL': '/var/mail/cltbld', 13:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:45 INFO - 'MOZ_NO_REMOTE': '1', 13:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:45 INFO - 'NO_EM_RESTART': '1', 13:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:45 INFO - 'PWD': '/builds/slave/test', 13:56:45 INFO - 'SHELL': '/bin/bash', 13:56:45 INFO - 'SHLVL': '1', 13:56:45 INFO - 'TERM': 'linux', 13:56:45 INFO - 'TMOUT': '86400', 13:56:45 INFO - 'USER': 'cltbld', 13:56:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:45 INFO - '_': '/tools/buildbot/bin/python'} 13:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:56:47 INFO - Installing collected packages: mozsystemmonitor 13:56:47 INFO - Running setup.py install for mozsystemmonitor 13:56:47 INFO - Successfully installed mozsystemmonitor 13:56:47 INFO - Cleaning up... 13:56:47 INFO - Return code: 0 13:56:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:47 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:56:47 INFO - Using env: {'DISPLAY': ':0', 13:56:47 INFO - 'HOME': '/home/cltbld', 13:56:47 INFO - 'LANG': 'en_US.UTF-8', 13:56:47 INFO - 'LANGUAGE': 'en_US:en', 13:56:47 INFO - 'LOGNAME': 'cltbld', 13:56:47 INFO - 'MAIL': '/var/mail/cltbld', 13:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:47 INFO - 'MOZ_NO_REMOTE': '1', 13:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:47 INFO - 'NO_EM_RESTART': '1', 13:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:47 INFO - 'PWD': '/builds/slave/test', 13:56:47 INFO - 'SHELL': '/bin/bash', 13:56:47 INFO - 'SHLVL': '1', 13:56:47 INFO - 'TERM': 'linux', 13:56:47 INFO - 'TMOUT': '86400', 13:56:47 INFO - 'USER': 'cltbld', 13:56:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:47 INFO - '_': '/tools/buildbot/bin/python'} 13:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:47 INFO - Downloading/unpacking jsonschema==2.5.1 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56:49 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:49 INFO - warning: no files found matching '*.txt' 13:56:49 INFO - no previously-included directories found matching 'build' 13:56:49 INFO - no previously-included directories found matching 'dist' 13:56:49 INFO - no previously-included directories found matching '.git*' 13:56:49 INFO - Installing collected packages: jsonschema, functools32 13:56:49 INFO - Running setup.py install for functools32 13:56:49 INFO - warning: no files found matching '*.txt' 13:56:49 INFO - no previously-included directories found matching 'build' 13:56:49 INFO - no previously-included directories found matching 'dist' 13:56:49 INFO - no previously-included directories found matching '.git*' 13:56:49 INFO - Successfully installed jsonschema functools32 13:56:49 INFO - Cleaning up... 13:56:50 INFO - Return code: 0 13:56:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:56:50 INFO - Using env: {'DISPLAY': ':0', 13:56:50 INFO - 'HOME': '/home/cltbld', 13:56:50 INFO - 'LANG': 'en_US.UTF-8', 13:56:50 INFO - 'LANGUAGE': 'en_US:en', 13:56:50 INFO - 'LOGNAME': 'cltbld', 13:56:50 INFO - 'MAIL': '/var/mail/cltbld', 13:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:50 INFO - 'MOZ_NO_REMOTE': '1', 13:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:50 INFO - 'NO_EM_RESTART': '1', 13:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:50 INFO - 'PWD': '/builds/slave/test', 13:56:50 INFO - 'SHELL': '/bin/bash', 13:56:50 INFO - 'SHLVL': '1', 13:56:50 INFO - 'TERM': 'linux', 13:56:50 INFO - 'TMOUT': '86400', 13:56:50 INFO - 'USER': 'cltbld', 13:56:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:50 INFO - '_': '/tools/buildbot/bin/python'} 13:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:56:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:56:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:52 INFO - Downloading docopt-0.6.1.tar.gz 13:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:56:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:56:52 INFO - Running setup.py install for blobuploader 13:56:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:56:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:56:52 INFO - Running setup.py install for requests 13:56:53 INFO - Running setup.py install for docopt 13:56:53 INFO - Successfully installed blobuploader requests docopt 13:56:53 INFO - Cleaning up... 13:56:53 INFO - Return code: 0 13:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:56:53 INFO - Using env: {'DISPLAY': ':0', 13:56:53 INFO - 'HOME': '/home/cltbld', 13:56:53 INFO - 'LANG': 'en_US.UTF-8', 13:56:53 INFO - 'LANGUAGE': 'en_US:en', 13:56:53 INFO - 'LOGNAME': 'cltbld', 13:56:53 INFO - 'MAIL': '/var/mail/cltbld', 13:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:53 INFO - 'MOZ_NO_REMOTE': '1', 13:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:53 INFO - 'NO_EM_RESTART': '1', 13:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:53 INFO - 'PWD': '/builds/slave/test', 13:56:53 INFO - 'SHELL': '/bin/bash', 13:56:53 INFO - 'SHLVL': '1', 13:56:53 INFO - 'TERM': 'linux', 13:56:53 INFO - 'TMOUT': '86400', 13:56:53 INFO - 'USER': 'cltbld', 13:56:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:53 INFO - '_': '/tools/buildbot/bin/python'} 13:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:53 INFO - Running setup.py (path:/tmp/pip-y3AB5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:53 INFO - Running setup.py (path:/tmp/pip-d0zV8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:53 INFO - Running setup.py (path:/tmp/pip-rzP2Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:53 INFO - Running setup.py (path:/tmp/pip-AiVPg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:53 INFO - Running setup.py (path:/tmp/pip-Xegmd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:54 INFO - Running setup.py (path:/tmp/pip-PRPulv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:54 INFO - Running setup.py (path:/tmp/pip-CcWNHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:54 INFO - Running setup.py (path:/tmp/pip-8CQRKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:54 INFO - Running setup.py (path:/tmp/pip-X64_Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:54 INFO - Running setup.py (path:/tmp/pip-o5Eo5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:54 INFO - Running setup.py (path:/tmp/pip-iLb13B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:54 INFO - Running setup.py (path:/tmp/pip-snJNrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:54 INFO - Running setup.py (path:/tmp/pip-8tdowN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:54 INFO - Running setup.py (path:/tmp/pip-TwHusn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:54 INFO - Running setup.py (path:/tmp/pip-MrGomn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:54 INFO - Running setup.py (path:/tmp/pip-FxOThk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:54 INFO - Running setup.py (path:/tmp/pip-GWuQqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:56:54 INFO - Running setup.py install for manifestparser 13:56:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for mozcrash 13:56:55 INFO - Running setup.py install for mozdebug 13:56:55 INFO - Running setup.py install for mozdevice 13:56:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for mozfile 13:56:55 INFO - Running setup.py install for mozhttpd 13:56:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for mozinfo 13:56:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for mozInstall 13:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for mozleak 13:56:55 INFO - Running setup.py install for mozlog 13:56:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:56:55 INFO - Running setup.py install for moznetwork 13:56:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Running setup.py install for mozprocess 13:56:56 INFO - Running setup.py install for mozprofile 13:56:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Running setup.py install for mozrunner 13:56:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Running setup.py install for mozscreenshot 13:56:56 INFO - Running setup.py install for moztest 13:56:56 INFO - Running setup.py install for mozversion 13:56:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:56:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:56:56 INFO - Cleaning up... 13:56:56 INFO - Return code: 0 13:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:56:56 INFO - Using env: {'DISPLAY': ':0', 13:56:56 INFO - 'HOME': '/home/cltbld', 13:56:56 INFO - 'LANG': 'en_US.UTF-8', 13:56:56 INFO - 'LANGUAGE': 'en_US:en', 13:56:56 INFO - 'LOGNAME': 'cltbld', 13:56:56 INFO - 'MAIL': '/var/mail/cltbld', 13:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:56 INFO - 'MOZ_NO_REMOTE': '1', 13:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:56 INFO - 'NO_EM_RESTART': '1', 13:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:56 INFO - 'PWD': '/builds/slave/test', 13:56:56 INFO - 'SHELL': '/bin/bash', 13:56:56 INFO - 'SHLVL': '1', 13:56:56 INFO - 'TERM': 'linux', 13:56:56 INFO - 'TMOUT': '86400', 13:56:56 INFO - 'USER': 'cltbld', 13:56:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:56 INFO - '_': '/tools/buildbot/bin/python'} 13:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:56 INFO - Running setup.py (path:/tmp/pip-7MdioV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:57 INFO - Running setup.py (path:/tmp/pip-USj5Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:57 INFO - Running setup.py (path:/tmp/pip-Dkavok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:57 INFO - Running setup.py (path:/tmp/pip-_y7MUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:57 INFO - Running setup.py (path:/tmp/pip-SibHsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:57 INFO - Running setup.py (path:/tmp/pip-2B322d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:57 INFO - Running setup.py (path:/tmp/pip-H1tpku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:57 INFO - Running setup.py (path:/tmp/pip-S9UUn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:57 INFO - Running setup.py (path:/tmp/pip-E2Q0R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:57 INFO - Running setup.py (path:/tmp/pip-DzPDf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:57 INFO - Running setup.py (path:/tmp/pip-BL7qMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:57 INFO - Running setup.py (path:/tmp/pip-eHjRFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:57 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)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:57 INFO - Running setup.py (path:/tmp/pip-j66Gyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:57 INFO - Running setup.py (path:/tmp/pip-k7I6EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:57 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)) 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:57 INFO - Running setup.py (path:/tmp/pip-t4VhK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:58 INFO - Running setup.py (path:/tmp/pip-yY1ekD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:58 INFO - Running setup.py (path:/tmp/pip-mMRLcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:56:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:00 INFO - Downloading blessings-1.6.tar.gz 13:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:00 INFO - Installing collected packages: blessings 13:57:00 INFO - Running setup.py install for blessings 13:57:00 INFO - Successfully installed blessings 13:57:00 INFO - Cleaning up... 13:57:00 INFO - Return code: 0 13:57:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:00 INFO - Reading from file tmpfile_stdout 13:57:00 INFO - Current package versions: 13:57:00 INFO - argparse == 1.2.1 13:57:00 INFO - blessings == 1.6 13:57:00 INFO - blobuploader == 1.2.4 13:57:00 INFO - docopt == 0.6.1 13:57:00 INFO - functools32 == 3.2.3-2 13:57:00 INFO - jsonschema == 2.5.1 13:57:00 INFO - manifestparser == 1.1 13:57:00 INFO - mozInstall == 1.12 13:57:00 INFO - mozcrash == 0.17 13:57:00 INFO - mozdebug == 0.1 13:57:00 INFO - mozdevice == 0.48 13:57:00 INFO - mozfile == 1.2 13:57:00 INFO - mozhttpd == 0.7 13:57:00 INFO - mozinfo == 0.9 13:57:00 INFO - mozleak == 0.1 13:57:00 INFO - mozlog == 3.2 13:57:00 INFO - moznetwork == 0.27 13:57:00 INFO - mozprocess == 0.23 13:57:00 INFO - mozprofile == 0.28 13:57:00 INFO - mozrunner == 6.12 13:57:00 INFO - mozscreenshot == 0.1 13:57:00 INFO - mozsystemmonitor == 0.3 13:57:00 INFO - moztest == 0.7 13:57:00 INFO - mozversion == 1.4 13:57:00 INFO - psutil == 3.1.1 13:57:00 INFO - requests == 1.2.3 13:57:00 INFO - wsgiref == 0.1.2 13:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:00 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:57:00 INFO - Using env: {'DISPLAY': ':0', 13:57:00 INFO - 'HOME': '/home/cltbld', 13:57:00 INFO - 'LANG': 'en_US.UTF-8', 13:57:00 INFO - 'LANGUAGE': 'en_US:en', 13:57:00 INFO - 'LOGNAME': 'cltbld', 13:57:00 INFO - 'MAIL': '/var/mail/cltbld', 13:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:00 INFO - 'MOZ_NO_REMOTE': '1', 13:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:00 INFO - 'NO_EM_RESTART': '1', 13:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:00 INFO - 'PWD': '/builds/slave/test', 13:57:00 INFO - 'SHELL': '/bin/bash', 13:57:00 INFO - 'SHLVL': '1', 13:57:00 INFO - 'TERM': 'linux', 13:57:00 INFO - 'TMOUT': '86400', 13:57:00 INFO - 'USER': 'cltbld', 13:57:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:00 INFO - '_': '/tools/buildbot/bin/python'} 13:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:57:00 INFO - Cleaning up... 13:57:00 INFO - Return code: 0 13:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:57:00 INFO - Using env: {'DISPLAY': ':0', 13:57:00 INFO - 'HOME': '/home/cltbld', 13:57:00 INFO - 'LANG': 'en_US.UTF-8', 13:57:00 INFO - 'LANGUAGE': 'en_US:en', 13:57:00 INFO - 'LOGNAME': 'cltbld', 13:57:00 INFO - 'MAIL': '/var/mail/cltbld', 13:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:00 INFO - 'MOZ_NO_REMOTE': '1', 13:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:00 INFO - 'NO_EM_RESTART': '1', 13:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:00 INFO - 'PWD': '/builds/slave/test', 13:57:00 INFO - 'SHELL': '/bin/bash', 13:57:00 INFO - 'SHLVL': '1', 13:57:00 INFO - 'TERM': 'linux', 13:57:00 INFO - 'TMOUT': '86400', 13:57:00 INFO - 'USER': 'cltbld', 13:57:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:00 INFO - '_': '/tools/buildbot/bin/python'} 13:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:00 INFO - Cleaning up... 13:57:00 INFO - Return code: 0 13:57:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 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 0x7f397587ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, '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': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:57:01 INFO - Using env: {'DISPLAY': ':0', 13:57:01 INFO - 'HOME': '/home/cltbld', 13:57:01 INFO - 'LANG': 'en_US.UTF-8', 13:57:01 INFO - 'LANGUAGE': 'en_US:en', 13:57:01 INFO - 'LOGNAME': 'cltbld', 13:57:01 INFO - 'MAIL': '/var/mail/cltbld', 13:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:01 INFO - 'MOZ_NO_REMOTE': '1', 13:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:01 INFO - 'NO_EM_RESTART': '1', 13:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:01 INFO - 'PWD': '/builds/slave/test', 13:57:01 INFO - 'SHELL': '/bin/bash', 13:57:01 INFO - 'SHLVL': '1', 13:57:01 INFO - 'TERM': 'linux', 13:57:01 INFO - 'TMOUT': '86400', 13:57:01 INFO - 'USER': 'cltbld', 13:57:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:01 INFO - '_': '/tools/buildbot/bin/python'} 13:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:01 INFO - Downloading/unpacking flake8 13:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:57:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:57:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:57:03 INFO - no previously-included directories found matching 'docs/_build' 13:57:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:57:03 INFO - Running setup.py install for pep8 13:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:57:03 INFO - no previously-included directories found matching 'docs/_build' 13:57:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:57:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:57:04 INFO - Cleaning up... 13:57:04 INFO - Return code: 0 13:57:04 INFO - Running post-action listener: _resource_record_post_action 13:57:04 INFO - Running post-action listener: _start_resource_monitoring 13:57:04 INFO - Starting resource monitoring. 13:57:04 INFO - ##### 13:57:04 INFO - ##### Finished create-virtualenv step (success) 13:57:04 INFO - ##### 13:57:04 INFO - ##### 13:57:04 INFO - ##### Running install step. 13:57:04 INFO - ##### 13:57:04 INFO - Running pre-action listener: _resource_record_pre_action 13:57:04 INFO - Running main action method: install 13:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:04 INFO - Reading from file tmpfile_stdout 13:57:04 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:04 INFO - Reading from file tmpfile_stdout 13:57:04 INFO - Output received: 13:57:04 INFO - Usage: mozinstall [options] installer 13:57:04 INFO - Options: 13:57:04 INFO - -h, --help show this help message and exit 13:57:04 INFO - -d DEST, --destination=DEST 13:57:04 INFO - Directory to install application into. [default: 13:57:04 INFO - "/builds/slave/test"] 13:57:04 INFO - --app=APP Application being installed. [default: firefox] 13:57:04 INFO - mkdir: /builds/slave/test/build/application 13:57:04 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'] 13:57:04 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 13:57:17 INFO - Reading from file tmpfile_stdout 13:57:17 INFO - Output received: 13:57:17 INFO - /builds/slave/test/build/application/firefox/firefox 13:57:17 INFO - Running post-action listener: _resource_record_post_action 13:57:17 INFO - ##### 13:57:17 INFO - ##### Finished install step (success) 13:57:17 INFO - ##### 13:57:17 INFO - ##### 13:57:17 INFO - ##### Running run-tests step. 13:57:17 INFO - ##### 13:57:17 INFO - Running pre-action listener: _resource_record_pre_action 13:57:17 INFO - Running main action method: run_tests 13:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:57:17 INFO - Python 2.7.3 13:57:17 INFO - Return code: 0 13:57:17 INFO - grabbing minidump binary from tooltool 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:17 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 0x20061c0>, '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 0x20070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2007550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:57:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:57:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:57:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:57:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:17 INFO - Return code: 0 13:57:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:57:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:57:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:57:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:57:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:57:18 INFO - Return code: 0 13:57:18 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/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:57:18 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/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:57:18 INFO - Using env: {'DISPLAY': ':0', 13:57:18 INFO - 'HOME': '/home/cltbld', 13:57:18 INFO - 'LANG': 'en_US.UTF-8', 13:57:18 INFO - 'LANGUAGE': 'en_US:en', 13:57:18 INFO - 'LOGNAME': 'cltbld', 13:57:18 INFO - 'MAIL': '/var/mail/cltbld', 13:57:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:57:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:18 INFO - 'MOZ_NO_REMOTE': '1', 13:57:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:18 INFO - 'NO_EM_RESTART': '1', 13:57:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:18 INFO - 'PWD': '/builds/slave/test', 13:57:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:57:18 INFO - 'SHELL': '/bin/bash', 13:57:18 INFO - 'SHLVL': '1', 13:57:18 INFO - 'TERM': 'linux', 13:57:18 INFO - 'TMOUT': '86400', 13:57:18 INFO - 'USER': 'cltbld', 13:57:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262', 13:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:18 INFO - '_': '/tools/buildbot/bin/python'} 13:57:18 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/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:57:18 INFO - mozversion application_buildid: 20160802111448 13:57:18 INFO - mozversion application_changeset: 5eb264c7ddfb972a051341a373a268e841bd4cb4 13:57:18 INFO - mozversion application_display_name: Firefox 13:57:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:18 INFO - mozversion application_name: Firefox 13:57:18 INFO - mozversion application_remotingname: firefox 13:57:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:18 INFO - mozversion application_vendor: Mozilla 13:57:18 INFO - mozversion application_version: 49.0 13:57:18 INFO - mozversion platform_buildid: 20160802111448 13:57:18 INFO - mozversion platform_changeset: 5eb264c7ddfb972a051341a373a268e841bd4cb4 13:57:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:18 INFO - mozversion platform_version: 49.0 13:57:18 INFO - using testdate: 1470171438 13:57:18 INFO - actual date: 1470171438 13:57:18 INFO - starting webserver on 'localhost:51475' 13:57:18 INFO - SUITE-START | Running 2 tests 13:57:18 INFO - TEST-START | dromaeo_css 13:57:18 INFO - operating with platform_type : linux_ 13:57:18 INFO - Initialising browser for dromaeo_css test... 13:57:18 INFO - TEST-INFO | started process 28417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNvnhhB/profile http://localhost:51475/getInfo.html) 13:57:23 INFO - PROCESS | 28417 | __metrics Screen width/height:1600/1200 13:57:23 INFO - PROCESS | 28417 | colorDepth:24 13:57:23 INFO - PROCESS | 28417 | Browser inner width/height: 1024/697 13:57:23 INFO - PROCESS | 28417 | __metrics 13:57:24 ERROR - PROCESS | 28417 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:57:25 INFO - TEST-INFO | 28417: exit 0 13:57:25 INFO - Browser initialized. 13:57:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:57:25 INFO - TEST-INFO | started process 28546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNvnhhB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:37 INFO - PROCESS | 28546 | RSS: Main: 152952832 13:57:37 INFO - PROCESS | 28546 | 13:58:26 INFO - PROCESS | 28546 | 1470171506626 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] 14:00:34 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51475/tests/dromaeo/cssquery-ext.html) 14:00:35 INFO - PROCESS | 28546 | RSS: Main: 157622272 14:00:35 INFO - PROCESS | 28546 | 14:03:37 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-ext.html (next: http://localhost:51475/tests/dromaeo/cssquery-jquery.html) 14:03:38 INFO - PROCESS | 28546 | RSS: Main: 155402240 14:03:38 INFO - PROCESS | 28546 | 14:06:40 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51475/tests/dromaeo/cssquery-mootools.html) 14:06:40 INFO - PROCESS | 28546 | RSS: Main: 154456064 14:06:40 INFO - PROCESS | 28546 | 14:09:42 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51475/tests/dromaeo/cssquery-prototype.html) 14:09:43 INFO - PROCESS | 28546 | RSS: Main: 156221440 14:09:43 INFO - PROCESS | 28546 | 14:12:45 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51475/tests/dromaeo/cssquery-yui.html) 14:12:45 INFO - PROCESS | 28546 | RSS: Main: 154460160 14:12:45 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:51475/tests/dromaeo/cssquery-yui.html (next: http://localhost:51475/tests/dromaeo/cssquery-dojo.html) 14:15:48 INFO - PROCESS | 28546 | RSS: Main: 158928896 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | __start_tp_report 14:15:48 INFO - PROCESS | 28546 | _x_x_mozilla_page_load 14:15:48 INFO - PROCESS | 28546 | _x_x_mozilla_page_load_details 14:15:48 INFO - PROCESS | 28546 | |i|pagename|runs| 14:15:48 INFO - PROCESS | 28546 | |0;dojo.html;3356.916077098072;3405.6934875861166;3414.1976635490655;3423.8801641942537;3439.5184674145607;5646.548276137909;5675.716214189295;5716.971415142919;5756.568257380697;5779.450952159548;5746.913796293048;5755.539556835453;5773.826785196451;5789.855253618662;5793.507551858097;5155.252488389191;5222.529972302492;5234.26720259164;5262.473752624745;5295.0733621616255;5098.796048158069;5178.430372659004;5253.7373131343475;5265.947340526584;5281.181416880389;5206.661566998152;5207.609429292818;5207.661502002376;5222.843314700565;5231.084560201968;5257.921131183035;5271.736413179345;5275.920861187085;5278.656887302313;5318.680879147263;4999.275105109775;5102.081625307444;5116.820911268088;5145.228215767627;5168.483151684839;5565.916511252334;5579.721013949327;5608.691521966291;5626.409227031144;5657.462541058634;6132.632042077445;6148.354422785633;6155.84610384744;6157.538184636125;6165.938340616582;5983.192269043667;6111.039264645882;6142.324344322121;6182.227221597301;6202.41077097675;5841.211436456109;5842.444967728102;5842.912356314701;5853.209816674779;5868.413158684098;6315.273743519554;6395.2645445773405;6400.295967443578;6404.7117879695525;6416.615003099829;5885.882282354414;5985.491233245136;6029.969850150721;6063.969680151571;6103.877922441527;6144.139482116908;6146.631202127797;6169.259688837368;6170.382961703884;6182.443580077725;5927.436893495197;6137.619035717017;6143;6149.046897730859;6176.320604733476;6084;6093.939060609426;6143.170671959318;6150.3849615039035;6179.536534759821;4672.883177920511;4679.742614156254;4681.250999840009;4711.0342379812055;4714.669973101919;4090;4092.3861420786525;4214.810333534937;4219.556946520633;4254.234237837219;5741.655500669973;5828.358880523139;5860.560457965669;5963.403659634002;5988.970055149696;6142.385761423911;6145.047517634774;6155.199824022938;6158.107074474176;6162.599431036968;5722.456366645162;5877.118432235199;5903.675297858659;5933.614315069507;5938.554608404387;5183.50756678115;5234.659747116425;5259.395169555473;5269.1569348903995;5288.81489147878;6496.707648155844;6498.967505162444;6502.219733631994;6508.284088750233;6508.60948343101;5930.52555795544;6047.848803779941;6087.482563982111;6190.0405437158215;6197.845053873689;6446.258680251831;6447.806565803034;6464.159659244268;6478.740850365933;6481.708323125376;6030.03519436888;6055.969720151371;6056.031035034373;6059.787907423395;6065.909011364922;5940.46535811779;6037.184980027816;6063.484603808725;6098.420650038239;6146.385361463817;5950.940490595039;5955.404459554184;5963.9105413417965;5968.910466343095;5987.341392446914;5922.170896074467;5933.614315069507;5945.167676525376;5979.162917191509;6000.249968753906;5719.714014299185;5740.655560666373;5877.94122058774;5903.704814759159;5940.8811823764145;6036.154938308552;6083.330833608211;6088.665123418077;6089.69551522431;6106.992346262817;5932.970335148297;5996.430339117776;5999.640021598718;6000.69996500182;6006 14:15:48 INFO - PROCESS | 28546 | |1;ext.html;610.7923306075934;666.3270097201827;673.1350214973758;674.5008693566759;685.3626127701242;40761.79619101904;43768;43977.78011109948;44080.01639926203;44169.77915110428;44311.55688443115;44915.10169796602;45015.54984450155;45063;45324;8832.690855820048;9022.142896424863;9028.77428064297;9033.683821066264;9049.819003619956;8849.380543361967;8868.423552469101;8869.113088691143;8909.777255568597;8947.821043579124;8873.467591944473;8968.551572421386;8970.192682658559;8972.820543589125;9001.594928228213;8879.778005549848;8946.955265223633;8970.372073954826;8984;8988.640454381817;8979.730608081769;9065.81868362629;9066.95466522663;9068.047854975199;9081.636734530612;42702.57297427017;42718.14563708739;43092.353614695494;43136.56863431388;43270;3367.8821241256437;3405.387030334539;3631.182983828644;3731.3470142724914;3950.6641935435523;33050.83474582636;33198.50202246944;35095;35364;36079.81960090209;4662.510436404196;4698.765061746899;4718.433787945434;4791.688540244908;4824.252240902666;376151;383269;384013;384090;384315;40200.79899600542;63595.68202158959;64099.679501603125;64522.67738661371;64581.35418645848;41090.58909410927;42959.140817183485;43266.13467730691;43333;43387.34918976218;15933.12367819781;16231.67536649284;16241.106739129225;16244.59388515273;16260;14477.782833257299;14619.415223390944;14620.926895365455;14711.926440367944;14723.411063557553;9650.372725772802;9710.563024663907;9731.12419882214;9800.705978820646;9815.312928095107;3654.798986055739;3679.7424180307657;3700.851965921333;3708.072981754561;3737.7757334560015;1045.8326667733127;1049.7585555322319;1080.1682704317632;1097.6322931817772;1214.8967337776212;32486.187845304055;32610;32612.83693581517;32662.34675306528;33062.08574336578;1157.2420064857363;1163.8079716846794;1171.2211379432752;1206.6621346023128;1226.2336039975016;17123.315067397165;17226.913865430593;17303.74044389335;17387.73918391225;17640.735388969177;579224;599502;603349;617284;622463;62752.37247627465;69867.65066174636;70171.64914175498;70204.2979570208;70220.64889675518;1485.0866716968985;1493.4324956516455;1513.2963172124794;1532.6398296400337;1535.2707463954532;33934.151646209044;34487.137821554665;34626.65373346234;34761;34811;57085.14372284502;57836;58037.12944305754;58055;58060.709696451246;580285;582470;583450;588607;591620;48162.759186203846;48363;48815.267770984174;49262.50737492723;49423.50576494333;52122.73938630283;52149.21776173285;53352.19971700505;53515.73242133764;53655.73172134271;44036.33945490884;44287.778561106985;45111.32333015073;45233.151592103495;45494.090118196786;44046.77976610096;44301.77849110863;44968.55031449775;45306.773466133774;45891.77054114708;44537.554624454635;44793.552064478936;45129.323060154784;45186.548134518234;45326.32010519779;37469.62530374771;37849.24301513899;39101.80449097736;39244.2151156981;40128;29177.416451670422;29816;29966.25084372908;30278.243043924078;30487.847560762053 14:15:48 INFO - PROCESS | 28546 | |2;jquery.html;427.82031546750363;428.3467711739599;432.2069003378799;439.15462734236604;440.06767262876883;18614.06929653517;20276.99999999998;20609.96950152492;21686.56626867462;21745.67381489279;19942.50143746407;20040.198392064336;20999.47501312468;21030.894845525752;21101.26145584905;5872.999999999989;6037.184980027684;6046.244219472566;6059.242594675666;6086.482648974842;5785.27684039495;5933.13969474426;5983.341832398432;5996.760129594811;5999.430054144871;5955.523558115362;5957.404259574051;5957.88084238315;5958.285005799288;5958.6424814511265;5697.8575535611735;5957.225560677128;5957.791477298274;5968.522518198533;5968.522518198533;5317.680939143664;5319.122344813101;5382.703951282678;5383.73081345935;5384.1923711443205;24703.641299728508;24741.381465463328;25022.4995500089;25086;25111.37221569457;2571.0230112557297;2571.485702859417;2600.982859882546;2663.3341664583854;2957.7633789296806;15199.544013679497;15336.693266134727;15431.459898903484;15549;15667.608309792233;2034.410021093881;2114.3445531885013;2124.5326028273753;2200.702905107806;2243.0467051503047;56488;85397.03163260182;88864.55567722184;89071;91416.54291728565;9899.356541824758;10431.426271554985;10660.46697665129;10851;11606.709832254091;14670.926645366704;14686.339114739862;14725.852741472663;14757.48348807808;14841.851581484047;8266.586670666564;8429.4942303462;8450.239478446969;8454;8569.271611913056;8337.666493340199;8345.666173352998;8495.872561911576;8608;8631.654733810703;4438.800253988578;4515.277555591156;4545.681802273875;4582.5646563577075;4608.354830323758;2099.5695882344085;2109.9472513187293;2126.1920470221526;2138.5295235048266;2142.6036183306137;1048.8112139814755;1062.1874266186373;1075.8224892892742;1090.9690342626143;1104.100158370925;18233.817661823476;19207.80792192088;19701.310454134036;19860.50348741264;21584.460388490414;1056.8520407143005;1057.2704833664748;1060.2525219720078;1089.6077412131626;1101.4382664840828;11407.48666310018;11456.885431145582;11546.249493782878;11570.652880413601;11656.766864662828;527739;530115;532777;556570;556792;103016;105034;105320;107246.46376768066;108730;1111.5887121764838;1149.3850789827402;1169.2049406403728;1195.7787809255315;1201.3332600406684;17679.469615911545;17704.849184802948;17868.19593118339;17912.91043544774;18100.63798723992;43257.13485730331;43450.34824477572;43960.560394396925;44860.551394485636;44948.66724118068;58845.411545885705;61037.38962610317;62547;63162.368376317485;64188.35811641824;8981.955090224506;9222.308326875645;9229.169374756304;9277.118673726256;9410.341276110606;13120.081594288307;13215.93392033072;13823.861761382257;13991.650208744863;14162.079464834753;11968.222065565711;12339.69150771238;12382.752344953231;12473.625791226277;12492.750144997231;11354.772904542027;11590.478428470571;11689.006434452827;11800.52797888075;12082.697932551757;11994;12222.511099556274;12268.754624907631;12284.631461056182;12771.10602257833;9065.728028159167;9149.679761208326;9271.072892710676;9295.349325547148;9316.44101353921;12004.75990480168;12011.699707507381;12245.938770306091;12267.87732122703;12341.321227332224 14:15:48 INFO - PROCESS | 28546 | |3;mootools.html;1528.6713356628327;1562.4843801545492;1745.615964487813;1834.4496651004695;1863.040534124926;8606.569671516414;9309.720708378743;9401.952990235057;9906.108450239486;9934.205263578915;9311.348205625609;9625.711228663135;9727.513624318774;9734;9753.219742420608;2484.167803785734;2508.2475257422793;2516.48412075525;2520;2526.381036646015;2429.283361408389;2510.661060756802;2513.3590934311815;2515.962260566093;2518.9496210075786;2472.6909136357954;2485.8135639826996;2488.912888048919;2501.6122501012374;2505.08564374004;2377.6909001829736;2421.5520128776143;2424.1757802347197;2489.103922587867;2494.0397946790436;2151.9354419367446;2190.7371115466085;2208.5251670890675;2210.502636906683;2230.553889222162;9636.084571965652;9735.415875047449;9746.853797193047;9778.41329520231;9783.168430683401;5338.5996050296;5461.481159289861;5488.067028605146;5489.643173193769;5495.450454954513;3634.2186429917697;3657.9817100914593;3662.6520480554304;3693.076730817296;3743.382341913581;1258.23876554684;1271.9458075208472;1272.166730791333;1275.5408053100875;1292.360281660584;13599.388027538784;13670.794938075838;13718.862811371959;13752.31238438084;13768.724625507533;5012.649114561946;5060.291559181717;5112.923306150411;5160.509751573594;5199.2201169824075;11443.885561144449;11447;11466.656000320003;11486.827697584544;11501.13741469393;5623.10030395143;5630.690312032878;5637;5643.717814109278;5645.661260324394;4739.976300118477;4944.085344211332;5014.222795466709;5127.564157046693;5136.897262054738;4437.400950871655;4513.119941611354;4527.411436513232;4538.977305113519;4703.764811759398;1335.2722766092502;1422.8292604887479;1426.7574512332928;1436.4972259709018;1439.2228196773624;1024.6516184497307;1033.565902321027;1054.7626783973544;1055.8310670292717;1075.693427373195;6150.292716337678;6521.02184672303;6541.8364540885905;6580.703868325841;6588.077669126326;483.9153148199051;485.9465458799529;486.04977269438166;502.7461132128252;509.2691986998669;4376.824927002948;4381.737095774264;4435.622972047412;4478.059607482465;4484.955150448519;11847.229930054518;12212.511499540096;12253.326067066218;12291.754164916652;12296.20074695142;11828.23116497425;12049.819252711217;12049.939750301368;12238.755224895453;12255.877441225652;8859.51272679996;8906.153915378029;8965.506897120591;9014.323925705598;9027.14242146995;6284;6378.617282963037;6410.1025856381075;6473.158489396348;6490.902636460552;10872.945635271773;11179.441027948407;11229.66311010671;11278.154138439813;11280.09759219277;11296.378699171624;11301.321920684784;11317.547298107984;11405.144614153805;11441.542338306375;8220.712275070344;8251.546164960744;8530.573471326534;8539.359548034046;8589.613467393858;9354.391964522285;9453.054694530492;9479.146876781122;9519;9552.283578731483;8374.916250837414;8618.181272779077;8646.394752367274;8693.521856297964;8767.780805479913;8234.464759790595;8242.546659933761;8479.872801907853;8498.70254541088;8501.532415717194;7268.345848873627;7283.308085731847;7319.487635865651;7329.486935914648;7334.083239595051;5514.91727624078;5559.27729395176;5620.437956204347;5711.8000869969355;5730.799422020209;5437.429069947757;5477.370102438271;5538;5547.667139971614;5587.944120558743 14:15:48 INFO - PROCESS | 28546 | |4;prototype.html;343.58272127474163;345.2628637858172;345.97578169528134;346.3747934977366;350.33086804203975;5704.973104841127;5725.255716756827;5728.513076388507;5749.246479823652;5755.223044888939;5620.690862002588;5660.2075709400715;5661.8393229387975;5672.943270567293;5682.659040457575;4199.958000419995;4368.104538569602;4374.540673229297;4374.97812510937;4415.88960275994;4364.825406983717;4371;4379.562043795611;4382.605565499104;4386.627136693385;4345.500267469234;4351.238533256684;4372.868813935587;4376.540463251361;4380.364847097169;4225.9788701056605;4382.9342559861625;4403.603675669173;4406.977965110186;4427.712198707074;3831.942520862189;3850;3853.614638536152;3905.4141878718137;3922.5685174630767;5420.91868621967;5447.863803404946;5449.945500544984;5471.179323101527;5480.424555421663;5042.1428357179;5091.159958606825;5098.133317336062;5119.232115182753;5120;5908.248262353393;5923.733431995527;5930.347661757203;5951.58338916276;5965.642061476326;4377.5403582623685;4386.508587080408;4390.714603550759;4392.143532011259;4419.4033805436175;5961.642301461926;6158.630482171084;6192.938070619326;6216.720247588869;6218.657973811439;4466.932996005063;4477.664175186874;4483.798229079699;4489.438820147481;4503.842365517191;4503.414556107685;4506.504284528699;4531.274996000624;4535.909281814345;4538.636909047268;4849.466558678613;5048;5086.669366491166;5103;5106.387233532;5974.163617093611;6002.459778619857;6012.128241404972;6037.426444487766;6053.576249662569;1564.4289834210658;1578.6423675638941;1579.723548379052;1602.4952140075839;1602.7355486344622;989.5744829723288;1001.0390025575529;1004.6885465505717;1017.2675673515057;1027.465717826726;5781.94218057814;5792.391798861143;5817.505512031525;5818.6217895836635;5823.068309070529;5973.372795856372;6043.887397990039;6048.576599637983;6076.635401875901;6091.23354227278;5668.149777533403;5801.245838041028;5818.592698511064;5831.912521312183;5852.917210316105;3231.2874176685923;3243.594550681165;3244.3349113432164;3252.10567094051;3274.5415641810164;6122.846928826815;6295.622262664255;6333;6338.397852204033;6376.617402955838;6063.514918806485;6153.015517517176;6204.5967012144965;6210.7515699372425;6233.688315584202;6057.727877145849;6305.747770089237;6372.58578192416;6390.265119511316;6395.52033597482;6136;6144.324124346408;6145.600535965148;6184.257889053342;6212.968935155295;5972.611780234271;6082.36135205797;6085.756569737161;6107.572469927062;6110.938890611037;6274.435300822948;6388.616682999035;6442.099580623633;6449.290937901366;6453.612783232833;4352.760598167131;4383.342498625232;4396.010897548026;4400;4407.427034485497;5998.370171131968;6158.199434073542;6164.47601953839;6177.536684748752;6189.195404597373;5980.401959803985;6004.0693692477735;6008.669523176267;6009.519238461;6020.397960203944;5980.09965166885;5982.790602328898;5988.401159883977;5993.430624090704;6001.879962400815;5729;5782.739776710142;5882.911756323573;5903.350631430625;5934.495567876779;6040.6677632730625;6042.697865106815;6045.909311360245;6049.334573197033;6070.964517741129;5615.747291371817;5924.851878703067;5928.614640048383;5943.71167100678;5964.165016897725 14:15:48 INFO - PROCESS | 28546 | |5;yui.html;720.4380583145147;744.1962680305271;746.2313816768728;771.5563550958201;861.9698310559128;15073.773893391608;15552;15600.687986240282;15604;15658.295376708047;16176;16275.91862040691;16302.510924672279;16347.509574712747;16533.66932661346;851.7870532366924;869.7825543614097;870.78665726897;872.720729366603;874.8600223964168;865.7575878753928;872.071244125008;873.978150546235;874.2656168818191;875.7197696737047;924.6578765856642;925.865749466327;926.7636752628105;928.6053427293407;929.7768535551453;916.4776077635751;920.585736418611;921.7511271956535;921.944683319003;922.557172557173;679.4224908827506;680.1939701453794;680.4998326230217;680.9897851532231;682.0178942323039;13931.651708707263;13954.651133721636;13980.370883310276;14039.508617198451;14181;15215.543533693895;15359.232038398035;15627.843721562753;15638.609034774108;16020.198990050567;12846.807297890538;13069.934650326783;13361.532346367927;13392.598222053353;13444.462221511129;4066.5323487798987;4101.97949010256;4124.463819703449;4160.479940007499;4205.91588168238;67470;71084.99999999948;71853;79802;81605.59197204035;11571.710707232387;11983.161178717406;12209.816852747215;12491.750164996649;12670.36648167588;23116.075356985868;23596.41008974755;23611.055557777498;23670.881645592006;23732;8321.583920803936;8395;8407.747767566983;8705.6517739291;8746.956265218632;4454.487733910577;4548.928708805601;4549.727016379028;4558.748664916512;4741.047146969489;3883.3980732986433;3970.285348637215;3994.2410941920944;4041.211963667057;4053.756774593534;723.616483263871;727.294524311417;727.7198278662647;729.3180875881068;740.2301606329464;681.3084719010209;699.7410957945491;764.6597264217481;793.1513280789616;810.1574362662883;10841.349519028883;10953.507092180711;11095.50070246841;11105.278156919936;11116.110711143088;617.1917774127701;745.9917782603744;784.1687810920442;785.4855069929206;808.6320724070533;5098.745062746922;5323.618385969811;5379.435159308295;5388.568914486832;5435.119077337876;68795.31204687989;70724.64637676881;72231.27768722245;74141.62929185427;74196.62901685457;92058;102720;103084;103869;104557.47721261498;58333.08334583339;81178.59410702909;89615.10384896198;92108;97242.51378743061;10149.34029288094;10469.842952355568;10602;10677.199210059121;10808.567657293936;43967.56032439635;51502.48497514977;55138.72430637821;55696.443035570745;56347.71826140843;50509.747451262505;67795.66102169457;68471.31528684849;69593;73162;12473.189242699196;12827.807582886078;13781.724365512835;13798.121972128727;14080.647983800078;13988.58034258974;14773.630659233606;15052.473163439226;15772.974756640782;15873.365065397255;14581.708365832836;14624.415023398944;14641.267936602913;14684.632884177981;14766.557003289918;12654.683632909251;14015.859841401456;14267.571972840831;14970.32633531472;15012.6997460048;14086.866350257069;14262.358193881093;14338.139711617336;14461.638459038608;14559.563213103624;10206.489675516343;10453.634122805664;10606.416647084485;10911.236213464981;11105.278156919774;11398.259113157617;12080.21478603888;12224.38878056076;12336.568220112253;12351.25892446456 14:15:48 INFO - PROCESS | 28546 | __end_tp_report 14:15:48 INFO - PROCESS | 28546 | __start_cc_report 14:15:48 INFO - PROCESS | 28546 | _x_x_mozilla_cycle_collect,328 14:15:48 INFO - PROCESS | 28546 | __end_cc_report 14:15:48 INFO - PROCESS | 28546 | __startTimestamp1470172548651__endTimestamp 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | ------- Summary: start ------- 14:15:48 INFO - PROCESS | 28546 | Number of tests: 6 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#0] dojo.html Cycles:165 Average:5711.87 Median:5938.55 stddev:651.79 (11.0%) stddev-sans-first:627.06 14:15:48 INFO - PROCESS | 28546 | Values: 3356.9 3405.7 3414.2 3423.9 3439.5 5646.5 5675.7 5717.0 5756.6 5779.5 5746.9 5755.5 5773.8 5789.9 5793.5 5155.3 5222.5 5234.3 5262.5 5295.1 5098.8 5178.4 5253.7 5265.9 5281.2 5206.7 5207.6 5207.7 5222.8 5231.1 5257.9 5271.7 5275.9 5278.7 5318.7 4999.3 5102.1 5116.8 5145.2 5168.5 5565.9 5579.7 5608.7 5626.4 5657.5 6132.6 6148.4 6155.8 6157.5 6165.9 5983.2 6111.0 6142.3 6182.2 6202.4 5841.2 5842.4 5842.9 5853.2 5868.4 6315.3 6395.3 6400.3 6404.7 6416.6 5885.9 5985.5 6030.0 6064.0 6103.9 6144.1 6146.6 6169.3 6170.4 6182.4 5927.4 6137.6 6143.0 6149.0 6176.3 6084.0 6093.9 6143.2 6150.4 6179.5 4672.9 4679.7 4681.3 4711.0 4714.7 4090.0 4092.4 4214.8 4219.6 4254.2 5741.7 5828.4 5860.6 5963.4 5989.0 6142.4 6145.0 6155.2 6158.1 6162.6 5722.5 5877.1 5903.7 5933.6 5938.6 5183.5 5234.7 5259.4 5269.2 5288.8 6496.7 6499.0 6502.2 6508.3 6508.6 5930.5 6047.8 6087.5 6190.0 6197.8 6446.3 6447.8 6464.2 6478.7 6481.7 6030.0 6056.0 6056.0 6059.8 6065.9 5940.5 6037.2 6063.5 6098.4 6146.4 5950.9 5955.4 5963.9 5968.9 5987.3 5922.2 5933.6 5945.2 5979.2 6000.2 5719.7 5740.7 5877.9 5903.7 5940.9 6036.2 6083.3 6088.7 6089.7 6107.0 5933.0 5996.4 5999.6 6000.7 6006.0 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#1] ext.html Cycles:180 Average:68282.17 Median:44424.56 stddev:142220.85 (320.1%) stddev-sans-first:142529.06 14:15:48 INFO - PROCESS | 28546 | Values: 610.8 666.3 673.1 674.5 685.4 40761.8 43768.0 43977.8 44080.0 44169.8 44311.6 44915.1 45015.5 45063.0 45324.0 8832.7 9022.1 9028.8 9033.7 9049.8 8849.4 8868.4 8869.1 8909.8 8947.8 8873.5 8968.6 8970.2 8972.8 9001.6 8879.8 8947.0 8970.4 8984.0 8988.6 8979.7 9065.8 9067.0 9068.0 9081.6 42702.6 42718.1 43092.4 43136.6 43270.0 3367.9 3405.4 3631.2 3731.3 3950.7 33050.8 33198.5 35095.0 35364.0 36079.8 4662.5 4698.8 4718.4 4791.7 4824.3 376151.0 383269.0 384013.0 384090.0 384315.0 40200.8 63595.7 64099.7 64522.7 64581.4 41090.6 42959.1 43266.1 43333.0 43387.3 15933.1 16231.7 16241.1 16244.6 16260.0 14477.8 14619.4 14620.9 14711.9 14723.4 9650.4 9710.6 9731.1 9800.7 9815.3 3654.8 3679.7 3700.9 3708.1 3737.8 1045.8 1049.8 1080.2 1097.6 1214.9 32486.2 32610.0 32612.8 32662.3 33062.1 1157.2 1163.8 1171.2 1206.7 1226.2 17123.3 17226.9 17303.7 17387.7 17640.7 579224.0 599502.0 603349.0 617284.0 622463.0 62752.4 69867.7 70171.6 70204.3 70220.6 1485.1 1493.4 1513.3 1532.6 1535.3 33934.2 34487.1 34626.7 34761.0 34811.0 57085.1 57836.0 58037.1 58055.0 58060.7 580285.0 582470.0 583450.0 588607.0 591620.0 48162.8 48363.0 48815.3 49262.5 49423.5 52122.7 52149.2 53352.2 53515.7 53655.7 44036.3 44287.8 45111.3 45233.2 45494.1 44046.8 44301.8 44968.6 45306.8 45891.8 44537.6 44793.6 45129.3 45186.5 45326.3 37469.6 37849.2 39101.8 39244.2 40128.0 29177.4 29816.0 29966.3 30278.2 30487.8 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#2] jquery.html Cycles:180 Average:31472.89 Median:21716.12 stddev:89238.25 (410.9%) stddev-sans-first:89458.15 14:15:48 INFO - PROCESS | 28546 | Values: 427.8 428.3 432.2 439.2 440.1 18614.1 20277.0 20610.0 21686.6 21745.7 19942.5 20040.2 20999.5 21030.9 21101.3 5873.0 6037.2 6046.2 6059.2 6086.5 5785.3 5933.1 5983.3 5996.8 5999.4 5955.5 5957.4 5957.9 5958.3 5958.6 5697.9 5957.2 5957.8 5968.5 5968.5 5317.7 5319.1 5382.7 5383.7 5384.2 24703.6 24741.4 25022.5 25086.0 25111.4 2571.0 2571.5 2601.0 2663.3 2957.8 15199.5 15336.7 15431.5 15549.0 15667.6 2034.4 2114.3 2124.5 2200.7 2243.0 56488.0 85397.0 88864.6 89071.0 91416.5 9899.4 10431.4 10660.5 10851.0 11606.7 14670.9 14686.3 14725.9 14757.5 14841.9 8266.6 8429.5 8450.2 8454.0 8569.3 8337.7 8345.7 8495.9 8608.0 8631.7 4438.8 4515.3 4545.7 4582.6 4608.4 2099.6 2109.9 2126.2 2138.5 2142.6 1048.8 1062.2 1075.8 1091.0 1104.1 18233.8 19207.8 19701.3 19860.5 21584.5 1056.9 1057.3 1060.3 1089.6 1101.4 11407.5 11456.9 11546.2 11570.7 11656.8 527739.0 530115.0 532777.0 556570.0 556792.0 103016.0 105034.0 105320.0 107246.5 108730.0 1111.6 1149.4 1169.2 1195.8 1201.3 17679.5 17704.8 17868.2 17912.9 18100.6 43257.1 43450.3 43960.6 44860.6 44948.7 58845.4 61037.4 62547.0 63162.4 64188.4 8982.0 9222.3 9229.2 9277.1 9410.3 13120.1 13215.9 13823.9 13991.7 14162.1 11968.2 12339.7 12382.8 12473.6 12492.8 11354.8 11590.5 11689.0 11800.5 12082.7 11994.0 12222.5 12268.8 12284.6 12771.1 9065.7 9149.7 9271.1 9295.3 9316.4 12004.8 12011.7 12245.9 12267.9 12341.3 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#3] mootools.html Cycles:180 Average:6329.87 Median:2611.95 stddev:3698.78 (141.6%) stddev-sans-first:3691.55 14:15:48 INFO - PROCESS | 28546 | Values: 1528.7 1562.5 1745.6 1834.4 1863.0 8606.6 9309.7 9402.0 9906.1 9934.2 9311.3 9625.7 9727.5 9734.0 9753.2 2484.2 2508.2 2516.5 2520.0 2526.4 2429.3 2510.7 2513.4 2516.0 2518.9 2472.7 2485.8 2488.9 2501.6 2505.1 2377.7 2421.6 2424.2 2489.1 2494.0 2151.9 2190.7 2208.5 2210.5 2230.6 9636.1 9735.4 9746.9 9778.4 9783.2 5338.6 5461.5 5488.1 5489.6 5495.5 3634.2 3658.0 3662.7 3693.1 3743.4 1258.2 1271.9 1272.2 1275.5 1292.4 13599.4 13670.8 13718.9 13752.3 13768.7 5012.6 5060.3 5112.9 5160.5 5199.2 11443.9 11447.0 11466.7 11486.8 11501.1 5623.1 5630.7 5637.0 5643.7 5645.7 4740.0 4944.1 5014.2 5127.6 5136.9 4437.4 4513.1 4527.4 4539.0 4703.8 1335.3 1422.8 1426.8 1436.5 1439.2 1024.7 1033.6 1054.8 1055.8 1075.7 6150.3 6521.0 6541.8 6580.7 6588.1 483.9 485.9 486.0 502.7 509.3 4376.8 4381.7 4435.6 4478.1 4485.0 11847.2 12212.5 12253.3 12291.8 12296.2 11828.2 12049.8 12049.9 12238.8 12255.9 8859.5 8906.2 8965.5 9014.3 9027.1 6284.0 6378.6 6410.1 6473.2 6490.9 10872.9 11179.4 11229.7 11278.2 11280.1 11296.4 11301.3 11317.5 11405.1 11441.5 8220.7 8251.5 8530.6 8539.4 8589.6 9354.4 9453.1 9479.1 9519.0 9552.3 8374.9 8618.2 8646.4 8693.5 8767.8 8234.5 8242.5 8479.9 8498.7 8501.5 7268.3 7283.3 7319.5 7329.5 7334.1 5514.9 5559.3 5620.4 5711.8 5730.8 5437.4 5477.4 5538.0 5547.7 5587.9 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#4] prototype.html Cycles:180 Average:5037.49 Median:5752.23 stddev:1479.64 (25.7%) stddev-sans-first:1441.23 14:15:48 INFO - PROCESS | 28546 | Values: 343.6 345.3 346.0 346.4 350.3 5705.0 5725.3 5728.5 5749.2 5755.2 5620.7 5660.2 5661.8 5672.9 5682.7 4200.0 4368.1 4374.5 4375.0 4415.9 4364.8 4371.0 4379.6 4382.6 4386.6 4345.5 4351.2 4372.9 4376.5 4380.4 4226.0 4382.9 4403.6 4407.0 4427.7 3831.9 3850.0 3853.6 3905.4 3922.6 5420.9 5447.9 5449.9 5471.2 5480.4 5042.1 5091.2 5098.1 5119.2 5120.0 5908.2 5923.7 5930.3 5951.6 5965.6 4377.5 4386.5 4390.7 4392.1 4419.4 5961.6 6158.6 6192.9 6216.7 6218.7 4466.9 4477.7 4483.8 4489.4 4503.8 4503.4 4506.5 4531.3 4535.9 4538.6 4849.5 5048.0 5086.7 5103.0 5106.4 5974.2 6002.5 6012.1 6037.4 6053.6 1564.4 1578.6 1579.7 1602.5 1602.7 989.6 1001.0 1004.7 1017.3 1027.5 5781.9 5792.4 5817.5 5818.6 5823.1 5973.4 6043.9 6048.6 6076.6 6091.2 5668.1 5801.2 5818.6 5831.9 5852.9 3231.3 3243.6 3244.3 3252.1 3274.5 6122.8 6295.6 6333.0 6338.4 6376.6 6063.5 6153.0 6204.6 6210.8 6233.7 6057.7 6305.7 6372.6 6390.3 6395.5 6136.0 6144.3 6145.6 6184.3 6213.0 5972.6 6082.4 6085.8 6107.6 6110.9 6274.4 6388.6 6442.1 6449.3 6453.6 4352.8 4383.3 4396.0 4400.0 4407.4 5998.4 6158.2 6164.5 6177.5 6189.2 5980.4 6004.1 6008.7 6009.5 6020.4 5980.1 5982.8 5988.4 5993.4 6001.9 5729.0 5782.7 5882.9 5903.4 5934.5 6040.7 6042.7 6045.9 6049.3 6071.0 5615.7 5924.9 5928.6 5943.7 5964.2 14:15:48 INFO - PROCESS | 28546 | 14:15:48 INFO - PROCESS | 28546 | [#5] yui.html Cycles:180 Average:19719.58 Median:4113.22 stddev:26379.72 (641.3%) stddev-sans-first:26415.14 14:15:48 INFO - PROCESS | 28546 | Values: 720.4 744.2 746.2 771.6 862.0 15073.8 15552.0 15600.7 15604.0 15658.3 16176.0 16275.9 16302.5 16347.5 16533.7 851.8 869.8 870.8 872.7 874.9 865.8 872.1 874.0 874.3 875.7 924.7 925.9 926.8 928.6 929.8 916.5 920.6 921.8 921.9 922.6 679.4 680.2 680.5 681.0 682.0 13931.7 13954.7 13980.4 14039.5 14181.0 15215.5 15359.2 15627.8 15638.6 16020.2 12846.8 13069.9 13361.5 13392.6 13444.5 4066.5 4102.0 4124.5 4160.5 4205.9 67470.0 71085.0 71853.0 79802.0 81605.6 11571.7 11983.2 12209.8 12491.8 12670.4 23116.1 23596.4 23611.1 23670.9 23732.0 8321.6 8395.0 8407.7 8705.7 8747.0 4454.5 4548.9 4549.7 4558.7 4741.0 3883.4 3970.3 3994.2 4041.2 4053.8 723.6 727.3 727.7 729.3 740.2 681.3 699.7 764.7 793.2 810.2 10841.3 10953.5 11095.5 11105.3 11116.1 617.2 746.0 784.2 785.5 808.6 5098.7 5323.6 5379.4 5388.6 5435.1 68795.3 70724.6 72231.3 74141.6 74196.6 92058.0 102720.0 103084.0 103869.0 104557.5 58333.1 81178.6 89615.1 92108.0 97242.5 10149.3 10469.8 10602.0 10677.2 10808.6 43967.6 51502.5 55138.7 55696.4 56347.7 50509.7 67795.7 68471.3 69593.0 73162.0 12473.2 12827.8 13781.7 13798.1 14080.6 13988.6 14773.6 15052.5 15773.0 15873.4 14581.7 14624.4 14641.3 14684.6 14766.6 12654.7 14015.9 14267.6 14970.3 15012.7 14086.9 14262.4 14338.1 14461.6 14559.6 10206.5 10453.6 10606.4 10911.2 11105.3 11398.3 12080.2 12224.4 12336.6 12351.3 14:15:48 INFO - PROCESS | 28546 | -------- Summary: end -------- 14:15:48 INFO - PROCESS | 28546 | 14:15:49 INFO - TEST-INFO | 28546: exit 0 14:15:49 INFO - TEST-OK | dromaeo_css | took 1110712ms 14:15:49 INFO - TEST-START | kraken 14:15:49 INFO - operating with platform_type : linux_ 14:15:49 INFO - Initialising browser for kraken test... 14:15:49 INFO - TEST-INFO | started process 28791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3SLk2/profile http://localhost:51475/getInfo.html) 14:15:54 INFO - PROCESS | 28791 | __metrics Screen width/height:1600/1200 14:15:54 INFO - PROCESS | 28791 | colorDepth:24 14:15:54 INFO - PROCESS | 28791 | Browser inner width/height: 1024/697 14:15:54 INFO - PROCESS | 28791 | __metrics 14:15:55 ERROR - PROCESS | 28791 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:15:56 INFO - TEST-INFO | 28791: exit 0 14:15:56 INFO - Browser initialized. 14:15:56 INFO - Running cycle 1/1 for kraken test... 14:15:56 INFO - TEST-INFO | started process 28920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3SLk2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:08 INFO - PROCESS | 28920 | RSS: Main: 153128960 14:16:08 INFO - PROCESS | 28920 | 14:16:10 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51475/tests/kraken/driver.html?testName=audio-beat-detection) 14:16:11 INFO - PROCESS | 28920 | RSS: Main: 158093312 14:16:11 INFO - PROCESS | 28920 | 14:16:14 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51475/tests/kraken/driver.html?testName=audio-dft) 14:16:14 INFO - PROCESS | 28920 | RSS: Main: 157392896 14:16:14 INFO - PROCESS | 28920 | 14:16:17 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51475/tests/kraken/driver.html?testName=audio-fft) 14:16:18 INFO - PROCESS | 28920 | RSS: Main: 157724672 14:16:18 INFO - PROCESS | 28920 | 14:16:20 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51475/tests/kraken/driver.html?testName=audio-oscillator) 14:16:20 INFO - PROCESS | 28920 | RSS: Main: 158130176 14:16:20 INFO - PROCESS | 28920 | 14:16:22 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:23 INFO - PROCESS | 28920 | RSS: Main: 157696000 14:16:23 INFO - PROCESS | 28920 | 14:16:26 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51475/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:27 INFO - PROCESS | 28920 | RSS: Main: 157294592 14:16:27 INFO - PROCESS | 28920 | 14:16:30 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51475/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:31 INFO - PROCESS | 28920 | RSS: Main: 158003200 14:16:31 INFO - PROCESS | 28920 | 14:16:34 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51475/tests/kraken/driver.html?testName=json-parse-financial) 14:16:34 INFO - PROCESS | 28920 | RSS: Main: 157396992 14:16:34 INFO - PROCESS | 28920 | 14:16:36 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:16:36 INFO - PROCESS | 28920 | RSS: Main: 157143040 14:16:36 INFO - PROCESS | 28920 | 14:16:38 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:39 INFO - PROCESS | 28920 | RSS: Main: 156737536 14:16:39 INFO - PROCESS | 28920 | 14:16:41 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:42 INFO - PROCESS | 28920 | RSS: Main: 157626368 14:16:42 INFO - PROCESS | 28920 | 14:16:44 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:45 INFO - PROCESS | 28920 | RSS: Main: 158408704 14:16:45 INFO - PROCESS | 28920 | 14:16:47 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:48 INFO - PROCESS | 28920 | RSS: Main: 158183424 14:16:48 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | Cycle 1(1): loaded http://localhost:51475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51475/tests/kraken/driver.html?testName=ai-astar) 14:16:50 INFO - PROCESS | 28920 | RSS: Main: 158711808 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | __start_tp_report 14:16:50 INFO - PROCESS | 28920 | _x_x_mozilla_page_load 14:16:50 INFO - PROCESS | 28920 | _x_x_mozilla_page_load_details 14:16:50 INFO - PROCESS | 28920 | |i|pagename|runs| 14:16:50 INFO - PROCESS | 28920 | |0;ai-astar;112;106;110;112;112;111;110;110;109;110 14:16:50 INFO - PROCESS | 28920 | |1;audio-beat-detection;156;129;157;169;134;161;155;126;184;132 14:16:50 INFO - PROCESS | 28920 | |2;audio-dft;164;163;163;162;163;162;160;163;163;161 14:16:50 INFO - PROCESS | 28920 | |3;audio-fft;75;75;76;174;75;75;75;76;180;76 14:16:50 INFO - PROCESS | 28920 | |4;audio-oscillator;87;84;153;85;84;83;141;86;84;136 14:16:50 INFO - PROCESS | 28920 | |5;imaging-gaussian-blur;117;116;117;118;116;117;117;118;118;117 14:16:50 INFO - PROCESS | 28920 | |6;imaging-darkroom;147;147;147;150;147;146;147;147;146;146 14:16:50 INFO - PROCESS | 28920 | |7;imaging-desaturate;94;95;97;95;95;95;96;95;95;96 14:16:50 INFO - PROCESS | 28920 | |8;json-parse-financial;52;52;53;56;53;53;53;52;54;59 14:16:50 INFO - PROCESS | 28920 | |9;json-stringify-tinderbox;60;60;60;59;60;60;60;60;60;60 14:16:50 INFO - PROCESS | 28920 | |10;stanford-crypto-aes;78;83;82;77;78;78;78;84;112;82 14:16:50 INFO - PROCESS | 28920 | |11;stanford-crypto-ccm;141;118;120;117;118;119;121;129;138;133 14:16:50 INFO - PROCESS | 28920 | |12;stanford-crypto-pbkdf2;153;152;158;154;154;161;153;154;155;151 14:16:50 INFO - PROCESS | 28920 | |13;stanford-crypto-sha256-iterative;62;64;62;62;63;61;61;63;61;68 14:16:50 INFO - PROCESS | 28920 | __end_tp_report 14:16:50 INFO - PROCESS | 28920 | __start_cc_report 14:16:50 INFO - PROCESS | 28920 | _x_x_mozilla_cycle_collect,845 14:16:50 INFO - PROCESS | 28920 | __end_cc_report 14:16:50 INFO - PROCESS | 28920 | __startTimestamp1470172610347__endTimestamp 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | ------- Summary: start ------- 14:16:50 INFO - PROCESS | 28920 | Number of tests: 14 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.81 (1.6%) stddev-sans-first:1.80 14:16:50 INFO - PROCESS | 28920 | Values: 112.0 106.0 110.0 112.0 112.0 111.0 110.0 110.0 109.0 110.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:156.50 stddev:19.28 (12.3%) stddev-sans-first:20.33 14:16:50 INFO - PROCESS | 28920 | Values: 156.0 129.0 157.0 169.0 134.0 161.0 155.0 126.0 184.0 132.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.09 14:16:50 INFO - PROCESS | 28920 | Values: 164.0 163.0 163.0 162.0 163.0 162.0 160.0 163.0 163.0 161.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.00 stddev:42.87 (57.2%) stddev-sans-first:44.82 14:16:50 INFO - PROCESS | 28920 | Values: 75.0 75.0 76.0 174.0 75.0 75.0 75.0 76.0 180.0 76.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:28.64 (34.1%) stddev-sans-first:29.83 14:16:50 INFO - PROCESS | 28920 | Values: 87.0 84.0 153.0 85.0 84.0 83.0 141.0 86.0 84.0 136.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:16:50 INFO - PROCESS | 28920 | Values: 117.0 116.0 117.0 118.0 116.0 117.0 117.0 118.0 118.0 117.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 14:16:50 INFO - PROCESS | 28920 | Values: 147.0 147.0 147.0 150.0 147.0 146.0 147.0 147.0 146.0 146.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 14:16:50 INFO - PROCESS | 28920 | Values: 94.0 95.0 97.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:2.21 (4.2%) stddev-sans-first:2.26 14:16:50 INFO - PROCESS | 28920 | Values: 52.0 52.0 53.0 56.0 53.0 53.0 53.0 52.0 54.0 59.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 14:16:50 INFO - PROCESS | 28920 | Values: 60.0 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.00 stddev:10.43 (13.0%) stddev-sans-first:10.89 14:16:50 INFO - PROCESS | 28920 | Values: 78.0 83.0 82.0 77.0 78.0 78.0 78.0 84.0 112.0 82.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:125.00 stddev:9.08 (7.3%) stddev-sans-first:7.68 14:16:50 INFO - PROCESS | 28920 | Values: 141.0 118.0 120.0 117.0 118.0 119.0 121.0 129.0 138.0 133.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.00 stddev:2.95 (1.9%) stddev-sans-first:3.08 14:16:50 INFO - PROCESS | 28920 | Values: 153.0 152.0 158.0 154.0 154.0 161.0 153.0 154.0 155.0 151.0 14:16:50 INFO - PROCESS | 28920 | 14:16:50 INFO - PROCESS | 28920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.11 (3.4%) stddev-sans-first:2.22 14:16:50 INFO - PROCESS | 28920 | Values: 62.0 64.0 62.0 62.0 63.0 61.0 61.0 63.0 61.0 68.0 14:16:50 INFO - PROCESS | 28920 | -------- Summary: end -------- 14:16:50 INFO - PROCESS | 28920 | 14:16:51 INFO - TEST-INFO | 28920: exit 0 14:16:51 INFO - TEST-OK | kraken | took 61876ms 14:16:51 INFO - SUITE-END | took 1172s 14:16:51 INFO - Completed test suite (00:19:32) 14:16:51 INFO - javascript benchmark 14:16:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.01963268546, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.916077098072, 3405.6934875861166, 3414.1976635490655, 3423.8801641942537, 3439.5184674145607, 5646.548276137909, 5675.716214189295, 5716.971415142919, 5756.568257380697, 5779.450952159548, 5746.913796293048, 5755.539556835453, 5773.826785196451, 5789.855253618662, 5793.507551858097, 5155.252488389191, 5222.529972302492, 5234.26720259164, 5262.473752624745, 5295.0733621616255, 5098.796048158069, 5178.430372659004, 5253.7373131343475, 5265.947340526584, 5281.181416880389, 5206.661566998152, 5207.609429292818, 5207.661502002376, 5222.843314700565, 5231.084560201968, 5257.921131183035, 5271.736413179345, 5275.920861187085, 5278.656887302313, 5318.680879147263, 4999.275105109775, 5102.081625307444, 5116.820911268088, 5145.228215767627, 5168.483151684839, 5565.916511252334, 5579.721013949327, 5608.691521966291, 5626.409227031144, 5657.462541058634, 6132.632042077445, 6148.354422785633, 6155.84610384744, 6157.538184636125, 6165.938340616582, 5983.192269043667, 6111.039264645882, 6142.324344322121, 6182.227221597301, 6202.41077097675, 5841.211436456109, 5842.444967728102, 5842.912356314701, 5853.209816674779, 5868.413158684098, 6315.273743519554, 6395.2645445773405, 6400.295967443578, 6404.7117879695525, 6416.615003099829, 5885.882282354414, 5985.491233245136, 6029.969850150721, 6063.969680151571, 6103.877922441527, 6144.139482116908, 6146.631202127797, 6169.259688837368, 6170.382961703884, 6182.443580077725, 5927.436893495197, 6137.619035717017, 6143.0, 6149.046897730859, 6176.320604733476, 6084.0, 6093.939060609426, 6143.170671959318, 6150.3849615039035, 6179.536534759821, 4672.883177920511, 4679.742614156254, 4681.250999840009, 4711.0342379812055, 4714.669973101919, 4090.0, 4092.3861420786525, 4214.810333534937, 4219.556946520633, 4254.234237837219, 5741.655500669973, 5828.358880523139, 5860.560457965669, 5963.403659634002, 5988.970055149696, 6142.385761423911, 6145.047517634774, 6155.199824022938, 6158.107074474176, 6162.599431036968, 5722.456366645162, 5877.118432235199, 5903.675297858659, 5933.614315069507, 5938.554608404387, 5183.50756678115, 5234.659747116425, 5259.395169555473, 5269.1569348903995, 5288.81489147878, 6496.707648155844, 6498.967505162444, 6502.219733631994, 6508.284088750233, 6508.60948343101, 5930.52555795544, 6047.848803779941, 6087.482563982111, 6190.0405437158215, 6197.845053873689, 6446.258680251831, 6447.806565803034, 6464.159659244268, 6478.740850365933, 6481.708323125376, 6030.03519436888, 6055.969720151371, 6056.031035034373, 6059.787907423395, 6065.909011364922, 5940.46535811779, 6037.184980027816, 6063.484603808725, 6098.420650038239, 6146.385361463817, 5950.940490595039, 5955.404459554184, 5963.9105413417965, 5968.910466343095, 5987.341392446914, 5922.170896074467, 5933.614315069507, 5945.167676525376, 5979.162917191509, 6000.249968753906, 5719.714014299185, 5740.655560666373, 5877.94122058774, 5903.704814759159, 5940.8811823764145, 6036.154938308552, 6083.330833608211, 6088.665123418077, 6089.69551522431, 6106.992346262817, 5932.970335148297, 5996.430339117776, 5999.640021598718, 6000.69996500182, 6006.0], "value": 5668.336642973761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7923306075934, 666.3270097201827, 673.1350214973758, 674.5008693566759, 685.3626127701242, 40761.79619101904, 43768.0, 43977.78011109948, 44080.01639926203, 44169.77915110428, 44311.55688443115, 44915.10169796602, 45015.54984450155, 45063.0, 45324.0, 8832.690855820048, 9022.142896424863, 9028.77428064297, 9033.683821066264, 9049.819003619956, 8849.380543361967, 8868.423552469101, 8869.113088691143, 8909.777255568597, 8947.821043579124, 8873.467591944473, 8968.551572421386, 8970.192682658559, 8972.820543589125, 9001.594928228213, 8879.778005549848, 8946.955265223633, 8970.372073954826, 8984.0, 8988.640454381817, 8979.730608081769, 9065.81868362629, 9066.95466522663, 9068.047854975199, 9081.636734530612, 42702.57297427017, 42718.14563708739, 43092.353614695494, 43136.56863431388, 43270.0, 3367.8821241256437, 3405.387030334539, 3631.182983828644, 3731.3470142724914, 3950.6641935435523, 33050.83474582636, 33198.50202246944, 35095.0, 35364.0, 36079.81960090209, 4662.510436404196, 4698.765061746899, 4718.433787945434, 4791.688540244908, 4824.252240902666, 376151.0, 383269.0, 384013.0, 384090.0, 384315.0, 40200.79899600542, 63595.68202158959, 64099.679501603125, 64522.67738661371, 64581.35418645848, 41090.58909410927, 42959.140817183485, 43266.13467730691, 43333.0, 43387.34918976218, 15933.12367819781, 16231.67536649284, 16241.106739129225, 16244.59388515273, 16260.0, 14477.782833257299, 14619.415223390944, 14620.926895365455, 14711.926440367944, 14723.411063557553, 9650.372725772802, 9710.563024663907, 9731.12419882214, 9800.705978820646, 9815.312928095107, 3654.798986055739, 3679.7424180307657, 3700.851965921333, 3708.072981754561, 3737.7757334560015, 1045.8326667733127, 1049.7585555322319, 1080.1682704317632, 1097.6322931817772, 1214.8967337776212, 32486.187845304055, 32610.0, 32612.83693581517, 32662.34675306528, 33062.08574336578, 1157.2420064857363, 1163.8079716846794, 1171.2211379432752, 1206.6621346023128, 1226.2336039975016, 17123.315067397165, 17226.913865430593, 17303.74044389335, 17387.73918391225, 17640.735388969177, 579224.0, 599502.0, 603349.0, 617284.0, 622463.0, 62752.37247627465, 69867.65066174636, 70171.64914175498, 70204.2979570208, 70220.64889675518, 1485.0866716968985, 1493.4324956516455, 1513.2963172124794, 1532.6398296400337, 1535.2707463954532, 33934.151646209044, 34487.137821554665, 34626.65373346234, 34761.0, 34811.0, 57085.14372284502, 57836.0, 58037.12944305754, 58055.0, 58060.709696451246, 580285.0, 582470.0, 583450.0, 588607.0, 591620.0, 48162.759186203846, 48363.0, 48815.267770984174, 49262.50737492723, 49423.50576494333, 52122.73938630283, 52149.21776173285, 53352.19971700505, 53515.73242133764, 53655.73172134271, 44036.33945490884, 44287.778561106985, 45111.32333015073, 45233.151592103495, 45494.090118196786, 44046.77976610096, 44301.77849110863, 44968.55031449775, 45306.773466133774, 45891.77054114708, 44537.554624454635, 44793.552064478936, 45129.323060154784, 45186.548134518234, 45326.32010519779, 37469.62530374771, 37849.24301513899, 39101.80449097736, 39244.2151156981, 40128.0, 29177.416451670422, 29816.0, 29966.25084372908, 30278.243043924078, 30487.847560762053], "value": 20689.447179572322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.82031546750363, 428.3467711739599, 432.2069003378799, 439.15462734236604, 440.06767262876883, 18614.06929653517, 20276.99999999998, 20609.96950152492, 21686.56626867462, 21745.67381489279, 19942.50143746407, 20040.198392064336, 20999.47501312468, 21030.894845525752, 21101.26145584905, 5872.999999999989, 6037.184980027684, 6046.244219472566, 6059.242594675666, 6086.482648974842, 5785.27684039495, 5933.13969474426, 5983.341832398432, 5996.760129594811, 5999.430054144871, 5955.523558115362, 5957.404259574051, 5957.88084238315, 5958.285005799288, 5958.6424814511265, 5697.8575535611735, 5957.225560677128, 5957.791477298274, 5968.522518198533, 5968.522518198533, 5317.680939143664, 5319.122344813101, 5382.703951282678, 5383.73081345935, 5384.1923711443205, 24703.641299728508, 24741.381465463328, 25022.4995500089, 25086.0, 25111.37221569457, 2571.0230112557297, 2571.485702859417, 2600.982859882546, 2663.3341664583854, 2957.7633789296806, 15199.544013679497, 15336.693266134727, 15431.459898903484, 15549.0, 15667.608309792233, 2034.410021093881, 2114.3445531885013, 2124.5326028273753, 2200.702905107806, 2243.0467051503047, 56488.0, 85397.03163260182, 88864.55567722184, 89071.0, 91416.54291728565, 9899.356541824758, 10431.426271554985, 10660.46697665129, 10851.0, 11606.709832254091, 14670.926645366704, 14686.339114739862, 14725.852741472663, 14757.48348807808, 14841.851581484047, 8266.586670666564, 8429.4942303462, 8450.239478446969, 8454.0, 8569.271611913056, 8337.666493340199, 8345.666173352998, 8495.872561911576, 8608.0, 8631.654733810703, 4438.800253988578, 4515.277555591156, 4545.681802273875, 4582.5646563577075, 4608.354830323758, 2099.5695882344085, 2109.9472513187293, 2126.1920470221526, 2138.5295235048266, 2142.6036183306137, 1048.8112139814755, 1062.1874266186373, 1075.8224892892742, 1090.9690342626143, 1104.100158370925, 18233.817661823476, 19207.80792192088, 19701.310454134036, 19860.50348741264, 21584.460388490414, 1056.8520407143005, 1057.2704833664748, 1060.2525219720078, 1089.6077412131626, 1101.4382664840828, 11407.48666310018, 11456.885431145582, 11546.249493782878, 11570.652880413601, 11656.766864662828, 527739.0, 530115.0, 532777.0, 556570.0, 556792.0, 103016.0, 105034.0, 105320.0, 107246.46376768066, 108730.0, 1111.5887121764838, 1149.3850789827402, 1169.2049406403728, 1195.7787809255315, 1201.3332600406684, 17679.469615911545, 17704.849184802948, 17868.19593118339, 17912.91043544774, 18100.63798723992, 43257.13485730331, 43450.34824477572, 43960.560394396925, 44860.551394485636, 44948.66724118068, 58845.411545885705, 61037.38962610317, 62547.0, 63162.368376317485, 64188.35811641824, 8981.955090224506, 9222.308326875645, 9229.169374756304, 9277.118673726256, 9410.341276110606, 13120.081594288307, 13215.93392033072, 13823.861761382257, 13991.650208744863, 14162.079464834753, 11968.222065565711, 12339.69150771238, 12382.752344953231, 12473.625791226277, 12492.750144997231, 11354.772904542027, 11590.478428470571, 11689.006434452827, 11800.52797888075, 12082.697932551757, 11994.0, 12222.511099556274, 12268.754624907631, 12284.631461056182, 12771.10602257833, 9065.728028159167, 9149.679761208326, 9271.072892710676, 9295.349325547148, 9316.44101353921, 12004.75990480168, 12011.699707507381, 12245.938770306091, 12267.87732122703, 12341.321227332224], "value": 9824.05972233935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.6713356628327, 1562.4843801545492, 1745.615964487813, 1834.4496651004695, 1863.040534124926, 8606.569671516414, 9309.720708378743, 9401.952990235057, 9906.108450239486, 9934.205263578915, 9311.348205625609, 9625.711228663135, 9727.513624318774, 9734.0, 9753.219742420608, 2484.167803785734, 2508.2475257422793, 2516.48412075525, 2520.0, 2526.381036646015, 2429.283361408389, 2510.661060756802, 2513.3590934311815, 2515.962260566093, 2518.9496210075786, 2472.6909136357954, 2485.8135639826996, 2488.912888048919, 2501.6122501012374, 2505.08564374004, 2377.6909001829736, 2421.5520128776143, 2424.1757802347197, 2489.103922587867, 2494.0397946790436, 2151.9354419367446, 2190.7371115466085, 2208.5251670890675, 2210.502636906683, 2230.553889222162, 9636.084571965652, 9735.415875047449, 9746.853797193047, 9778.41329520231, 9783.168430683401, 5338.5996050296, 5461.481159289861, 5488.067028605146, 5489.643173193769, 5495.450454954513, 3634.2186429917697, 3657.9817100914593, 3662.6520480554304, 3693.076730817296, 3743.382341913581, 1258.23876554684, 1271.9458075208472, 1272.166730791333, 1275.5408053100875, 1292.360281660584, 13599.388027538784, 13670.794938075838, 13718.862811371959, 13752.31238438084, 13768.724625507533, 5012.649114561946, 5060.291559181717, 5112.923306150411, 5160.509751573594, 5199.2201169824075, 11443.885561144449, 11447.0, 11466.656000320003, 11486.827697584544, 11501.13741469393, 5623.10030395143, 5630.690312032878, 5637.0, 5643.717814109278, 5645.661260324394, 4739.976300118477, 4944.085344211332, 5014.222795466709, 5127.564157046693, 5136.897262054738, 4437.400950871655, 4513.119941611354, 4527.411436513232, 4538.977305113519, 4703.764811759398, 1335.2722766092502, 1422.8292604887479, 1426.7574512332928, 1436.4972259709018, 1439.2228196773624, 1024.6516184497307, 1033.565902321027, 1054.7626783973544, 1055.8310670292717, 1075.693427373195, 6150.292716337678, 6521.02184672303, 6541.8364540885905, 6580.703868325841, 6588.077669126326, 483.9153148199051, 485.9465458799529, 486.04977269438166, 502.7461132128252, 509.2691986998669, 4376.824927002948, 4381.737095774264, 4435.622972047412, 4478.059607482465, 4484.955150448519, 11847.229930054518, 12212.511499540096, 12253.326067066218, 12291.754164916652, 12296.20074695142, 11828.23116497425, 12049.819252711217, 12049.939750301368, 12238.755224895453, 12255.877441225652, 8859.51272679996, 8906.153915378029, 8965.506897120591, 9014.323925705598, 9027.14242146995, 6284.0, 6378.617282963037, 6410.1025856381075, 6473.158489396348, 6490.902636460552, 10872.945635271773, 11179.441027948407, 11229.66311010671, 11278.154138439813, 11280.09759219277, 11296.378699171624, 11301.321920684784, 11317.547298107984, 11405.144614153805, 11441.542338306375, 8220.712275070344, 8251.546164960744, 8530.573471326534, 8539.359548034046, 8589.613467393858, 9354.391964522285, 9453.054694530492, 9479.146876781122, 9519.0, 9552.283578731483, 8374.916250837414, 8618.181272779077, 8646.394752367274, 8693.521856297964, 8767.780805479913, 8234.464759790595, 8242.546659933761, 8479.872801907853, 8498.70254541088, 8501.532415717194, 7268.345848873627, 7283.308085731847, 7319.487635865651, 7329.486935914648, 7334.083239595051, 5514.91727624078, 5559.27729395176, 5620.437956204347, 5711.8000869969355, 5730.799422020209, 5437.429069947757, 5477.370102438271, 5538.0, 5547.667139971614, 5587.944120558743], "value": 4945.490481645726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.58272127474163, 345.2628637858172, 345.97578169528134, 346.3747934977366, 350.33086804203975, 5704.973104841127, 5725.255716756827, 5728.513076388507, 5749.246479823652, 5755.223044888939, 5620.690862002588, 5660.2075709400715, 5661.8393229387975, 5672.943270567293, 5682.659040457575, 4199.958000419995, 4368.104538569602, 4374.540673229297, 4374.97812510937, 4415.88960275994, 4364.825406983717, 4371.0, 4379.562043795611, 4382.605565499104, 4386.627136693385, 4345.500267469234, 4351.238533256684, 4372.868813935587, 4376.540463251361, 4380.364847097169, 4225.9788701056605, 4382.9342559861625, 4403.603675669173, 4406.977965110186, 4427.712198707074, 3831.942520862189, 3850.0, 3853.614638536152, 3905.4141878718137, 3922.5685174630767, 5420.91868621967, 5447.863803404946, 5449.945500544984, 5471.179323101527, 5480.424555421663, 5042.1428357179, 5091.159958606825, 5098.133317336062, 5119.232115182753, 5120.0, 5908.248262353393, 5923.733431995527, 5930.347661757203, 5951.58338916276, 5965.642061476326, 4377.5403582623685, 4386.508587080408, 4390.714603550759, 4392.143532011259, 4419.4033805436175, 5961.642301461926, 6158.630482171084, 6192.938070619326, 6216.720247588869, 6218.657973811439, 4466.932996005063, 4477.664175186874, 4483.798229079699, 4489.438820147481, 4503.842365517191, 4503.414556107685, 4506.504284528699, 4531.274996000624, 4535.909281814345, 4538.636909047268, 4849.466558678613, 5048.0, 5086.669366491166, 5103.0, 5106.387233532, 5974.163617093611, 6002.459778619857, 6012.128241404972, 6037.426444487766, 6053.576249662569, 1564.4289834210658, 1578.6423675638941, 1579.723548379052, 1602.4952140075839, 1602.7355486344622, 989.5744829723288, 1001.0390025575529, 1004.6885465505717, 1017.2675673515057, 1027.465717826726, 5781.94218057814, 5792.391798861143, 5817.505512031525, 5818.6217895836635, 5823.068309070529, 5973.372795856372, 6043.887397990039, 6048.576599637983, 6076.635401875901, 6091.23354227278, 5668.149777533403, 5801.245838041028, 5818.592698511064, 5831.912521312183, 5852.917210316105, 3231.2874176685923, 3243.594550681165, 3244.3349113432164, 3252.10567094051, 3274.5415641810164, 6122.846928826815, 6295.622262664255, 6333.0, 6338.397852204033, 6376.617402955838, 6063.514918806485, 6153.015517517176, 6204.5967012144965, 6210.7515699372425, 6233.688315584202, 6057.727877145849, 6305.747770089237, 6372.58578192416, 6390.265119511316, 6395.52033597482, 6136.0, 6144.324124346408, 6145.600535965148, 6184.257889053342, 6212.968935155295, 5972.611780234271, 6082.36135205797, 6085.756569737161, 6107.572469927062, 6110.938890611037, 6274.435300822948, 6388.616682999035, 6442.099580623633, 6449.290937901366, 6453.612783232833, 4352.760598167131, 4383.342498625232, 4396.010897548026, 4400.0, 4407.427034485497, 5998.370171131968, 6158.199434073542, 6164.47601953839, 6177.536684748752, 6189.195404597373, 5980.401959803985, 6004.0693692477735, 6008.669523176267, 6009.519238461, 6020.397960203944, 5980.09965166885, 5982.790602328898, 5988.401159883977, 5993.430624090704, 6001.879962400815, 5729.0, 5782.739776710142, 5882.911756323573, 5903.350631430625, 5934.495567876779, 6040.6677632730625, 6042.697865106815, 6045.909311360245, 6049.334573197033, 6070.964517741129, 5615.747291371817, 5924.851878703067, 5928.614640048383, 5943.71167100678, 5964.165016897725], "value": 4563.162784515933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.4380583145147, 744.1962680305271, 746.2313816768728, 771.5563550958201, 861.9698310559128, 15073.773893391608, 15552.0, 15600.687986240282, 15604.0, 15658.295376708047, 16176.0, 16275.91862040691, 16302.510924672279, 16347.509574712747, 16533.66932661346, 851.7870532366924, 869.7825543614097, 870.78665726897, 872.720729366603, 874.8600223964168, 865.7575878753928, 872.071244125008, 873.978150546235, 874.2656168818191, 875.7197696737047, 924.6578765856642, 925.865749466327, 926.7636752628105, 928.6053427293407, 929.7768535551453, 916.4776077635751, 920.585736418611, 921.7511271956535, 921.944683319003, 922.557172557173, 679.4224908827506, 680.1939701453794, 680.4998326230217, 680.9897851532231, 682.0178942323039, 13931.651708707263, 13954.651133721636, 13980.370883310276, 14039.508617198451, 14181.0, 15215.543533693895, 15359.232038398035, 15627.843721562753, 15638.609034774108, 16020.198990050567, 12846.807297890538, 13069.934650326783, 13361.532346367927, 13392.598222053353, 13444.462221511129, 4066.5323487798987, 4101.97949010256, 4124.463819703449, 4160.479940007499, 4205.91588168238, 67470.0, 71084.99999999948, 71853.0, 79802.0, 81605.59197204035, 11571.710707232387, 11983.161178717406, 12209.816852747215, 12491.750164996649, 12670.36648167588, 23116.075356985868, 23596.41008974755, 23611.055557777498, 23670.881645592006, 23732.0, 8321.583920803936, 8395.0, 8407.747767566983, 8705.6517739291, 8746.956265218632, 4454.487733910577, 4548.928708805601, 4549.727016379028, 4558.748664916512, 4741.047146969489, 3883.3980732986433, 3970.285348637215, 3994.2410941920944, 4041.211963667057, 4053.756774593534, 723.616483263871, 727.294524311417, 727.7198278662647, 729.3180875881068, 740.2301606329464, 681.3084719010209, 699.7410957945491, 764.6597264217481, 793.1513280789616, 810.1574362662883, 10841.349519028883, 10953.507092180711, 11095.50070246841, 11105.278156919936, 11116.110711143088, 617.1917774127701, 745.9917782603744, 784.1687810920442, 785.4855069929206, 808.6320724070533, 5098.745062746922, 5323.618385969811, 5379.435159308295, 5388.568914486832, 5435.119077337876, 68795.31204687989, 70724.64637676881, 72231.27768722245, 74141.62929185427, 74196.62901685457, 92058.0, 102720.0, 103084.0, 103869.0, 104557.47721261498, 58333.08334583339, 81178.59410702909, 89615.10384896198, 92108.0, 97242.51378743061, 10149.34029288094, 10469.842952355568, 10602.0, 10677.199210059121, 10808.567657293936, 43967.56032439635, 51502.48497514977, 55138.72430637821, 55696.443035570745, 56347.71826140843, 50509.747451262505, 67795.66102169457, 68471.31528684849, 69593.0, 73162.0, 12473.189242699196, 12827.807582886078, 13781.724365512835, 13798.121972128727, 14080.647983800078, 13988.58034258974, 14773.630659233606, 15052.473163439226, 15772.974756640782, 15873.365065397255, 14581.708365832836, 14624.415023398944, 14641.267936602913, 14684.632884177981, 14766.557003289918, 12654.683632909251, 14015.859841401456, 14267.571972840831, 14970.32633531472, 15012.6997460048, 14086.866350257069, 14262.358193881093, 14338.139711617336, 14461.638459038608, 14559.563213103624, 10206.489675516343, 10453.634122805664, 10606.416647084485, 10911.236213464981, 11105.278156919774, 11398.259113157617, 12080.21478603888, 12224.38878056076, 12336.568220112253, 12351.25892446456], "value": 7817.860633158892, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 112.0, 112.0, 111.0, 110.0, 110.0, 109.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 157.0, 169.0, 134.0, 161.0, 155.0, 126.0, 184.0, 132.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 163.0, 162.0, 160.0, 163.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 174.0, 75.0, 75.0, 75.0, 76.0, 180.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 153.0, 85.0, 84.0, 83.0, 141.0, 86.0, 84.0, 136.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 150.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 56.0, 53.0, 53.0, 53.0, 52.0, 54.0, 59.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 82.0, 77.0, 78.0, 78.0, 78.0, 84.0, 112.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 120.0, 117.0, 118.0, 119.0, 121.0, 129.0, 138.0, 133.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 158.0, 154.0, 154.0, 161.0, 153.0, 154.0, 155.0, 151.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 61.0, 61.0, 63.0, 61.0, 68.0], "value": 62.7, "unit": "score"}]}]} 14:16:51 INFO - Return code: 0 14:16:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:51 ERROR - # TBPL SUCCESS # 14:16:51 INFO - Running post-action listener: _resource_record_post_action 14:16:51 INFO - ##### 14:16:51 INFO - ##### Finished run-tests step (success) 14:16:51 INFO - ##### 14:16:51 INFO - Running post-run listener: _resource_record_post_run 14:16:51 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 28672; Write bytes: 453120000; Read time: 24; Write time: 561020 14:16:51 INFO - TinderboxPrint: CPU usage
13.3% 14:16:51 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 24 14:16:51 INFO - TinderboxPrint: I/O write bytes / time
453,120,000 / 561,020 14:16:51 INFO - TinderboxPrint: CPU idle
8,209.5 (86.7%) 14:16:51 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 14:16:51 INFO - TinderboxPrint: Swap in / out
0 / 0 14:16:51 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 235483136; Read time: 0; Write time: 389624 14:16:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217636864; Read time: 16; Write time: 171396 14:16:52 INFO - Running post-run listener: _upload_blobber_files 14:16:52 INFO - Blob upload gear active. 14:16:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:52 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 14:16:52 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'] 14:16:52 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 14:16:52 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:53 INFO - (blobuploader) - INFO - Done attempting. 14:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:54 INFO - (blobuploader) - INFO - Done attempting. 14:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:00 INFO - (blobuploader) - INFO - Done attempting. 14:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:17:00 INFO - Return code: 0 14:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1e930ba9c598e70e4fc12efda9e4d229bad26aa33e09011df8e1eb0c0743b5f2aea74ce089ef55914c50bbed83222a9a808cd8676453b49e7451252e66df2ba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efa9ff540e7ca8c0477bb160af6cfa760ab27f45866f155a1a17ad4afbcd9ee21b5b5ae8095b3005ca8a5227aee1f6e149440fd3d610b9992594a55a77aadc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb0a511950db2fbc07be9fe5ee2b97606ea71d1f2fc2e495e5dacd206e2a07c68b610eb67daba3b0b58fc97ccc55036a454495deeb356680b14c89a497bcfd3"} 14:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:17:00 INFO - Contents: 14:17:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1e930ba9c598e70e4fc12efda9e4d229bad26aa33e09011df8e1eb0c0743b5f2aea74ce089ef55914c50bbed83222a9a808cd8676453b49e7451252e66df2ba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efa9ff540e7ca8c0477bb160af6cfa760ab27f45866f155a1a17ad4afbcd9ee21b5b5ae8095b3005ca8a5227aee1f6e149440fd3d610b9992594a55a77aadc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb0a511950db2fbc07be9fe5ee2b97606ea71d1f2fc2e495e5dacd206e2a07c68b610eb67daba3b0b58fc97ccc55036a454495deeb356680b14c89a497bcfd3"} 14:17:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:17:00 INFO - Copying logs to upload dir... 14:17:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:17:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.113659 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-02 14:16:59.889152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 14:16:59.892459) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 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/1e930ba9c598e70e4fc12efda9e4d229bad26aa33e09011df8e1eb0c0743b5f2aea74ce089ef55914c50bbed83222a9a808cd8676453b49e7451252e66df2ba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efa9ff540e7ca8c0477bb160af6cfa760ab27f45866f155a1a17ad4afbcd9ee21b5b5ae8095b3005ca8a5227aee1f6e149440fd3d610b9992594a55a77aadc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb0a511950db2fbc07be9fe5ee2b97606ea71d1f2fc2e495e5dacd206e2a07c68b610eb67daba3b0b58fc97ccc55036a454495deeb356680b14c89a497bcfd3"} build_url:https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/L6RShwaNQk6qUlNCnE_Zjw/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/1e930ba9c598e70e4fc12efda9e4d229bad26aa33e09011df8e1eb0c0743b5f2aea74ce089ef55914c50bbed83222a9a808cd8676453b49e7451252e66df2ba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efa9ff540e7ca8c0477bb160af6cfa760ab27f45866f155a1a17ad4afbcd9ee21b5b5ae8095b3005ca8a5227aee1f6e149440fd3d610b9992594a55a77aadc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb0a511950db2fbc07be9fe5ee2b97606ea71d1f2fc2e495e5dacd206e2a07c68b610eb67daba3b0b58fc97ccc55036a454495deeb356680b14c89a497bcfd3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 14:16:59.918109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 14:16:59.918438) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470171387.200854-422750262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 14:17:00.000959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 14:17:00.001292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 14:17:00.001612) ========= ========= Total master_lag: 0.18 =========