builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1465260132.15 results: success (0) buildid: 20160606053005 builduid: 7afa8ff62dfa40a2ae994ec404a4246c revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.146547) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.147019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.147290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.161447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.161749) ========= 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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 17:42:12-- 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% 78.7M=0s 2016-06-06 17:42:12 (78.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.273035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.273377) ========= 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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013625 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.322582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:12.322974) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a6cb441259d532d321f56272b26a322dbdc2caa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6a6cb441259d532d321f56272b26a322dbdc2caa --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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 17:42:12,398 truncating revision to first 12 chars 2016-06-06 17:42:12,398 Setting DEBUG logging. 2016-06-06 17:42:12,398 attempt 1/10 2016-06-06 17:42:12,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a6cb441259d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 17:42:12,706 unpacking tar archive at: fx-team-6a6cb441259d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:13.027069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:13.027607) ========= script_repo_revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:13.028328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:13.028792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:42:13.040006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 17:42:13.040305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:13 INFO - MultiFileLogger online at 20160606 17:42:13 in /builds/slave/test 17:42:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:42:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:13 INFO - {'append_to_log': False, 17:42:13 INFO - 'base_work_dir': '/builds/slave/test', 17:42:13 INFO - 'blob_upload_branch': 'Fx-Team', 17:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:13 INFO - 'branch': 'Fx-Team', 17:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:13 INFO - 'config_files': ('talos/linux_config.py',), 17:42:13 INFO - 'default_actions': ('clobber', 17:42:13 INFO - 'read-buildbot-config', 17:42:13 INFO - 'download-and-extract', 17:42:13 INFO - 'populate-webroot', 17:42:13 INFO - 'create-virtualenv', 17:42:13 INFO - 'install', 17:42:13 INFO - 'run-tests'), 17:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:13 INFO - 'download_minidump_stackwalk': True, 17:42:13 INFO - 'download_symbols': 'ondemand', 17:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:13 INFO - 'installer_path': 'installer.exe', 17:42:13 INFO - 'log_level': 'info', 17:42:13 INFO - 'log_name': 'talos', 17:42:13 INFO - 'log_to_console': True, 17:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:13 INFO - 'opt_config_files': (), 17:42:13 INFO - 'pip_index': False, 17:42:13 INFO - 'sps_profile': False, 17:42:13 INFO - 'sps_profile_interval': 0, 17:42:13 INFO - 'suite': 'dromaeojs-e10s', 17:42:13 INFO - 'system_bits': '32', 17:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:13 INFO - 'title': 'talos-linux64-ix-021', 17:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:13 INFO - 'use_talos_json': True, 17:42:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:13 INFO - 'work_dir': 'build'} 17:42:13 INFO - ##### 17:42:13 INFO - ##### Running clobber step. 17:42:13 INFO - ##### 17:42:13 INFO - Running pre-action listener: _resource_record_pre_action 17:42:13 INFO - Running main action method: clobber 17:42:13 INFO - rmtree: /builds/slave/test/build 17:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:14 INFO - Running post-action listener: _resource_record_post_action 17:42:14 INFO - ##### 17:42:14 INFO - ##### Finished clobber step (success) 17:42:14 INFO - ##### 17:42:14 INFO - ##### 17:42:14 INFO - ##### Running read-buildbot-config step. 17:42:14 INFO - ##### 17:42:14 INFO - Running pre-action listener: _resource_record_pre_action 17:42:14 INFO - Running main action method: read_buildbot_config 17:42:14 INFO - Using buildbot properties: 17:42:14 INFO - { 17:42:14 INFO - "project": "", 17:42:14 INFO - "product": "firefox", 17:42:14 INFO - "script_repo_revision": "production", 17:42:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:42:14 INFO - "repository": "", 17:42:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:42:14 INFO - "buildid": "20160606053005", 17:42:14 INFO - "pgo_build": "True", 17:42:14 INFO - "basedir": "/builds/slave/test", 17:42:14 INFO - "buildnumber": 429, 17:42:14 INFO - "slavename": "talos-linux64-ix-021", 17:42:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:42:14 INFO - "platform": "ubuntu64_hw", 17:42:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:42:14 INFO - "branch": "fx-team", 17:42:14 INFO - "repo_path": "integration/fx-team", 17:42:14 INFO - "revision": "6a6cb441259d532d321f56272b26a322dbdc2caa", 17:42:14 INFO - "stage_platform": "linux64-pgo", 17:42:14 INFO - "builduid": "7afa8ff62dfa40a2ae994ec404a4246c", 17:42:14 INFO - "slavebuilddir": "test" 17:42:14 INFO - } 17:42:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:42:14 INFO - Running post-action listener: _resource_record_post_action 17:42:14 INFO - ##### 17:42:14 INFO - ##### Finished read-buildbot-config step (success) 17:42:14 INFO - ##### 17:42:14 INFO - ##### 17:42:14 INFO - ##### Running download-and-extract step. 17:42:14 INFO - ##### 17:42:14 INFO - Running pre-action listener: _resource_record_pre_action 17:42:14 INFO - Running main action method: download_and_extract 17:42:14 INFO - mkdir: /builds/slave/test/build/tests 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:14 INFO - https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:42:14 INFO - Downloaded 1361 bytes. 17:42:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:42:14 INFO - Using the following test package requirements: 17:42:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:42:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:42:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'jsshell-linux-x86_64.zip'], 17:42:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:42:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:42:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:42:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:42:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:42:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:14 INFO - https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:16 INFO - Downloaded 24443732 bytes. 17:42:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:42:17 INFO - Return code: 0 17:42:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:42: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')]} 17:42:17 INFO - https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:18 INFO - Downloaded 24443732 bytes. 17:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:42:20 INFO - Return code: 0 17:42:20 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')]} 17:42:20 INFO - https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:42:21 INFO - Downloaded 10833369 bytes. 17:42:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:42:21 INFO - Return code: 0 17:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:21 INFO - https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:42:22 INFO - Downloaded 59166024 bytes. 17:42:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:42:22 INFO - mkdir: /builds/slave/test/properties 17:42:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:22 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:22 INFO - Contents: 17:42:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:42:23 INFO - Running post-action listener: _resource_record_post_action 17:42:23 INFO - Running post-action listener: set_extra_try_arguments 17:42:23 INFO - ##### 17:42:23 INFO - ##### Finished download-and-extract step (success) 17:42:23 INFO - ##### 17:42:23 INFO - ##### 17:42:23 INFO - ##### Running populate-webroot step. 17:42:23 INFO - ##### 17:42:23 INFO - Running pre-action listener: _resource_record_pre_action 17:42:23 INFO - Running main action method: populate_webroot 17:42:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:23 INFO - '--tppagecycles', 17:42:23 INFO - '7'], 17:42:23 INFO - 'tests': ['tsvgm']}}, 17:42:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['damp', 'tps']}, 17:42:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'tests': ['damp', 'tps']}, 17:42:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['dromaeo_dom']}, 17:42:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['a11yr', 17:42:23 INFO - 'ts_paint', 17:42:23 INFO - 'tpaint', 17:42:23 INFO - 'sessionrestore', 17:42:23 INFO - 'sessionrestore_no_auto_restore', 17:42:23 INFO - 'tabpaint']}, 17:42:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['tsvgx', 17:42:23 INFO - 'tsvgr_opacity', 17:42:23 INFO - 'tart', 17:42:23 INFO - 'tscrollx', 17:42:23 INFO - 'cart']}, 17:42:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:23 INFO - 'tsvgr_opacity', 17:42:23 INFO - 'tart', 17:42:23 INFO - 'tscrollx', 17:42:23 INFO - 'cart']}, 17:42:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'talos_options': ['--disable-e10s'], 17:42:23 INFO - 'tests': ['tp5o']}, 17:42:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'tests': ['tp5o']}, 17:42:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'talos_options': ['--disable-e10s', 17:42:23 INFO - '--xperf_path', 17:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:23 INFO - 'tests': ['tp5n']}, 17:42:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:23 INFO - 'talos_options': ['--xperf_path', 17:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:23 INFO - 'tests': ['tp5n']}}, 17:42:23 INFO - 'talos.zip': {'path': '', 17:42:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:23 INFO - Running post-action listener: _resource_record_post_action 17:42:23 INFO - ##### 17:42:23 INFO - ##### Finished populate-webroot step (success) 17:42:23 INFO - ##### 17:42:23 INFO - ##### 17:42:23 INFO - ##### Running create-virtualenv step. 17:42:23 INFO - ##### 17:42:23 INFO - Running pre-action listener: _resource_record_pre_action 17:42:23 INFO - Running main action method: create_virtualenv 17:42:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:23 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 17:42:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:23 INFO - Using real prefix '/usr' 17:42:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:26 INFO - Installing pip.................done. 17:42:26 INFO - Return code: 0 17:42:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:26 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')]} 17:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:26 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')]} 17:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:26 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:26 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 17:42:26 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 17:42:26 INFO - Using env: {'DISPLAY': ':0', 17:42:26 INFO - 'HOME': '/home/cltbld', 17:42:26 INFO - 'LANG': 'en_US.UTF-8', 17:42:26 INFO - 'LANGUAGE': 'en_US:en', 17:42:26 INFO - 'LOGNAME': 'cltbld', 17:42:26 INFO - 'MAIL': '/var/mail/cltbld', 17:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:26 INFO - 'MOZ_NO_REMOTE': '1', 17:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:26 INFO - 'NO_EM_RESTART': '1', 17:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:26 INFO - 'PWD': '/builds/slave/test', 17:42:26 INFO - 'SHELL': '/bin/bash', 17:42:26 INFO - 'SHLVL': '1', 17:42:26 INFO - 'TERM': 'linux', 17:42:26 INFO - 'TMOUT': '86400', 17:42:26 INFO - 'USER': 'cltbld', 17:42:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:26 INFO - '_': '/tools/buildbot/bin/python'} 17:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:26 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 17:42:26 INFO - Cleaning up... 17:42:26 INFO - Return code: 0 17:42:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:26 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')]} 17:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:26 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')]} 17:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:26 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:26 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 17:42:26 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 17:42:26 INFO - Using env: {'DISPLAY': ':0', 17:42:26 INFO - 'HOME': '/home/cltbld', 17:42:26 INFO - 'LANG': 'en_US.UTF-8', 17:42:26 INFO - 'LANGUAGE': 'en_US:en', 17:42:26 INFO - 'LOGNAME': 'cltbld', 17:42:26 INFO - 'MAIL': '/var/mail/cltbld', 17:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:26 INFO - 'MOZ_NO_REMOTE': '1', 17:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:26 INFO - 'NO_EM_RESTART': '1', 17:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:26 INFO - 'PWD': '/builds/slave/test', 17:42:26 INFO - 'SHELL': '/bin/bash', 17:42:26 INFO - 'SHLVL': '1', 17:42:26 INFO - 'TERM': 'linux', 17:42:26 INFO - 'TMOUT': '86400', 17:42:26 INFO - 'USER': 'cltbld', 17:42:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:26 INFO - '_': '/tools/buildbot/bin/python'} 17:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:26 INFO - Downloading/unpacking psutil>=3.1.1 17:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:27 INFO - Installing collected packages: psutil 17:42:27 INFO - Running setup.py install for psutil 17:42:27 INFO - building 'psutil._psutil_linux' extension 17:42:27 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 17:42:27 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 17:42:28 INFO - building 'psutil._psutil_posix' extension 17:42:28 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 17:42:28 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 17:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:28 INFO - Successfully installed psutil 17:42:28 INFO - Cleaning up... 17:42:28 INFO - Return code: 0 17:42:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:28 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:28 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 17:42:28 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 17:42:28 INFO - Using env: {'DISPLAY': ':0', 17:42:28 INFO - 'HOME': '/home/cltbld', 17:42:28 INFO - 'LANG': 'en_US.UTF-8', 17:42:28 INFO - 'LANGUAGE': 'en_US:en', 17:42:28 INFO - 'LOGNAME': 'cltbld', 17:42:28 INFO - 'MAIL': '/var/mail/cltbld', 17:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:28 INFO - 'MOZ_NO_REMOTE': '1', 17:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:28 INFO - 'NO_EM_RESTART': '1', 17:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:28 INFO - 'PWD': '/builds/slave/test', 17:42:28 INFO - 'SHELL': '/bin/bash', 17:42:28 INFO - 'SHLVL': '1', 17:42:28 INFO - 'TERM': 'linux', 17:42:28 INFO - 'TMOUT': '86400', 17:42:28 INFO - 'USER': 'cltbld', 17:42:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:28 INFO - '_': '/tools/buildbot/bin/python'} 17:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:28 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 17:42:28 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 17:42:28 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 17:42:28 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 17:42:28 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 17:42:28 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 17:42:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:30 INFO - Installing collected packages: mozsystemmonitor 17:42:30 INFO - Running setup.py install for mozsystemmonitor 17:42:30 INFO - Successfully installed mozsystemmonitor 17:42:30 INFO - Cleaning up... 17:42:30 INFO - Return code: 0 17:42:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:30 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:30 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 17:42:30 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 17:42:30 INFO - Using env: {'DISPLAY': ':0', 17:42:30 INFO - 'HOME': '/home/cltbld', 17:42:30 INFO - 'LANG': 'en_US.UTF-8', 17:42:30 INFO - 'LANGUAGE': 'en_US:en', 17:42:30 INFO - 'LOGNAME': 'cltbld', 17:42:30 INFO - 'MAIL': '/var/mail/cltbld', 17:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:30 INFO - 'MOZ_NO_REMOTE': '1', 17:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:30 INFO - 'NO_EM_RESTART': '1', 17:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:30 INFO - 'PWD': '/builds/slave/test', 17:42:30 INFO - 'SHELL': '/bin/bash', 17:42:30 INFO - 'SHLVL': '1', 17:42:30 INFO - 'TERM': 'linux', 17:42:30 INFO - 'TMOUT': '86400', 17:42:30 INFO - 'USER': 'cltbld', 17:42:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:30 INFO - '_': '/tools/buildbot/bin/python'} 17:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:32 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:32 INFO - warning: no files found matching '*.txt' 17:42:32 INFO - no previously-included directories found matching 'build' 17:42:32 INFO - no previously-included directories found matching 'dist' 17:42:32 INFO - no previously-included directories found matching '.git*' 17:42:32 INFO - Installing collected packages: jsonschema, functools32 17:42:32 INFO - Running setup.py install for functools32 17:42:33 INFO - warning: no files found matching '*.txt' 17:42:33 INFO - no previously-included directories found matching 'build' 17:42:33 INFO - no previously-included directories found matching 'dist' 17:42:33 INFO - no previously-included directories found matching '.git*' 17:42:33 INFO - Successfully installed jsonschema functools32 17:42:33 INFO - Cleaning up... 17:42:33 INFO - Return code: 0 17:42:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:33 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')]} 17:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:33 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')]} 17:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:33 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:33 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 17:42:33 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 17:42:33 INFO - Using env: {'DISPLAY': ':0', 17:42:33 INFO - 'HOME': '/home/cltbld', 17:42:33 INFO - 'LANG': 'en_US.UTF-8', 17:42:33 INFO - 'LANGUAGE': 'en_US:en', 17:42:33 INFO - 'LOGNAME': 'cltbld', 17:42:33 INFO - 'MAIL': '/var/mail/cltbld', 17:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:33 INFO - 'MOZ_NO_REMOTE': '1', 17:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:33 INFO - 'NO_EM_RESTART': '1', 17:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:33 INFO - 'PWD': '/builds/slave/test', 17:42:33 INFO - 'SHELL': '/bin/bash', 17:42:33 INFO - 'SHLVL': '1', 17:42:33 INFO - 'TERM': 'linux', 17:42:33 INFO - 'TMOUT': '86400', 17:42:33 INFO - 'USER': 'cltbld', 17:42:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:33 INFO - '_': '/tools/buildbot/bin/python'} 17:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:33 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 17:42:33 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 17:42:33 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 17:42:33 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 17:42:33 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 17:42:33 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 17:42:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:35 INFO - Downloading docopt-0.6.1.tar.gz 17:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:36 INFO - Running setup.py install for blobuploader 17:42:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:36 INFO - Running setup.py install for requests 17:42:36 INFO - Running setup.py install for docopt 17:42:36 INFO - Successfully installed blobuploader requests docopt 17:42:36 INFO - Cleaning up... 17:42:36 INFO - Return code: 0 17:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:36 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:36 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 17:42:36 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 17:42:36 INFO - Using env: {'DISPLAY': ':0', 17:42:36 INFO - 'HOME': '/home/cltbld', 17:42:36 INFO - 'LANG': 'en_US.UTF-8', 17:42:36 INFO - 'LANGUAGE': 'en_US:en', 17:42:36 INFO - 'LOGNAME': 'cltbld', 17:42:36 INFO - 'MAIL': '/var/mail/cltbld', 17:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:36 INFO - 'MOZ_NO_REMOTE': '1', 17:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:36 INFO - 'NO_EM_RESTART': '1', 17:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:36 INFO - 'PWD': '/builds/slave/test', 17:42:36 INFO - 'SHELL': '/bin/bash', 17:42:36 INFO - 'SHLVL': '1', 17:42:36 INFO - 'TERM': 'linux', 17:42:36 INFO - 'TMOUT': '86400', 17:42:36 INFO - 'USER': 'cltbld', 17:42:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:36 INFO - '_': '/tools/buildbot/bin/python'} 17:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:36 INFO - Running setup.py (path:/tmp/pip-iHZION-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:36 INFO - Running setup.py (path:/tmp/pip-Ha_rCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:36 INFO - Running setup.py (path:/tmp/pip-CMJf3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:37 INFO - Running setup.py (path:/tmp/pip-nn9xee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:37 INFO - Running setup.py (path:/tmp/pip-7mWBwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:37 INFO - Running setup.py (path:/tmp/pip-9sOxWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:37 INFO - Running setup.py (path:/tmp/pip-jXX9qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:37 INFO - Running setup.py (path:/tmp/pip-CIhef_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:37 INFO - Running setup.py (path:/tmp/pip-_4I8sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:37 INFO - Running setup.py (path:/tmp/pip-68RKUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:37 INFO - Running setup.py (path:/tmp/pip-Uyr1me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:37 INFO - Running setup.py (path:/tmp/pip-RLRuq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:37 INFO - Running setup.py (path:/tmp/pip-V_2dID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:37 INFO - Running setup.py (path:/tmp/pip-8usjb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:37 INFO - Running setup.py (path:/tmp/pip-t3NQu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:37 INFO - Running setup.py (path:/tmp/pip-wcMvqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:37 INFO - Running setup.py (path:/tmp/pip-FhNOFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:38 INFO - Running setup.py install for manifestparser 17:42:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Running setup.py install for mozcrash 17:42:38 INFO - Running setup.py install for mozdebug 17:42:38 INFO - Running setup.py install for mozdevice 17:42:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Running setup.py install for mozfile 17:42:38 INFO - Running setup.py install for mozhttpd 17:42:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Running setup.py install for mozinfo 17:42:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Running setup.py install for mozInstall 17:42:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:38 INFO - Running setup.py install for mozleak 17:42:38 INFO - Running setup.py install for mozlog 17:42:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Running setup.py install for moznetwork 17:42:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Running setup.py install for mozprocess 17:42:39 INFO - Running setup.py install for mozprofile 17:42:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Running setup.py install for mozrunner 17:42:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Running setup.py install for mozscreenshot 17:42:39 INFO - Running setup.py install for moztest 17:42:39 INFO - Running setup.py install for mozversion 17:42:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:39 INFO - Cleaning up... 17:42:39 INFO - Return code: 0 17:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:39 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:39 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 17:42:39 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 17:42:39 INFO - Using env: {'DISPLAY': ':0', 17:42:39 INFO - 'HOME': '/home/cltbld', 17:42:39 INFO - 'LANG': 'en_US.UTF-8', 17:42:39 INFO - 'LANGUAGE': 'en_US:en', 17:42:39 INFO - 'LOGNAME': 'cltbld', 17:42:39 INFO - 'MAIL': '/var/mail/cltbld', 17:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:39 INFO - 'MOZ_NO_REMOTE': '1', 17:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:39 INFO - 'NO_EM_RESTART': '1', 17:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:39 INFO - 'PWD': '/builds/slave/test', 17:42:39 INFO - 'SHELL': '/bin/bash', 17:42:39 INFO - 'SHLVL': '1', 17:42:39 INFO - 'TERM': 'linux', 17:42:39 INFO - 'TMOUT': '86400', 17:42:39 INFO - 'USER': 'cltbld', 17:42:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:39 INFO - '_': '/tools/buildbot/bin/python'} 17:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:40 INFO - Running setup.py (path:/tmp/pip-3lq8eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:40 INFO - Running setup.py (path:/tmp/pip-3wJWr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:40 INFO - Running setup.py (path:/tmp/pip-VPIdAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:40 INFO - Running setup.py (path:/tmp/pip-CF4lWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:40 INFO - Running setup.py (path:/tmp/pip-lofaGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:40 INFO - Running setup.py (path:/tmp/pip-v6pIYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:40 INFO - Running setup.py (path:/tmp/pip-4vWmm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:40 INFO - Running setup.py (path:/tmp/pip-fglDcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:40 INFO - Running setup.py (path:/tmp/pip-JFMMGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:40 INFO - Running setup.py (path:/tmp/pip-rCvDv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:40 INFO - Running setup.py (path:/tmp/pip-QW1H3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:40 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)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:40 INFO - Running setup.py (path:/tmp/pip-x47l8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:40 INFO - Running setup.py (path:/tmp/pip-P5g4j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:41 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)) 17:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:41 INFO - Running setup.py (path:/tmp/pip-rZSj7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:41 INFO - Running setup.py (path:/tmp/pip-GWSAen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:41 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)) 17:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:41 INFO - Running setup.py (path:/tmp/pip-WktBFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:41 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)) 17:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:41 INFO - Running setup.py (path:/tmp/pip-VYaCwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:41 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)) 17:42:41 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)) 17:42:41 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)) 17:42:41 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)) 17:42:41 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)) 17:42:41 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)) 17:42:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:41 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 17:42:41 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 17:42:41 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 17:42:41 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 17:42:41 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 17:42:41 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 17:42:43 INFO - Downloading blessings-1.6.tar.gz 17:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:43 INFO - Installing collected packages: blessings 17:42:43 INFO - Running setup.py install for blessings 17:42:43 INFO - Successfully installed blessings 17:42:43 INFO - Cleaning up... 17:42:43 INFO - Return code: 0 17:42:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:43 INFO - Reading from file tmpfile_stdout 17:42:43 INFO - Current package versions: 17:42:43 INFO - argparse == 1.2.1 17:42:43 INFO - blessings == 1.6 17:42:43 INFO - blobuploader == 1.2.4 17:42:43 INFO - docopt == 0.6.1 17:42:43 INFO - functools32 == 3.2.3-2 17:42:43 INFO - jsonschema == 2.5.1 17:42:43 INFO - manifestparser == 1.1 17:42:43 INFO - mozInstall == 1.12 17:42:43 INFO - mozcrash == 0.17 17:42:43 INFO - mozdebug == 0.1 17:42:43 INFO - mozdevice == 0.48 17:42:43 INFO - mozfile == 1.2 17:42:43 INFO - mozhttpd == 0.7 17:42:43 INFO - mozinfo == 0.9 17:42:43 INFO - mozleak == 0.1 17:42:43 INFO - mozlog == 3.2 17:42:43 INFO - moznetwork == 0.27 17:42:43 INFO - mozprocess == 0.22 17:42:43 INFO - mozprofile == 0.28 17:42:43 INFO - mozrunner == 6.11 17:42:43 INFO - mozscreenshot == 0.1 17:42:43 INFO - mozsystemmonitor == 0.3 17:42:43 INFO - moztest == 0.7 17:42:43 INFO - mozversion == 1.4 17:42:43 INFO - psutil == 3.1.1 17:42:43 INFO - requests == 1.2.3 17:42:43 INFO - wsgiref == 0.1.2 17:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:43 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')]} 17:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:43 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')]} 17:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:43 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:43 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 17:42:43 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 17:42:43 INFO - Using env: {'DISPLAY': ':0', 17:42:43 INFO - 'HOME': '/home/cltbld', 17:42:43 INFO - 'LANG': 'en_US.UTF-8', 17:42:43 INFO - 'LANGUAGE': 'en_US:en', 17:42:43 INFO - 'LOGNAME': 'cltbld', 17:42:43 INFO - 'MAIL': '/var/mail/cltbld', 17:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:43 INFO - 'MOZ_NO_REMOTE': '1', 17:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:43 INFO - 'NO_EM_RESTART': '1', 17:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:43 INFO - 'PWD': '/builds/slave/test', 17:42:43 INFO - 'SHELL': '/bin/bash', 17:42:43 INFO - 'SHLVL': '1', 17:42:43 INFO - 'TERM': 'linux', 17:42:43 INFO - 'TMOUT': '86400', 17:42:43 INFO - 'USER': 'cltbld', 17:42:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:43 INFO - '_': '/tools/buildbot/bin/python'} 17:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 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)) 17:42:43 INFO - Cleaning up... 17:42:43 INFO - Return code: 0 17:42:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:43 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')]} 17:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:43 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')]} 17:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:43 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:43 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 17:42:43 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 17:42:43 INFO - Using env: {'DISPLAY': ':0', 17:42:43 INFO - 'HOME': '/home/cltbld', 17:42:43 INFO - 'LANG': 'en_US.UTF-8', 17:42:43 INFO - 'LANGUAGE': 'en_US:en', 17:42:43 INFO - 'LOGNAME': 'cltbld', 17:42:43 INFO - 'MAIL': '/var/mail/cltbld', 17:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:43 INFO - 'MOZ_NO_REMOTE': '1', 17:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:43 INFO - 'NO_EM_RESTART': '1', 17:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:43 INFO - 'PWD': '/builds/slave/test', 17:42:43 INFO - 'SHELL': '/bin/bash', 17:42:43 INFO - 'SHLVL': '1', 17:42:43 INFO - 'TERM': 'linux', 17:42:43 INFO - 'TMOUT': '86400', 17:42:43 INFO - 'USER': 'cltbld', 17:42:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:43 INFO - '_': '/tools/buildbot/bin/python'} 17:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:44 INFO - Cleaning up... 17:42:44 INFO - Return code: 0 17:42:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:42:44 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')]} 17:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:44 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')]} 17:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:44 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 0x7f1c57020f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, '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': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', '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 17:42:44 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 17:42:44 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 17:42:44 INFO - Using env: {'DISPLAY': ':0', 17:42:44 INFO - 'HOME': '/home/cltbld', 17:42:44 INFO - 'LANG': 'en_US.UTF-8', 17:42:44 INFO - 'LANGUAGE': 'en_US:en', 17:42:44 INFO - 'LOGNAME': 'cltbld', 17:42:44 INFO - 'MAIL': '/var/mail/cltbld', 17:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:44 INFO - 'MOZ_NO_REMOTE': '1', 17:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:44 INFO - 'NO_EM_RESTART': '1', 17:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:44 INFO - 'PWD': '/builds/slave/test', 17:42:44 INFO - 'SHELL': '/bin/bash', 17:42:44 INFO - 'SHLVL': '1', 17:42:44 INFO - 'TERM': 'linux', 17:42:44 INFO - 'TMOUT': '86400', 17:42:44 INFO - 'USER': 'cltbld', 17:42:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:44 INFO - '_': '/tools/buildbot/bin/python'} 17:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:44 INFO - Downloading/unpacking flake8 17:42:44 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 17:42:44 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 17:42:44 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 17:42:44 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 17:42:44 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 17:42:44 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 17:42:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:42:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:42:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 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 17:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:42:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:46 INFO - no previously-included directories found matching 'docs/_build' 17:42:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:42:46 INFO - Running setup.py install for pep8 17:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:47 INFO - no previously-included directories found matching 'docs/_build' 17:42:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:42:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:42:47 INFO - Cleaning up... 17:42:47 INFO - Return code: 0 17:42:47 INFO - Running post-action listener: _resource_record_post_action 17:42:47 INFO - Running post-action listener: _start_resource_monitoring 17:42:47 INFO - Starting resource monitoring. 17:42:47 INFO - ##### 17:42:47 INFO - ##### Finished create-virtualenv step (success) 17:42:47 INFO - ##### 17:42:47 INFO - ##### 17:42:47 INFO - ##### Running install step. 17:42:47 INFO - ##### 17:42:47 INFO - Running pre-action listener: _resource_record_pre_action 17:42:47 INFO - Running main action method: install 17:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:47 INFO - Reading from file tmpfile_stdout 17:42:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:47 INFO - Reading from file tmpfile_stdout 17:42:47 INFO - Output received: 17:42:47 INFO - Usage: mozinstall [options] installer 17:42:47 INFO - Options: 17:42:47 INFO - -h, --help show this help message and exit 17:42:47 INFO - -d DEST, --destination=DEST 17:42:47 INFO - Directory to install application into. [default: 17:42:47 INFO - "/builds/slave/test"] 17:42:47 INFO - --app=APP Application being installed. [default: firefox] 17:42:47 INFO - mkdir: /builds/slave/test/build/application 17:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:43:05 INFO - Reading from file tmpfile_stdout 17:43:05 INFO - Output received: 17:43:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:05 INFO - Running post-action listener: _resource_record_post_action 17:43:05 INFO - ##### 17:43:05 INFO - ##### Finished install step (success) 17:43:05 INFO - ##### 17:43:05 INFO - ##### 17:43:05 INFO - ##### Running run-tests step. 17:43:05 INFO - ##### 17:43:05 INFO - Running pre-action listener: _resource_record_pre_action 17:43:05 INFO - Running main action method: run_tests 17:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:05 INFO - Python 2.7.3 17:43:05 INFO - Return code: 0 17:43:05 INFO - grabbing minidump binary from tooltool 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:05 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 0x2d431c0>, '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 0x2d440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d44550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:05 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 17:43:05 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 17:43:05 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 17:43:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:05 INFO - Return code: 0 17:43:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:43:06 INFO - Return code: 0 17:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 17:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 17:43:06 INFO - Using env: {'DISPLAY': ':0', 17:43:06 INFO - 'HOME': '/home/cltbld', 17:43:06 INFO - 'LANG': 'en_US.UTF-8', 17:43:06 INFO - 'LANGUAGE': 'en_US:en', 17:43:06 INFO - 'LOGNAME': 'cltbld', 17:43:06 INFO - 'MAIL': '/var/mail/cltbld', 17:43:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:06 INFO - 'MOZ_NO_REMOTE': '1', 17:43:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:06 INFO - 'NO_EM_RESTART': '1', 17:43:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:06 INFO - 'PWD': '/builds/slave/test', 17:43:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:06 INFO - 'SHELL': '/bin/bash', 17:43:06 INFO - 'SHLVL': '1', 17:43:06 INFO - 'TERM': 'linux', 17:43:06 INFO - 'TMOUT': '86400', 17:43:06 INFO - 'USER': 'cltbld', 17:43:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249', 17:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:06 INFO - '_': '/tools/buildbot/bin/python'} 17:43:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 17:43:06 INFO - mozversion application_buildid: 20160606053005 17:43:06 INFO - mozversion application_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 17:43:06 INFO - mozversion application_display_name: Nightly 17:43:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:06 INFO - mozversion application_name: Firefox 17:43:06 INFO - mozversion application_remotingname: firefox 17:43:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:43:06 INFO - mozversion application_vendor: Mozilla 17:43:06 INFO - mozversion application_version: 49.0a1 17:43:06 INFO - mozversion platform_buildid: 20160606053005 17:43:06 INFO - mozversion platform_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 17:43:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:43:06 INFO - mozversion platform_version: 49.0a1 17:43:06 INFO - using testdate: 1465260186 17:43:06 INFO - actual date: 1465260186 17:43:06 INFO - starting webserver on 'localhost:53387' 17:43:06 INFO - SUITE-START | Running 2 tests 17:43:06 INFO - TEST-START | dromaeo_css 17:43:06 INFO - operating with platform_type : linux_ 17:43:06 INFO - Initialising browser for dromaeo_css test... 17:43:06 INFO - TEST-INFO | started process 11333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuJX7X1/profile http://localhost:53387/getInfo.html) 17:43:12 INFO - PROCESS | 11333 | __metrics Screen width/height:1600/1200 17:43:12 INFO - PROCESS | 11333 | colorDepth:24 17:43:12 INFO - PROCESS | 11333 | Browser inner width/height: 1024/697 17:43:12 INFO - PROCESS | 11333 | __metrics 17:43:13 ERROR - PROCESS | 11333 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 17:43:13 INFO - TEST-INFO | 11333: exit 0 17:43:13 INFO - Browser initialized. 17:43:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:13 INFO - TEST-INFO | started process 11453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuJX7X1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:25 INFO - PROCESS | 11453 | RSS: Main: 167251968 17:43:25 INFO - PROCESS | 11453 | 17:44:15 INFO - PROCESS | 11453 | 1465260255408 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] 17:46:22 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53387/tests/dromaeo/cssquery-ext.html) 17:46:23 INFO - PROCESS | 11453 | RSS: Main: 170409984 17:46:23 INFO - PROCESS | 11453 | 17:49:25 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-ext.html (next: http://localhost:53387/tests/dromaeo/cssquery-jquery.html) 17:49:26 INFO - PROCESS | 11453 | RSS: Main: 170225664 17:49:26 INFO - PROCESS | 11453 | 17:52:28 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53387/tests/dromaeo/cssquery-mootools.html) 17:52:28 INFO - PROCESS | 11453 | RSS: Main: 171757568 17:52:28 INFO - PROCESS | 11453 | 17:55:30 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53387/tests/dromaeo/cssquery-prototype.html) 17:55:31 INFO - PROCESS | 11453 | RSS: Main: 169041920 17:55:31 INFO - PROCESS | 11453 | 17:58:33 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53387/tests/dromaeo/cssquery-yui.html) 17:58:34 INFO - PROCESS | 11453 | RSS: Main: 171036672 17:58:34 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-yui.html (next: http://localhost:53387/tests/dromaeo/cssquery-dojo.html) 18:01:36 INFO - PROCESS | 11453 | RSS: Main: 172470272 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | __start_tp_report 18:01:36 INFO - PROCESS | 11453 | _x_x_mozilla_page_load 18:01:36 INFO - PROCESS | 11453 | _x_x_mozilla_page_load_details 18:01:36 INFO - PROCESS | 11453 | |i|pagename|runs| 18:01:36 INFO - PROCESS | 11453 | |0;dojo.html;3095.3345030818373;3104.2549788050874;3125.671804460532;3131.639861415937;3136.137562170403;5306.257124002638;5371.4897084776885;5375.247465354849;5384.2462055312235;5411.377691565471;5326.893462130755;5348.786048558063;5352.330958630171;5441.83674489765;5475.260839786628;4909.189983652693;4945.25821126832;4986.900261994758;5026.29631851541;5062.417821950486;787.3618827834049;4891.192953162724;4921.458639549646;5005.2492126181;5016.347874776274;4872.293517439969;4903.754812259408;4921.8277360292395;4930.211166213407;4946.826861059882;4903.53416425439;4927.852164435073;4928.408590969071;4935.925961110586;4957.752112394366;4863.975680121612;4888.266759985995;4901.852944411673;4909.950900490985;4918.360613120307;5261.500157485033;5312.840614781563;5325.094733895247;5335.359756829166;5351.598630102758;5692.31692196939;5768.711564421804;5795.797147099874;5816.505597024258;5839.445252700986;5898;5942.494887934531;5949.6727679977585;5954.672493012882;6007.459328660441;5494.615376923617;5496.615236933416;5503.504684578367;5519;5522.337319521643;5803.738831752581;5895.852603684943;5927.970360148258;6021.909671354933;6032.306284777307;5577.776888924398;5640.5487560995025;5648.943510564924;5655.1799989001365;5657.773689052474;5745.482906538348;5749.223854779551;5758.596898217084;5759.481646651821;5789.160571717078;5702.857428564236;5716.256886604798;5726.9713651431475;5744.770209191669;5749.885002300014;5711.800086997018;5714.714264286769;5723;5749.942500574941;5753.712314384264;4309.07354918694;4335.7181783184;4351.955530672616;4363.738175709467;4385.978070109629;3886.8639597614515;3889;3892.0853599404118;3909.7849618271266;3917.9020524487114;5536.557075433956;5569.136783798518;5613.7193140342815;5644.181593668977;5647.209390685307;5796.507296879812;5907.409259074058;5910.645361278337;5948.434898684618;5966.0454327307425;5527.088030474926;5581.525570326487;5585.162225666182;5592.161175823659;5631.915521267184;4776.116418462596;4848.442429120626;4865.0756356292195;4865.5864251538305;4917.901641967141;5924.4667979882015;6001.2498437695285;6054;6062.514998800086;6081.3614570470345;5840.883182336414;5913.674747888907;5919.733611987384;5929.940700592939;5948.881022379442;6078.3921607838865;6083.66539840313;6092.421219984094;6099.329073801967;6113.724882380215;5693.857653558529;5722.4277572242445;5756.453136951983;5763.33721622002;5773.769049237983;5870.647761134345;5885.264341957255;5924.6149000314845;5925.466707996301;5961.344252132175;5744.339400968942;5746.42535746422;5771.7402716877;5778.248827652378;5778.768849245983;5605.04714198579;5662.03745363281;5672.7730890763905;5689.601727879009;5710.457506536873;5539.362973258127;5582.413846546055;5583.134614134816;5585.078462053716;5585.944140558542;5710.857228569319;5727.427257274239;5746.281714785652;5773.595848290579;5788.218590490398;5534.4742249486235;5570.5265052470995;5602.187682786055;5641.464060914206;5663.490285874291 18:01:36 INFO - PROCESS | 11453 | |1;ext.html;570.0992431957508;618.1253526260342;622.7228883147002;640.30526878337;654.3946849164528;40538.18923621526;41099.589004109985;44000;44372.3344149838;44700;45874.54125458753;46075.53924460754;46429.07141857169;46753.53246467543;46810.76594617022;8687.869681954775;8846.5576721164;8859.778505537348;8877;8884.422512536665;8752.212300892917;8814.25078868297;8854.557272136399;8864.73405797827;8886.511241881693;8874.733757987271;8894.777630559223;8946.344926188644;8980.506072166028;9023.18791308782;8828.161324674145;8850.955745221265;8902.554872256394;8910.420822646573;8932.776680582972;8634.136586341378;8641.351898607629;8726.912730872673;8729.476231426135;8749.16882896124;42270.78864605688;42651.786741066404;42652.57347426517;42670.57329426697;42672.57327426717;3453.637368076341;3618.294432585647;3623.2934577757346;3626.7098632109632;3669.9082522936874;31739.52390714141;32129.678703213136;32130.196745081324;32437.83781081103;32643.347133057207;4066.2477441673386;4130.896727581804;4132.504099508078;4136.565660605654;4205.936910946339;354072.99999999744;355707;356451;357138;357777;34166.316673666384;57344.426555734746;58054.709726451096;58101.709491452275;58256.41743582595;35379;36715.26569468596;36851.631483685356;36884.446733299024;36984.44523332152;14223.359948802121;14450.132992020512;14465.421383144767;14466;14511.564653060424;12303.753924921451;12429.005679545615;12448.937755311166;12467.064970127096;12470.937645311715;8378.664853405917;8403.201695838885;8408.537530435762;8463.534505602127;8466.026406963278;3271.7382609391193;3296.489044198153;3301.5047742838765;3308.9007329780147;3333.616634087111;975.9512024398751;983.6606370802205;986.9407835529892;1060.1624716474053;1145.730753272997;29708.702912970595;30134.698653013627;30853.845730771653;30907.84546077255;31223.687763122078;1026.461107918349;1124.7188202949262;1134.5348407153028;1155.7341811383428;1247.6880779805049;15872.44446444369;16411.507654770376;17479.737803932952;18001.459956201335;18412.81587184138;575511;579115;579349;579555;580778;58921;59238;59341.40658593445;59381;59742;1321.973560528784;1359.1844893064083;1378.9931050344885;1384.8338199416135;1387.2508845223667;27413.31466713348;27523.449531009668;27752.58371124475;27854.860725697054;28053.43893122085;49457.752711236215;50112.74943625258;50393.49606503888;50435.495645044546;50565.74717126391;471855;473890;478768;479354;479783;27218.72781272162;27604.309892252855;27616.58575121415;27626;28367.716322837332;47986.28020579624;48001.75999119982;48966.26550601672;49082;49331.506684934124;40456.190876181725;41047;41328;41781.37327940023;42365.152696946505;40418;40661.79669101635;40884.386734198415;41716.374254386814;42008;40300.39549406702;41273.1745365097;41767;42219.36670949877;43647;33536.83231583826;37038.62961370352;37668.81165594264;37875.24249514939;37899.242015160096;28680.282992925342;28850.42299153963;29237.561436578042;29315.41369172562;29485.410291794473 18:01:36 INFO - PROCESS | 11453 | |2;jquery.html;382.52184769038695;390.5625699216877;392.75845355106617;396.5816064052425;411.964982976447;13701;18141.727874081884;18858.622827543477;19503.02484875756;19534.609307813836;18338.633227335446;18526;18615.90692046541;18719.812801871976;19034.33379831706;5419.674819510822;5463.617546771738;5609.3268807743125;5618.213450116987;5635.5773317001185;5496.972515137419;5511.58663100269;5513.007658621446;5522.254495643077;5554.0835762099205;5431.456854314576;5431.674099554019;5472.398036216013;5510.862228444301;5574.024545704486;5553.500184983351;5558.610897237175;5562.221289019541;5565.2486914266465;5592.552595792326;4877.804887804484;4978.6017118630425;4979.651424400294;4982.800687972477;4995.500449955011;16911.661766764595;16987.74518382225;20639.277625283044;22040.11839526417;22222.88888555547;2225.9666105008437;2237.3623517297656;2291.8051965582777;2326.6626339180725;2338.4504641409253;9574.329796914219;10084.344517606332;10109.848352274721;12616;13021.41403636829;1909.4748944040361;1928.768547774262;1946.912388942501;1947.6494231038407;2017.909194086255;82571;86822;88873;89439.21121577597;89463;8809.735707928645;9346;9510.667126650535;9540.61837526505;9661.71014869555;12851.807222891664;12912.677183070498;12923.095383323078;12933.805992910115;12940.611781646565;7261.636918154071;7705.383569314441;7713.6914523419555;7781.766547003599;7844.607769611496;7780.572068536172;7838.137804841463;7872.094709108412;7959.482633628795;7965.044194696674;3918.6277303656107;3993.121513267077;4004.1190937993597;4066.369712694537;4104.938425923614;1951.7657881054365;1955.9487199968096;1973.427705965254;2003.0685731135093;2056.259746491262;901.2429559170329;1041.3283432186197;1065.4998330484323;1078.757279612081;1125.1224045244721;17972.820271797376;18306.450806475827;18464.076796160138;18691.532711682317;18837.152328145265;988.7132731507926;1045.2369770067894;1063.3938654966594;1109.4840898982013;1118.9384583847966;10111.342762720547;10208.877023527406;10487.003734645197;10549.20880933933;10551.20865935058;478746;481316;501116;507050;507280;89151.55424222967;92142.53928730448;93071.53464232635;93100;94895.52552237194;1014.7919676466307;1028.6451174344838;1036.2746077745458;1054.8786889507805;1056.3609016545033;16424;16425.589360266087;16480.34078636841;16576.2540685667;16659.250333735254;38441.231175376895;41414.378784317654;42703.57296426996;43144.56855431406;44560.77719611511;56862.7156864213;61645;62959.6852015737;63189.36810631835;63771;8248.587570621325;8568.52873091986;8740.562971851255;8792.824143517222;8868.822623547363;11959.820602691141;12380.257184568954;12718.300493472947;12725.109242352946;12756.234625922103;11360.772784544428;11780.234284771463;11794;12005.519779208735;12070.27578345302;5225.608079393985;10254.846482238516;11355.37545435009;11438.485268162785;11500.769984600429;10222.693319200436;11745.88254117482;11782.646520604396;11939.46272417726;11999.280043197436;8498.915010849812;8620.870686939827;8658.134186581292;8699.347548933729;8720.302375809793;8669.696560620348;11131.165162612675;11711.941440292743;11718.296902185895;11736.06111511094 18:01:36 INFO - PROCESS | 11453 | |3;mootools.html;1505.3301280929986;1537.1852917953481;1696.7794186755727;1781.7683701118854;1810.3301778342015;7677.692892284316;8178.836423271531;8396.790080247996;8932.732018039462;8944.463332200072;8295.502269863813;8422.705205317816;8578.142185781418;8627.956860215705;8650.307975361971;2314.7106611673585;2347.436615212354;2373.46597015671;2376.4415362389823;2379.1791831817995;2310.792028717415;2334.2997100869757;2336.4275752440676;2347.4366152123453;2358.9646155307682;2342.7891489765916;2350.847194932324;2352.776486233805;2386.331827088418;2387.5344307859973;2252.8986195621155;2254.1434254983;2273.4202778291515;2276.578832915916;2283.417728479227;2236.8434209605334;2249.302716157996;2256.593813113639;2263.762304957972;2271.693321401606;8343.165683431609;8428.410011299211;8451.028131764864;8460.746177614681;8473.533955632438;5062.721550314731;5149.227615857614;5150.27896094547;5155.71643559604;5156.896862062776;3060.7704422168426;3165.6517783043846;3282.2286762610765;3283.6059672839174;3291.0949488890506;1072.785442911421;1121.2767764791745;1132.2470557079614;1134.1210561814578;1144.3991904250252;11690.707732306675;11701.824472632918;11761;11931.224470409396;11947.761044779143;4465.933011004838;4522.118186953512;4580.977095114503;4599.40207772994;4631.328457373662;10167.237457190593;10174.847377289347;10223.437710925971;10298.536565854554;10318.329308594917;5030.4215015272985;5093.490650934951;5098.362704661918;5114.3095682083185;5158.071547121479;4162.687798415071;4502.549745025472;4624.398828152386;4630.189716799547;4748.406449193851;3908.7068469864307;3945.467361906163;3960.386140148282;3976.2842688315804;4004.939925901114;1220.9450574724158;1224.406163010939;1232.9938350308191;1233.7409144079663;1250.3248245947268;989.9851502227473;1014.5028935821394;1014.5282443663732;1029.0995379043336;1030.3611760708409;5703.201551782754;5977;6007.290934207104;6079.240094988127;6155.322914479404;466.23071931312927;482.9227323628203;484.3582253514108;488.0799692579513;493.5557997802007;4211.684123690736;4252.362145678173;4261.531231564588;4273.87178384649;4280.914381712349;10155.7461063474;10439.37363758177;10469.895301047045;10479.53286539885;10482.37105773656;10368.326058806153;10390.324628899098;10399.58401663925;10443.164546836235;10459.947700261602;7702.537847729154;7749.186335434698;7979.760607181794;7992.840143197103;8140.75577732669;5936.643801371759;6007.8197654070445;6041.093835924647;6058.273007238983;6198.473129784019;9456.338056336266;9769.120779129913;9777.364471309342;9780.706578802647;9939.950300248742;9599.856002159833;9731.805363892825;9813.313068085166;9863.358881672668;9920;6989.405900498515;7323.523970941872;7653.158152603321;7663.693452261847;7803.960980195063;8375.455595386524;8457.746267611981;8461.661533538836;8479.19447652472;8503.404761666625;7511.8497630046;7558.1686014539455;7565.394768418403;7602.277783610548;7831.765047048598;7250.782476525713;7303.963480182565;7305.707771689073;7363.484556081237;7437.851242975002;6981.3367730065565;6986.860262794818;7024.086868707035;7075.646217689198;7077.5399599025895;5139.126348520836;5188.754698872319;5292.311999440049;5318.946810532;5325.760340784596;5284.682919024717;5295.073362161529;5297.152455607084;5320.707361095177;5340.225667278145 18:01:36 INFO - PROCESS | 11453 | |4;prototype.html;321.145752298885;332.3038234897888;335.1905149065008;338.0618782877513;338.62581847059;5402.37872644646;5594.692291923942;5603.439656034399;5700.515456186229;5739.770409183638;5575.721213939307;5591.4688104630095;5618.915716264249;5627.549796016319;5631.436856314377;4360.062586543892;4388.517263101056;4409.757463339515;4410.338449232625;4411.183930972764;4242.3666888247935;4372.584604462571;4377.584129507692;4389.144116897206;4405.207062728708;4343.565643435662;4365.497967733703;4366.148601022802;4384.618845063795;4404.810701110699;4305.07440900208;4374.496932852715;4403.4495688039;4425.1370982658555;4430.977845110786;3823.541175058983;3850;3891;3907.8436862525464;3908.530976282836;5419.403865574784;5434.483724046209;5434.619576629638;5440;5478.808241711561;4954.157793175169;5035.295058691786;5042.470540593222;5056.544910957995;5063.569596584295;5814.418558144194;5908.615939963888;5913.408659134096;5929.940700592982;5950.9107363389585;4198.908283846192;4250.234957707611;4253.319468884994;4268.189044081614;4273.081287523167;5836.5914385993;5941.287045554561;6171.660558669271;6182.227221597301;6188.84527886802;4320.330348795942;4343.2399330117105;4355.259605867011;4363.127374525107;4370.431843860278;4390.517043125254;4409.382686423904;4411.625011873963;4423.60187583119;4425.247707889666;4861.9027619447415;4997.875053123701;5001.924971125436;5009.724465154379;5037.143685573461;5814.854628634233;5905.940940590625;5913.881722365529;5927.2590926134235;5931;1488.7245859516024;1520.3310543360885;1524.9695006100037;1526.9236538173047;1527.3279756906925;940.7130825098274;953.6042542344987;963.1861077389734;971.8347880860271;982.3810999070682;5082.822101226439;5102.923456148161;5109.930478156352;5130.230465430141;5161.896762064813;5384.811531596375;5385.542228910508;5398.91901621476;5425;5427.755750991215;4954.727489988013;5045.344105266292;5107;5109.821156259587;5110.8466745997675;2834.7385413490797;2873.252954231873;2882.9135125946254;2886.235147685865;2891.8843246270335;5488.890222195534;5526.88247255797;5528.673118451623;5532.280803495601;5559.305086864142;5253.474652534716;5397.865053373697;5401.3248343957;5472.50747432733;5476.972615136979;5490.3371864645615;5590.2328347468265;5595.62907087758;5616.528727359949;5624.353199382042;5302.507821323971;5325;5371.301730774974;5398.62209645321;5659.3491748447805;6008.3863519369215;6067.757289708362;6095.146679464967;6112.633242005494;6115.960286751174;6250.249970003629;6293.370662933853;6307.400796924285;6371.74513019474;6376.107344971801;4256.36154576816;4266.125444283976;4278.160391031886;4280.935785963151;4284.871453856389;5786.82993877296;6098.451139397298;6120.347506173397;6148.923938310688;6157.599756015845;5992.760289588367;6001.90997135052;6006.339302676614;6012.849678758066;6019.367966363468;5890.145928840208;5902.498287645598;5931.881362372815;5948.10778383246;5956.434138756811;5590.720463976703;5805.013147764806;5848.093545500455;5857.384974577608;5871.530277577698;5930.495907847881;5990.880182396415;5994.400559943971;6027.849303767265;6032.336442991355;5625.634333768292;5845.532357411482;5854.502367298657;5885.793997210077;5895.29256489224 18:01:36 INFO - PROCESS | 11453 | |5;yui.html;646.5797231799327;735.5586648011194;786.9606519674015;808.325048584432;827.6275675945826;14330.928345358272;15937.601559960993;15998.760018599716;16199.676006479864;16209.83790162098;14257.073290236127;14367;14382.92808535956;14432.061915975455;14444.350004249807;640.9519286053553;765.177434258172;793.2226418110256;797.2665148063795;798.8322452285028;784.1883650421814;786.5241528875034;789.5815217934476;793.4326956226297;795.145218889693;846.0777752250046;848.3806821020659;848.9660413583449;849.5157760076759;850.4939560961249;834.3742193354984;836.523181786382;839.0183485322187;843.8649816029437;843.8902942617482;613.7606333529927;615.6521565315583;616.9352218017133;617.6849806598622;620.5439002333281;15081.54755357341;15081.698366032728;15154.696906061818;15174.772378414333;15201;14505.637359066002;14840.406383744637;14867.256637168206;15178.544643660707;15318.463853765064;12324.75350492994;12501.49994000239;12513.874861251454;12582.68543286416;12586.874131258663;3946.5856085110936;3969.364901615728;3981.3231750602467;4029.214303210875;4116.9794151029055;73775;74106.62946685286;74177;74871.62564187145;76778.16109194573;10759.193060520493;11223.494942727597;11290.435478226056;11386.146039046938;11965.760684786255;19421.028948552517;19802.306919257757;20349.287774927805;20580.58838823215;20745.792542074385;8050.637721302555;8139.43023988327;8243.711470098518;8298.502089874626;8609.397342186112;4566.954330456653;4646.7444290564345;4779.617630589614;4787.976060119747;5044.394672639233;3369.0735047861544;3447.1899103710607;3461.826908654557;3466.843992020365;3469.2887957968555;599.4155698194226;604.3171216525299;614.118739608663;620.3889169168366;624.497279689845;614.4070971512512;645.5706954874955;679.2969276798589;687.8933765266391;694.2016680817;9373.765655858659;9409.48247846375;9456.432614043179;9499;9653.22774178064;598.8712426828253;661.4278648968703;685.3454950522239;689.6138162628944;697;4332.826686932551;4386.824527018884;4440.444944381952;4463.085067561142;4481.843135490242;100358;112368.43815781032;112822;114839;116802;96385.51807240919;99395.50302248442;100150.49924750475;101814.49092754489;102057.48971255096;86528.56735716281;87745.99999999872;88003;88216;88252.55873720719;8224.09534951143;8392.4544904581;8494.74515764528;8498.70254541088;8573.399862009599;49919.50080499148;50380.74809625928;50848;51610.74194629003;53056;58893.70553147207;70609.64695176491;71115.64442177756;71166;72809.27190728237;10445.425501597485;10546.8417973732;10571.2600117991;10620.150387969099;10881.238313317992;10565.26043177001;10588.735281618021;10852.489228700097;11096.500657470595;11626.88373116258;10802.243842930919;10811.29726567802;10959.83560246581;11043.447827608426;11363.54545818191;10051.396916185053;10141.340812847142;10180.185585153022;10200.846987295048;10206.132478739093;10662.786744265226;10830.40432776205;10869.836952445878;11244;11377.43112844371;9157.130072643089;9233.492157931378;9294.163525282756;9321.533923303943;9392.81214375695;9251.953740231256;9415.529223538659;9619.951900240454;9689.563969621244;11366.602168924048 18:01:36 INFO - PROCESS | 11453 | __end_tp_report 18:01:36 INFO - PROCESS | 11453 | __start_cc_report 18:01:36 INFO - PROCESS | 11453 | _x_x_mozilla_cycle_collect,344 18:01:36 INFO - PROCESS | 11453 | __end_cc_report 18:01:36 INFO - PROCESS | 11453 | __startTimestamp1465261296835__endTimestamp 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | ------- Summary: start ------- 18:01:36 INFO - PROCESS | 11453 | Number of tests: 6 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#0] dojo.html Cycles:165 Average:5373.23 Median:5640.55 stddev:731.95 (13.0%) stddev-sans-first:712.05 18:01:36 INFO - PROCESS | 11453 | Values: 3095.3 3104.3 3125.7 3131.6 3136.1 5306.3 5371.5 5375.2 5384.2 5411.4 5326.9 5348.8 5352.3 5441.8 5475.3 4909.2 4945.3 4986.9 5026.3 5062.4 787.4 4891.2 4921.5 5005.2 5016.3 4872.3 4903.8 4921.8 4930.2 4946.8 4903.5 4927.9 4928.4 4935.9 4957.8 4864.0 4888.3 4901.9 4910.0 4918.4 5261.5 5312.8 5325.1 5335.4 5351.6 5692.3 5768.7 5795.8 5816.5 5839.4 5898.0 5942.5 5949.7 5954.7 6007.5 5494.6 5496.6 5503.5 5519.0 5522.3 5803.7 5895.9 5928.0 6021.9 6032.3 5577.8 5640.5 5648.9 5655.2 5657.8 5745.5 5749.2 5758.6 5759.5 5789.2 5702.9 5716.3 5727.0 5744.8 5749.9 5711.8 5714.7 5723.0 5749.9 5753.7 4309.1 4335.7 4352.0 4363.7 4386.0 3886.9 3889.0 3892.1 3909.8 3917.9 5536.6 5569.1 5613.7 5644.2 5647.2 5796.5 5907.4 5910.6 5948.4 5966.0 5527.1 5581.5 5585.2 5592.2 5631.9 4776.1 4848.4 4865.1 4865.6 4917.9 5924.5 6001.2 6054.0 6062.5 6081.4 5840.9 5913.7 5919.7 5929.9 5948.9 6078.4 6083.7 6092.4 6099.3 6113.7 5693.9 5722.4 5756.5 5763.3 5773.8 5870.6 5885.3 5924.6 5925.5 5961.3 5744.3 5746.4 5771.7 5778.2 5778.8 5605.0 5662.0 5672.8 5689.6 5710.5 5539.4 5582.4 5583.1 5585.1 5585.9 5710.9 5727.4 5746.3 5773.6 5788.2 5534.5 5570.5 5602.2 5641.5 5663.5 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#1] ext.html Cycles:180 Average:61445.64 Median:22732.28 stddev:127706.72 (561.8%) stddev-sans-first:127983.18 18:01:36 INFO - PROCESS | 11453 | Values: 570.1 618.1 622.7 640.3 654.4 40538.2 41099.6 44000.0 44372.3 44700.0 45874.5 46075.5 46429.1 46753.5 46810.8 8687.9 8846.6 8859.8 8877.0 8884.4 8752.2 8814.3 8854.6 8864.7 8886.5 8874.7 8894.8 8946.3 8980.5 9023.2 8828.2 8851.0 8902.6 8910.4 8932.8 8634.1 8641.4 8726.9 8729.5 8749.2 42270.8 42651.8 42652.6 42670.6 42672.6 3453.6 3618.3 3623.3 3626.7 3669.9 31739.5 32129.7 32130.2 32437.8 32643.3 4066.2 4130.9 4132.5 4136.6 4205.9 354073.0 355707.0 356451.0 357138.0 357777.0 34166.3 57344.4 58054.7 58101.7 58256.4 35379.0 36715.3 36851.6 36884.4 36984.4 14223.4 14450.1 14465.4 14466.0 14511.6 12303.8 12429.0 12448.9 12467.1 12470.9 8378.7 8403.2 8408.5 8463.5 8466.0 3271.7 3296.5 3301.5 3308.9 3333.6 976.0 983.7 986.9 1060.2 1145.7 29708.7 30134.7 30853.8 30907.8 31223.7 1026.5 1124.7 1134.5 1155.7 1247.7 15872.4 16411.5 17479.7 18001.5 18412.8 575511.0 579115.0 579349.0 579555.0 580778.0 58921.0 59238.0 59341.4 59381.0 59742.0 1322.0 1359.2 1379.0 1384.8 1387.3 27413.3 27523.4 27752.6 27854.9 28053.4 49457.8 50112.7 50393.5 50435.5 50565.7 471855.0 473890.0 478768.0 479354.0 479783.0 27218.7 27604.3 27616.6 27626.0 28367.7 47986.3 48001.8 48966.3 49082.0 49331.5 40456.2 41047.0 41328.0 41781.4 42365.2 40418.0 40661.8 40884.4 41716.4 42008.0 40300.4 41273.2 41767.0 42219.4 43647.0 33536.8 37038.6 37668.8 37875.2 37899.2 28680.3 28850.4 29237.6 29315.4 29485.4 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#2] jquery.html Cycles:180 Average:29008.45 Median:19411.88 stddev:81887.14 (421.8%) stddev-sans-first:82088.65 18:01:36 INFO - PROCESS | 11453 | Values: 382.5 390.6 392.8 396.6 412.0 13701.0 18141.7 18858.6 19503.0 19534.6 18338.6 18526.0 18615.9 18719.8 19034.3 5419.7 5463.6 5609.3 5618.2 5635.6 5497.0 5511.6 5513.0 5522.3 5554.1 5431.5 5431.7 5472.4 5510.9 5574.0 5553.5 5558.6 5562.2 5565.2 5592.6 4877.8 4978.6 4979.7 4982.8 4995.5 16911.7 16987.7 20639.3 22040.1 22222.9 2226.0 2237.4 2291.8 2326.7 2338.5 9574.3 10084.3 10109.8 12616.0 13021.4 1909.5 1928.8 1946.9 1947.6 2017.9 82571.0 86822.0 88873.0 89439.2 89463.0 8809.7 9346.0 9510.7 9540.6 9661.7 12851.8 12912.7 12923.1 12933.8 12940.6 7261.6 7705.4 7713.7 7781.8 7844.6 7780.6 7838.1 7872.1 7959.5 7965.0 3918.6 3993.1 4004.1 4066.4 4104.9 1951.8 1955.9 1973.4 2003.1 2056.3 901.2 1041.3 1065.5 1078.8 1125.1 17972.8 18306.5 18464.1 18691.5 18837.2 988.7 1045.2 1063.4 1109.5 1118.9 10111.3 10208.9 10487.0 10549.2 10551.2 478746.0 481316.0 501116.0 507050.0 507280.0 89151.6 92142.5 93071.5 93100.0 94895.5 1014.8 1028.6 1036.3 1054.9 1056.4 16424.0 16425.6 16480.3 16576.3 16659.3 38441.2 41414.4 42703.6 43144.6 44560.8 56862.7 61645.0 62959.7 63189.4 63771.0 8248.6 8568.5 8740.6 8792.8 8868.8 11959.8 12380.3 12718.3 12725.1 12756.2 11360.8 11780.2 11794.0 12005.5 12070.3 5225.6 10254.8 11355.4 11438.5 11500.8 10222.7 11745.9 11782.6 11939.5 11999.3 8498.9 8620.9 8658.1 8699.3 8720.3 8669.7 11131.2 11711.9 11718.3 11736.1 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#3] mootools.html Cycles:180 Average:5668.02 Median:483.64 stddev:3176.24 (656.7%) stddev-sans-first:3169.75 18:01:36 INFO - PROCESS | 11453 | Values: 1505.3 1537.2 1696.8 1781.8 1810.3 7677.7 8178.8 8396.8 8932.7 8944.5 8295.5 8422.7 8578.1 8628.0 8650.3 2314.7 2347.4 2373.5 2376.4 2379.2 2310.8 2334.3 2336.4 2347.4 2359.0 2342.8 2350.8 2352.8 2386.3 2387.5 2252.9 2254.1 2273.4 2276.6 2283.4 2236.8 2249.3 2256.6 2263.8 2271.7 8343.2 8428.4 8451.0 8460.7 8473.5 5062.7 5149.2 5150.3 5155.7 5156.9 3060.8 3165.7 3282.2 3283.6 3291.1 1072.8 1121.3 1132.2 1134.1 1144.4 11690.7 11701.8 11761.0 11931.2 11947.8 4465.9 4522.1 4581.0 4599.4 4631.3 10167.2 10174.8 10223.4 10298.5 10318.3 5030.4 5093.5 5098.4 5114.3 5158.1 4162.7 4502.5 4624.4 4630.2 4748.4 3908.7 3945.5 3960.4 3976.3 4004.9 1220.9 1224.4 1233.0 1233.7 1250.3 990.0 1014.5 1014.5 1029.1 1030.4 5703.2 5977.0 6007.3 6079.2 6155.3 466.2 482.9 484.4 488.1 493.6 4211.7 4252.4 4261.5 4273.9 4280.9 10155.7 10439.4 10469.9 10479.5 10482.4 10368.3 10390.3 10399.6 10443.2 10459.9 7702.5 7749.2 7979.8 7992.8 8140.8 5936.6 6007.8 6041.1 6058.3 6198.5 9456.3 9769.1 9777.4 9780.7 9940.0 9599.9 9731.8 9813.3 9863.4 9920.0 6989.4 7323.5 7653.2 7663.7 7804.0 8375.5 8457.7 8461.7 8479.2 8503.4 7511.8 7558.2 7565.4 7602.3 7831.8 7250.8 7304.0 7305.7 7363.5 7437.9 6981.3 6986.9 7024.1 7075.6 7077.5 5139.1 5188.8 5292.3 5318.9 5325.8 5284.7 5295.1 5297.2 5320.7 5340.2 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#4] prototype.html Cycles:180 Average:4844.84 Median:5410.89 stddev:1415.11 (26.2%) stddev-sans-first:1377.74 18:01:36 INFO - PROCESS | 11453 | Values: 321.1 332.3 335.2 338.1 338.6 5402.4 5594.7 5603.4 5700.5 5739.8 5575.7 5591.5 5618.9 5627.5 5631.4 4360.1 4388.5 4409.8 4410.3 4411.2 4242.4 4372.6 4377.6 4389.1 4405.2 4343.6 4365.5 4366.1 4384.6 4404.8 4305.1 4374.5 4403.4 4425.1 4431.0 3823.5 3850.0 3891.0 3907.8 3908.5 5419.4 5434.5 5434.6 5440.0 5478.8 4954.2 5035.3 5042.5 5056.5 5063.6 5814.4 5908.6 5913.4 5929.9 5950.9 4198.9 4250.2 4253.3 4268.2 4273.1 5836.6 5941.3 6171.7 6182.2 6188.8 4320.3 4343.2 4355.3 4363.1 4370.4 4390.5 4409.4 4411.6 4423.6 4425.2 4861.9 4997.9 5001.9 5009.7 5037.1 5814.9 5905.9 5913.9 5927.3 5931.0 1488.7 1520.3 1525.0 1526.9 1527.3 940.7 953.6 963.2 971.8 982.4 5082.8 5102.9 5109.9 5130.2 5161.9 5384.8 5385.5 5398.9 5425.0 5427.8 4954.7 5045.3 5107.0 5109.8 5110.8 2834.7 2873.3 2882.9 2886.2 2891.9 5488.9 5526.9 5528.7 5532.3 5559.3 5253.5 5397.9 5401.3 5472.5 5477.0 5490.3 5590.2 5595.6 5616.5 5624.4 5302.5 5325.0 5371.3 5398.6 5659.3 6008.4 6067.8 6095.1 6112.6 6116.0 6250.2 6293.4 6307.4 6371.7 6376.1 4256.4 4266.1 4278.2 4280.9 4284.9 5786.8 6098.5 6120.3 6148.9 6157.6 5992.8 6001.9 6006.3 6012.8 6019.4 5890.1 5902.5 5931.9 5948.1 5956.4 5590.7 5805.0 5848.1 5857.4 5871.5 5930.5 5990.9 5994.4 6027.8 6032.3 5625.6 5845.5 5854.5 5885.8 5895.3 18:01:36 INFO - PROCESS | 11453 | 18:01:36 INFO - PROCESS | 11453 | [#5] yui.html Cycles:180 Average:20011.30 Median:27946.20 stddev:29606.19 (105.9%) stddev-sans-first:29653.54 18:01:36 INFO - PROCESS | 11453 | Values: 646.6 735.6 787.0 808.3 827.6 14330.9 15937.6 15998.8 16199.7 16209.8 14257.1 14367.0 14382.9 14432.1 14444.4 641.0 765.2 793.2 797.3 798.8 784.2 786.5 789.6 793.4 795.1 846.1 848.4 849.0 849.5 850.5 834.4 836.5 839.0 843.9 843.9 613.8 615.7 616.9 617.7 620.5 15081.5 15081.7 15154.7 15174.8 15201.0 14505.6 14840.4 14867.3 15178.5 15318.5 12324.8 12501.5 12513.9 12582.7 12586.9 3946.6 3969.4 3981.3 4029.2 4117.0 73775.0 74106.6 74177.0 74871.6 76778.2 10759.2 11223.5 11290.4 11386.1 11965.8 19421.0 19802.3 20349.3 20580.6 20745.8 8050.6 8139.4 8243.7 8298.5 8609.4 4567.0 4646.7 4779.6 4788.0 5044.4 3369.1 3447.2 3461.8 3466.8 3469.3 599.4 604.3 614.1 620.4 624.5 614.4 645.6 679.3 687.9 694.2 9373.8 9409.5 9456.4 9499.0 9653.2 598.9 661.4 685.3 689.6 697.0 4332.8 4386.8 4440.4 4463.1 4481.8 100358.0 112368.4 112822.0 114839.0 116802.0 96385.5 99395.5 100150.5 101814.5 102057.5 86528.6 87746.0 88003.0 88216.0 88252.6 8224.1 8392.5 8494.7 8498.7 8573.4 49919.5 50380.7 50848.0 51610.7 53056.0 58893.7 70609.6 71115.6 71166.0 72809.3 10445.4 10546.8 10571.3 10620.2 10881.2 10565.3 10588.7 10852.5 11096.5 11626.9 10802.2 10811.3 10959.8 11043.4 11363.5 10051.4 10141.3 10180.2 10200.8 10206.1 10662.8 10830.4 10869.8 11244.0 11377.4 9157.1 9233.5 9294.2 9321.5 9392.8 9252.0 9415.5 9620.0 9689.6 11366.6 18:01:36 INFO - PROCESS | 11453 | -------- Summary: end -------- 18:01:36 INFO - PROCESS | 11453 | 18:01:37 INFO - TEST-INFO | 11453: exit 0 18:01:37 INFO - TEST-OK | dromaeo_css | took 1110626ms 18:01:37 INFO - TEST-START | kraken 18:01:37 INFO - operating with platform_type : linux_ 18:01:37 INFO - Initialising browser for kraken test... 18:01:37 INFO - TEST-INFO | started process 11688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkom76a/profile http://localhost:53387/getInfo.html) 18:01:42 INFO - PROCESS | 11688 | __metrics Screen width/height:1600/1200 18:01:42 INFO - PROCESS | 11688 | colorDepth:24 18:01:42 INFO - PROCESS | 11688 | Browser inner width/height: 1024/697 18:01:42 INFO - PROCESS | 11688 | __metrics 18:01:43 ERROR - PROCESS | 11688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 18:01:44 INFO - TEST-INFO | 11688: exit 0 18:01:44 INFO - Browser initialized. 18:01:44 INFO - Running cycle 1/1 for kraken test... 18:01:44 INFO - TEST-INFO | started process 11812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkom76a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:56 INFO - PROCESS | 11812 | RSS: Main: 167657472 18:01:56 INFO - PROCESS | 11812 | 18:01:58 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:59 INFO - PROCESS | 11812 | RSS: Main: 173211648 18:01:59 INFO - PROCESS | 11812 | 18:02:02 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-dft) 18:02:02 INFO - PROCESS | 11812 | RSS: Main: 172093440 18:02:02 INFO - PROCESS | 11812 | 18:02:05 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-fft) 18:02:06 INFO - PROCESS | 11812 | RSS: Main: 166928384 18:02:06 INFO - PROCESS | 11812 | 18:02:08 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-oscillator) 18:02:09 INFO - PROCESS | 11812 | RSS: Main: 167854080 18:02:09 INFO - PROCESS | 11812 | 18:02:11 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:12 INFO - PROCESS | 11812 | RSS: Main: 167895040 18:02:12 INFO - PROCESS | 11812 | 18:02:15 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:15 INFO - PROCESS | 11812 | RSS: Main: 168337408 18:02:15 INFO - PROCESS | 11812 | 18:02:19 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:19 INFO - PROCESS | 11812 | RSS: Main: 169029632 18:02:19 INFO - PROCESS | 11812 | 18:02:22 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53387/tests/kraken/driver.html?testName=json-parse-financial) 18:02:23 INFO - PROCESS | 11812 | RSS: Main: 168443904 18:02:23 INFO - PROCESS | 11812 | 18:02:24 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:25 INFO - PROCESS | 11812 | RSS: Main: 168554496 18:02:25 INFO - PROCESS | 11812 | 18:02:27 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:27 INFO - PROCESS | 11812 | RSS: Main: 168992768 18:02:27 INFO - PROCESS | 11812 | 18:02:30 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:30 INFO - PROCESS | 11812 | RSS: Main: 169189376 18:02:30 INFO - PROCESS | 11812 | 18:02:33 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:33 INFO - PROCESS | 11812 | RSS: Main: 168996864 18:02:33 INFO - PROCESS | 11812 | 18:02:36 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:37 INFO - PROCESS | 11812 | RSS: Main: 168890368 18:02:37 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53387/tests/kraken/driver.html?testName=ai-astar) 18:02:39 INFO - PROCESS | 11812 | RSS: Main: 169984000 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | __start_tp_report 18:02:39 INFO - PROCESS | 11812 | _x_x_mozilla_page_load 18:02:39 INFO - PROCESS | 11812 | _x_x_mozilla_page_load_details 18:02:39 INFO - PROCESS | 11812 | |i|pagename|runs| 18:02:39 INFO - PROCESS | 11812 | |0;ai-astar;112;108;111;112;113;114;110;111;111;113 18:02:39 INFO - PROCESS | 11812 | |1;audio-beat-detection;152;126;159;185;134;165;163;135;187;128 18:02:39 INFO - PROCESS | 11812 | |2;audio-dft;162;162;163;161;161;165;172;162;162;161 18:02:39 INFO - PROCESS | 11812 | |3;audio-fft;74;76;76;174;75;78;75;74;158;75 18:02:39 INFO - PROCESS | 11812 | |4;audio-oscillator;91;86;144;86;93;85;143;85;85;149 18:02:39 INFO - PROCESS | 11812 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;117;118;117 18:02:39 INFO - PROCESS | 11812 | |6;imaging-darkroom;146;147;147;148;147;147;147;148;146;147 18:02:39 INFO - PROCESS | 11812 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;99 18:02:39 INFO - PROCESS | 11812 | |8;json-parse-financial;55;56;55;55;58;54;56;54;55;55 18:02:39 INFO - PROCESS | 11812 | |9;json-stringify-tinderbox;61;62;64;62;63;62;62;62;63;63 18:02:39 INFO - PROCESS | 11812 | |10;stanford-crypto-aes;84;82;81;81;82;81;82;83;112;81 18:02:39 INFO - PROCESS | 11812 | |11;stanford-crypto-ccm;127;132;133;124;123;124;139;133;134;135 18:02:39 INFO - PROCESS | 11812 | |12;stanford-crypto-pbkdf2;168;165;168;171;166;174;173;170;166;167 18:02:39 INFO - PROCESS | 11812 | |13;stanford-crypto-sha256-iterative;65;65;65;63;67;64;63;63;68;63 18:02:39 INFO - PROCESS | 11812 | __end_tp_report 18:02:39 INFO - PROCESS | 11812 | __start_cc_report 18:02:39 INFO - PROCESS | 11812 | _x_x_mozilla_cycle_collect,893 18:02:39 INFO - PROCESS | 11812 | __end_cc_report 18:02:39 INFO - PROCESS | 11812 | __startTimestamp1465261359287__endTimestamp 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | ------- Summary: start ------- 18:02:39 INFO - PROCESS | 11812 | Number of tests: 14 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 18:02:39 INFO - PROCESS | 11812 | Values: 112.0 108.0 111.0 112.0 113.0 114.0 110.0 111.0 111.0 113.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:161.00 stddev:22.36 (13.9%) stddev-sans-first:23.71 18:02:39 INFO - PROCESS | 11812 | Values: 152.0 126.0 159.0 185.0 134.0 165.0 163.0 135.0 187.0 128.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:3.35 (2.1%) stddev-sans-first:3.53 18:02:39 INFO - PROCESS | 11812 | Values: 162.0 162.0 163.0 161.0 161.0 165.0 172.0 162.0 162.0 161.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:38.41 (51.2%) stddev-sans-first:40.09 18:02:39 INFO - PROCESS | 11812 | Values: 74.0 76.0 76.0 174.0 75.0 78.0 75.0 74.0 158.0 75.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:85.50 stddev:28.21 (33.0%) stddev-sans-first:29.48 18:02:39 INFO - PROCESS | 11812 | Values: 91.0 86.0 144.0 86.0 93.0 85.0 143.0 85.0 85.0 149.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:02:39 INFO - PROCESS | 11812 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 18:02:39 INFO - PROCESS | 11812 | Values: 146.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 146.0 147.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.25 (1.3%) stddev-sans-first:1.30 18:02:39 INFO - PROCESS | 11812 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 99.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 18:02:39 INFO - PROCESS | 11812 | Values: 55.0 56.0 55.0 55.0 58.0 54.0 56.0 54.0 55.0 55.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 18:02:39 INFO - PROCESS | 11812 | Values: 61.0 62.0 64.0 62.0 63.0 62.0 62.0 62.0 63.0 63.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.00 stddev:9.57 (11.7%) stddev-sans-first:10.15 18:02:39 INFO - PROCESS | 11812 | Values: 84.0 82.0 81.0 81.0 82.0 81.0 82.0 83.0 112.0 81.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:133.00 stddev:5.50 (4.1%) stddev-sans-first:5.70 18:02:39 INFO - PROCESS | 11812 | Values: 127.0 132.0 133.0 124.0 123.0 124.0 139.0 133.0 134.0 135.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.00 stddev:3.08 (1.8%) stddev-sans-first:3.26 18:02:39 INFO - PROCESS | 11812 | Values: 168.0 165.0 168.0 171.0 166.0 174.0 173.0 170.0 166.0 167.0 18:02:39 INFO - PROCESS | 11812 | 18:02:39 INFO - PROCESS | 11812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 18:02:39 INFO - PROCESS | 11812 | Values: 65.0 65.0 65.0 63.0 67.0 64.0 63.0 63.0 68.0 63.0 18:02:39 INFO - PROCESS | 11812 | -------- Summary: end -------- 18:02:39 INFO - PROCESS | 11812 | 18:02:40 INFO - TEST-INFO | 11812: exit 0 18:02:40 INFO - TEST-OK | kraken | took 62712ms 18:02:40 INFO - SUITE-END | took 1173s 18:02:40 INFO - Completed test suite (00:19:33) 18:02:40 INFO - javascript benchmark 18:02:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7090.495375354656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.3345030818373, 3104.2549788050874, 3125.671804460532, 3131.639861415937, 3136.137562170403, 5306.257124002638, 5371.4897084776885, 5375.247465354849, 5384.2462055312235, 5411.377691565471, 5326.893462130755, 5348.786048558063, 5352.330958630171, 5441.83674489765, 5475.260839786628, 4909.189983652693, 4945.25821126832, 4986.900261994758, 5026.29631851541, 5062.417821950486, 787.3618827834049, 4891.192953162724, 4921.458639549646, 5005.2492126181, 5016.347874776274, 4872.293517439969, 4903.754812259408, 4921.8277360292395, 4930.211166213407, 4946.826861059882, 4903.53416425439, 4927.852164435073, 4928.408590969071, 4935.925961110586, 4957.752112394366, 4863.975680121612, 4888.266759985995, 4901.852944411673, 4909.950900490985, 4918.360613120307, 5261.500157485033, 5312.840614781563, 5325.094733895247, 5335.359756829166, 5351.598630102758, 5692.31692196939, 5768.711564421804, 5795.797147099874, 5816.505597024258, 5839.445252700986, 5898.0, 5942.494887934531, 5949.6727679977585, 5954.672493012882, 6007.459328660441, 5494.615376923617, 5496.615236933416, 5503.504684578367, 5519.0, 5522.337319521643, 5803.738831752581, 5895.852603684943, 5927.970360148258, 6021.909671354933, 6032.306284777307, 5577.776888924398, 5640.5487560995025, 5648.943510564924, 5655.1799989001365, 5657.773689052474, 5745.482906538348, 5749.223854779551, 5758.596898217084, 5759.481646651821, 5789.160571717078, 5702.857428564236, 5716.256886604798, 5726.9713651431475, 5744.770209191669, 5749.885002300014, 5711.800086997018, 5714.714264286769, 5723.0, 5749.942500574941, 5753.712314384264, 4309.07354918694, 4335.7181783184, 4351.955530672616, 4363.738175709467, 4385.978070109629, 3886.8639597614515, 3889.0, 3892.0853599404118, 3909.7849618271266, 3917.9020524487114, 5536.557075433956, 5569.136783798518, 5613.7193140342815, 5644.181593668977, 5647.209390685307, 5796.507296879812, 5907.409259074058, 5910.645361278337, 5948.434898684618, 5966.0454327307425, 5527.088030474926, 5581.525570326487, 5585.162225666182, 5592.161175823659, 5631.915521267184, 4776.116418462596, 4848.442429120626, 4865.0756356292195, 4865.5864251538305, 4917.901641967141, 5924.4667979882015, 6001.2498437695285, 6054.0, 6062.514998800086, 6081.3614570470345, 5840.883182336414, 5913.674747888907, 5919.733611987384, 5929.940700592939, 5948.881022379442, 6078.3921607838865, 6083.66539840313, 6092.421219984094, 6099.329073801967, 6113.724882380215, 5693.857653558529, 5722.4277572242445, 5756.453136951983, 5763.33721622002, 5773.769049237983, 5870.647761134345, 5885.264341957255, 5924.6149000314845, 5925.466707996301, 5961.344252132175, 5744.339400968942, 5746.42535746422, 5771.7402716877, 5778.248827652378, 5778.768849245983, 5605.04714198579, 5662.03745363281, 5672.7730890763905, 5689.601727879009, 5710.457506536873, 5539.362973258127, 5582.413846546055, 5583.134614134816, 5585.078462053716, 5585.944140558542, 5710.857228569319, 5727.427257274239, 5746.281714785652, 5773.595848290579, 5788.218590490398, 5534.4742249486235, 5570.5265052470995, 5602.187682786055, 5641.464060914206, 5663.490285874291], "value": 5323.738365314342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.0992431957508, 618.1253526260342, 622.7228883147002, 640.30526878337, 654.3946849164528, 40538.18923621526, 41099.589004109985, 44000.0, 44372.3344149838, 44700.0, 45874.54125458753, 46075.53924460754, 46429.07141857169, 46753.53246467543, 46810.76594617022, 8687.869681954775, 8846.5576721164, 8859.778505537348, 8877.0, 8884.422512536665, 8752.212300892917, 8814.25078868297, 8854.557272136399, 8864.73405797827, 8886.511241881693, 8874.733757987271, 8894.777630559223, 8946.344926188644, 8980.506072166028, 9023.18791308782, 8828.161324674145, 8850.955745221265, 8902.554872256394, 8910.420822646573, 8932.776680582972, 8634.136586341378, 8641.351898607629, 8726.912730872673, 8729.476231426135, 8749.16882896124, 42270.78864605688, 42651.786741066404, 42652.57347426517, 42670.57329426697, 42672.57327426717, 3453.637368076341, 3618.294432585647, 3623.2934577757346, 3626.7098632109632, 3669.9082522936874, 31739.52390714141, 32129.678703213136, 32130.196745081324, 32437.83781081103, 32643.347133057207, 4066.2477441673386, 4130.896727581804, 4132.504099508078, 4136.565660605654, 4205.936910946339, 354072.99999999744, 355707.0, 356451.0, 357138.0, 357777.0, 34166.316673666384, 57344.426555734746, 58054.709726451096, 58101.709491452275, 58256.41743582595, 35379.0, 36715.26569468596, 36851.631483685356, 36884.446733299024, 36984.44523332152, 14223.359948802121, 14450.132992020512, 14465.421383144767, 14466.0, 14511.564653060424, 12303.753924921451, 12429.005679545615, 12448.937755311166, 12467.064970127096, 12470.937645311715, 8378.664853405917, 8403.201695838885, 8408.537530435762, 8463.534505602127, 8466.026406963278, 3271.7382609391193, 3296.489044198153, 3301.5047742838765, 3308.9007329780147, 3333.616634087111, 975.9512024398751, 983.6606370802205, 986.9407835529892, 1060.1624716474053, 1145.730753272997, 29708.702912970595, 30134.698653013627, 30853.845730771653, 30907.84546077255, 31223.687763122078, 1026.461107918349, 1124.7188202949262, 1134.5348407153028, 1155.7341811383428, 1247.6880779805049, 15872.44446444369, 16411.507654770376, 17479.737803932952, 18001.459956201335, 18412.81587184138, 575511.0, 579115.0, 579349.0, 579555.0, 580778.0, 58921.0, 59238.0, 59341.40658593445, 59381.0, 59742.0, 1321.973560528784, 1359.1844893064083, 1378.9931050344885, 1384.8338199416135, 1387.2508845223667, 27413.31466713348, 27523.449531009668, 27752.58371124475, 27854.860725697054, 28053.43893122085, 49457.752711236215, 50112.74943625258, 50393.49606503888, 50435.495645044546, 50565.74717126391, 471855.0, 473890.0, 478768.0, 479354.0, 479783.0, 27218.72781272162, 27604.309892252855, 27616.58575121415, 27626.0, 28367.716322837332, 47986.28020579624, 48001.75999119982, 48966.26550601672, 49082.0, 49331.506684934124, 40456.190876181725, 41047.0, 41328.0, 41781.37327940023, 42365.152696946505, 40418.0, 40661.79669101635, 40884.386734198415, 41716.374254386814, 42008.0, 40300.39549406702, 41273.1745365097, 41767.0, 42219.36670949877, 43647.0, 33536.83231583826, 37038.62961370352, 37668.81165594264, 37875.24249514939, 37899.242015160096, 28680.282992925342, 28850.42299153963, 29237.561436578042, 29315.41369172562, 29485.410291794473], "value": 18921.539083518768, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.52184769038695, 390.5625699216877, 392.75845355106617, 396.5816064052425, 411.964982976447, 13701.0, 18141.727874081884, 18858.622827543477, 19503.02484875756, 19534.609307813836, 18338.633227335446, 18526.0, 18615.90692046541, 18719.812801871976, 19034.33379831706, 5419.674819510822, 5463.617546771738, 5609.3268807743125, 5618.213450116987, 5635.5773317001185, 5496.972515137419, 5511.58663100269, 5513.007658621446, 5522.254495643077, 5554.0835762099205, 5431.456854314576, 5431.674099554019, 5472.398036216013, 5510.862228444301, 5574.024545704486, 5553.500184983351, 5558.610897237175, 5562.221289019541, 5565.2486914266465, 5592.552595792326, 4877.804887804484, 4978.6017118630425, 4979.651424400294, 4982.800687972477, 4995.500449955011, 16911.661766764595, 16987.74518382225, 20639.277625283044, 22040.11839526417, 22222.88888555547, 2225.9666105008437, 2237.3623517297656, 2291.8051965582777, 2326.6626339180725, 2338.4504641409253, 9574.329796914219, 10084.344517606332, 10109.848352274721, 12616.0, 13021.41403636829, 1909.4748944040361, 1928.768547774262, 1946.912388942501, 1947.6494231038407, 2017.909194086255, 82571.0, 86822.0, 88873.0, 89439.21121577597, 89463.0, 8809.735707928645, 9346.0, 9510.667126650535, 9540.61837526505, 9661.71014869555, 12851.807222891664, 12912.677183070498, 12923.095383323078, 12933.805992910115, 12940.611781646565, 7261.636918154071, 7705.383569314441, 7713.6914523419555, 7781.766547003599, 7844.607769611496, 7780.572068536172, 7838.137804841463, 7872.094709108412, 7959.482633628795, 7965.044194696674, 3918.6277303656107, 3993.121513267077, 4004.1190937993597, 4066.369712694537, 4104.938425923614, 1951.7657881054365, 1955.9487199968096, 1973.427705965254, 2003.0685731135093, 2056.259746491262, 901.2429559170329, 1041.3283432186197, 1065.4998330484323, 1078.757279612081, 1125.1224045244721, 17972.820271797376, 18306.450806475827, 18464.076796160138, 18691.532711682317, 18837.152328145265, 988.7132731507926, 1045.2369770067894, 1063.3938654966594, 1109.4840898982013, 1118.9384583847966, 10111.342762720547, 10208.877023527406, 10487.003734645197, 10549.20880933933, 10551.20865935058, 478746.0, 481316.0, 501116.0, 507050.0, 507280.0, 89151.55424222967, 92142.53928730448, 93071.53464232635, 93100.0, 94895.52552237194, 1014.7919676466307, 1028.6451174344838, 1036.2746077745458, 1054.8786889507805, 1056.3609016545033, 16424.0, 16425.589360266087, 16480.34078636841, 16576.2540685667, 16659.250333735254, 38441.231175376895, 41414.378784317654, 42703.57296426996, 43144.56855431406, 44560.77719611511, 56862.7156864213, 61645.0, 62959.6852015737, 63189.36810631835, 63771.0, 8248.587570621325, 8568.52873091986, 8740.562971851255, 8792.824143517222, 8868.822623547363, 11959.820602691141, 12380.257184568954, 12718.300493472947, 12725.109242352946, 12756.234625922103, 11360.772784544428, 11780.234284771463, 11794.0, 12005.519779208735, 12070.27578345302, 5225.608079393985, 10254.846482238516, 11355.37545435009, 11438.485268162785, 11500.769984600429, 10222.693319200436, 11745.88254117482, 11782.646520604396, 11939.46272417726, 11999.280043197436, 8498.915010849812, 8620.870686939827, 8658.134186581292, 8699.347548933729, 8720.302375809793, 8669.696560620348, 11131.165162612675, 11711.941440292743, 11718.296902185895, 11736.06111511094], "value": 8951.054623501683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.3301280929986, 1537.1852917953481, 1696.7794186755727, 1781.7683701118854, 1810.3301778342015, 7677.692892284316, 8178.836423271531, 8396.790080247996, 8932.732018039462, 8944.463332200072, 8295.502269863813, 8422.705205317816, 8578.142185781418, 8627.956860215705, 8650.307975361971, 2314.7106611673585, 2347.436615212354, 2373.46597015671, 2376.4415362389823, 2379.1791831817995, 2310.792028717415, 2334.2997100869757, 2336.4275752440676, 2347.4366152123453, 2358.9646155307682, 2342.7891489765916, 2350.847194932324, 2352.776486233805, 2386.331827088418, 2387.5344307859973, 2252.8986195621155, 2254.1434254983, 2273.4202778291515, 2276.578832915916, 2283.417728479227, 2236.8434209605334, 2249.302716157996, 2256.593813113639, 2263.762304957972, 2271.693321401606, 8343.165683431609, 8428.410011299211, 8451.028131764864, 8460.746177614681, 8473.533955632438, 5062.721550314731, 5149.227615857614, 5150.27896094547, 5155.71643559604, 5156.896862062776, 3060.7704422168426, 3165.6517783043846, 3282.2286762610765, 3283.6059672839174, 3291.0949488890506, 1072.785442911421, 1121.2767764791745, 1132.2470557079614, 1134.1210561814578, 1144.3991904250252, 11690.707732306675, 11701.824472632918, 11761.0, 11931.224470409396, 11947.761044779143, 4465.933011004838, 4522.118186953512, 4580.977095114503, 4599.40207772994, 4631.328457373662, 10167.237457190593, 10174.847377289347, 10223.437710925971, 10298.536565854554, 10318.329308594917, 5030.4215015272985, 5093.490650934951, 5098.362704661918, 5114.3095682083185, 5158.071547121479, 4162.687798415071, 4502.549745025472, 4624.398828152386, 4630.189716799547, 4748.406449193851, 3908.7068469864307, 3945.467361906163, 3960.386140148282, 3976.2842688315804, 4004.939925901114, 1220.9450574724158, 1224.406163010939, 1232.9938350308191, 1233.7409144079663, 1250.3248245947268, 989.9851502227473, 1014.5028935821394, 1014.5282443663732, 1029.0995379043336, 1030.3611760708409, 5703.201551782754, 5977.0, 6007.290934207104, 6079.240094988127, 6155.322914479404, 466.23071931312927, 482.9227323628203, 484.3582253514108, 488.0799692579513, 493.5557997802007, 4211.684123690736, 4252.362145678173, 4261.531231564588, 4273.87178384649, 4280.914381712349, 10155.7461063474, 10439.37363758177, 10469.895301047045, 10479.53286539885, 10482.37105773656, 10368.326058806153, 10390.324628899098, 10399.58401663925, 10443.164546836235, 10459.947700261602, 7702.537847729154, 7749.186335434698, 7979.760607181794, 7992.840143197103, 8140.75577732669, 5936.643801371759, 6007.8197654070445, 6041.093835924647, 6058.273007238983, 6198.473129784019, 9456.338056336266, 9769.120779129913, 9777.364471309342, 9780.706578802647, 9939.950300248742, 9599.856002159833, 9731.805363892825, 9813.313068085166, 9863.358881672668, 9920.0, 6989.405900498515, 7323.523970941872, 7653.158152603321, 7663.693452261847, 7803.960980195063, 8375.455595386524, 8457.746267611981, 8461.661533538836, 8479.19447652472, 8503.404761666625, 7511.8497630046, 7558.1686014539455, 7565.394768418403, 7602.277783610548, 7831.765047048598, 7250.782476525713, 7303.963480182565, 7305.707771689073, 7363.484556081237, 7437.851242975002, 6981.3367730065565, 6986.860262794818, 7024.086868707035, 7075.646217689198, 7077.5399599025895, 5139.126348520836, 5188.754698872319, 5292.311999440049, 5318.946810532, 5325.760340784596, 5284.682919024717, 5295.073362161529, 5297.152455607084, 5320.707361095177, 5340.225667278145], "value": 4501.664232097159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.145752298885, 332.3038234897888, 335.1905149065008, 338.0618782877513, 338.62581847059, 5402.37872644646, 5594.692291923942, 5603.439656034399, 5700.515456186229, 5739.770409183638, 5575.721213939307, 5591.4688104630095, 5618.915716264249, 5627.549796016319, 5631.436856314377, 4360.062586543892, 4388.517263101056, 4409.757463339515, 4410.338449232625, 4411.183930972764, 4242.3666888247935, 4372.584604462571, 4377.584129507692, 4389.144116897206, 4405.207062728708, 4343.565643435662, 4365.497967733703, 4366.148601022802, 4384.618845063795, 4404.810701110699, 4305.07440900208, 4374.496932852715, 4403.4495688039, 4425.1370982658555, 4430.977845110786, 3823.541175058983, 3850.0, 3891.0, 3907.8436862525464, 3908.530976282836, 5419.403865574784, 5434.483724046209, 5434.619576629638, 5440.0, 5478.808241711561, 4954.157793175169, 5035.295058691786, 5042.470540593222, 5056.544910957995, 5063.569596584295, 5814.418558144194, 5908.615939963888, 5913.408659134096, 5929.940700592982, 5950.9107363389585, 4198.908283846192, 4250.234957707611, 4253.319468884994, 4268.189044081614, 4273.081287523167, 5836.5914385993, 5941.287045554561, 6171.660558669271, 6182.227221597301, 6188.84527886802, 4320.330348795942, 4343.2399330117105, 4355.259605867011, 4363.127374525107, 4370.431843860278, 4390.517043125254, 4409.382686423904, 4411.625011873963, 4423.60187583119, 4425.247707889666, 4861.9027619447415, 4997.875053123701, 5001.924971125436, 5009.724465154379, 5037.143685573461, 5814.854628634233, 5905.940940590625, 5913.881722365529, 5927.2590926134235, 5931.0, 1488.7245859516024, 1520.3310543360885, 1524.9695006100037, 1526.9236538173047, 1527.3279756906925, 940.7130825098274, 953.6042542344987, 963.1861077389734, 971.8347880860271, 982.3810999070682, 5082.822101226439, 5102.923456148161, 5109.930478156352, 5130.230465430141, 5161.896762064813, 5384.811531596375, 5385.542228910508, 5398.91901621476, 5425.0, 5427.755750991215, 4954.727489988013, 5045.344105266292, 5107.0, 5109.821156259587, 5110.8466745997675, 2834.7385413490797, 2873.252954231873, 2882.9135125946254, 2886.235147685865, 2891.8843246270335, 5488.890222195534, 5526.88247255797, 5528.673118451623, 5532.280803495601, 5559.305086864142, 5253.474652534716, 5397.865053373697, 5401.3248343957, 5472.50747432733, 5476.972615136979, 5490.3371864645615, 5590.2328347468265, 5595.62907087758, 5616.528727359949, 5624.353199382042, 5302.507821323971, 5325.0, 5371.301730774974, 5398.62209645321, 5659.3491748447805, 6008.3863519369215, 6067.757289708362, 6095.146679464967, 6112.633242005494, 6115.960286751174, 6250.249970003629, 6293.370662933853, 6307.400796924285, 6371.74513019474, 6376.107344971801, 4256.36154576816, 4266.125444283976, 4278.160391031886, 4280.935785963151, 4284.871453856389, 5786.82993877296, 6098.451139397298, 6120.347506173397, 6148.923938310688, 6157.599756015845, 5992.760289588367, 6001.90997135052, 6006.339302676614, 6012.849678758066, 6019.367966363468, 5890.145928840208, 5902.498287645598, 5931.881362372815, 5948.10778383246, 5956.434138756811, 5590.720463976703, 5805.013147764806, 5848.093545500455, 5857.384974577608, 5871.530277577698, 5930.495907847881, 5990.880182396415, 5994.400559943971, 6027.849303767265, 6032.336442991355, 5625.634333768292, 5845.532357411482, 5854.502367298657, 5885.793997210077, 5895.29256489224], "value": 4389.177990881316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.5797231799327, 735.5586648011194, 786.9606519674015, 808.325048584432, 827.6275675945826, 14330.928345358272, 15937.601559960993, 15998.760018599716, 16199.676006479864, 16209.83790162098, 14257.073290236127, 14367.0, 14382.92808535956, 14432.061915975455, 14444.350004249807, 640.9519286053553, 765.177434258172, 793.2226418110256, 797.2665148063795, 798.8322452285028, 784.1883650421814, 786.5241528875034, 789.5815217934476, 793.4326956226297, 795.145218889693, 846.0777752250046, 848.3806821020659, 848.9660413583449, 849.5157760076759, 850.4939560961249, 834.3742193354984, 836.523181786382, 839.0183485322187, 843.8649816029437, 843.8902942617482, 613.7606333529927, 615.6521565315583, 616.9352218017133, 617.6849806598622, 620.5439002333281, 15081.54755357341, 15081.698366032728, 15154.696906061818, 15174.772378414333, 15201.0, 14505.637359066002, 14840.406383744637, 14867.256637168206, 15178.544643660707, 15318.463853765064, 12324.75350492994, 12501.49994000239, 12513.874861251454, 12582.68543286416, 12586.874131258663, 3946.5856085110936, 3969.364901615728, 3981.3231750602467, 4029.214303210875, 4116.9794151029055, 73775.0, 74106.62946685286, 74177.0, 74871.62564187145, 76778.16109194573, 10759.193060520493, 11223.494942727597, 11290.435478226056, 11386.146039046938, 11965.760684786255, 19421.028948552517, 19802.306919257757, 20349.287774927805, 20580.58838823215, 20745.792542074385, 8050.637721302555, 8139.43023988327, 8243.711470098518, 8298.502089874626, 8609.397342186112, 4566.954330456653, 4646.7444290564345, 4779.617630589614, 4787.976060119747, 5044.394672639233, 3369.0735047861544, 3447.1899103710607, 3461.826908654557, 3466.843992020365, 3469.2887957968555, 599.4155698194226, 604.3171216525299, 614.118739608663, 620.3889169168366, 624.497279689845, 614.4070971512512, 645.5706954874955, 679.2969276798589, 687.8933765266391, 694.2016680817, 9373.765655858659, 9409.48247846375, 9456.432614043179, 9499.0, 9653.22774178064, 598.8712426828253, 661.4278648968703, 685.3454950522239, 689.6138162628944, 697.0, 4332.826686932551, 4386.824527018884, 4440.444944381952, 4463.085067561142, 4481.843135490242, 100358.0, 112368.43815781032, 112822.0, 114839.0, 116802.0, 96385.51807240919, 99395.50302248442, 100150.49924750475, 101814.49092754489, 102057.48971255096, 86528.56735716281, 87745.99999999872, 88003.0, 88216.0, 88252.55873720719, 8224.09534951143, 8392.4544904581, 8494.74515764528, 8498.70254541088, 8573.399862009599, 49919.50080499148, 50380.74809625928, 50848.0, 51610.74194629003, 53056.0, 58893.70553147207, 70609.64695176491, 71115.64442177756, 71166.0, 72809.27190728237, 10445.425501597485, 10546.8417973732, 10571.2600117991, 10620.150387969099, 10881.238313317992, 10565.26043177001, 10588.735281618021, 10852.489228700097, 11096.500657470595, 11626.88373116258, 10802.243842930919, 10811.29726567802, 10959.83560246581, 11043.447827608426, 11363.54545818191, 10051.396916185053, 10141.340812847142, 10180.185585153022, 10200.846987295048, 10206.132478739093, 10662.786744265226, 10830.40432776205, 10869.836952445878, 11244.0, 11377.43112844371, 9157.130072643089, 9233.492157931378, 9294.163525282756, 9321.533923303943, 9392.81214375695, 9251.953740231256, 9415.529223538659, 9619.951900240454, 9689.563969621244, 11366.602168924048], "value": 7132.043060340191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 111.0, 112.0, 113.0, 114.0, 110.0, 111.0, 111.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 159.0, 185.0, 134.0, 165.0, 163.0, 135.0, 187.0, 128.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 165.0, 172.0, 162.0, 162.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 174.0, 75.0, 78.0, 75.0, 74.0, 158.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 144.0, 86.0, 93.0, 85.0, 143.0, 85.0, 85.0, 149.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 99.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 58.0, 54.0, 56.0, 54.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0, 83.0, 112.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 133.0, 124.0, 123.0, 124.0, 139.0, 133.0, 134.0, 135.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 168.0, 171.0, 166.0, 174.0, 173.0, 170.0, 166.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 67.0, 64.0, 63.0, 63.0, 68.0, 63.0], "value": 64.6, "unit": "score"}]}]} 18:02:40 INFO - Return code: 0 18:02:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:40 ERROR - # TBPL SUCCESS # 18:02:40 INFO - Running post-action listener: _resource_record_post_action 18:02:40 INFO - ##### 18:02:40 INFO - ##### Finished run-tests step (success) 18:02:40 INFO - ##### 18:02:40 INFO - Running post-run listener: _resource_record_post_run 18:02:40 INFO - Total resource usage - Wall time: 1193s; CPU: 14.0%; Read bytes: 4096; Write bytes: 542597120; Read time: 8; Write time: 1654336 18:02:40 INFO - TinderboxPrint: CPU usage
13.6% 18:02:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:02:40 INFO - TinderboxPrint: I/O write bytes / time
542,597,120 / 1,654,336 18:02:40 INFO - TinderboxPrint: CPU idle
8,227.2 (86.4%) 18:02:40 INFO - TinderboxPrint: CPU user
1,221.5 (12.8%) 18:02:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:40 INFO - install - Wall time: 19s; CPU: 18.0%; Read bytes: 0; Write bytes: 248934400; Read time: 0; Write time: 1105056 18:02:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293609472; Read time: 8; Write time: 549256 18:02:41 INFO - Running post-run listener: _upload_blobber_files 18:02:41 INFO - Blob upload gear active. 18:02:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:41 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 18:02:41 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:41 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:45 INFO - (blobuploader) - INFO - Done attempting. 18:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:46 INFO - (blobuploader) - INFO - Done attempting. 18:02:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:47 INFO - (blobuploader) - INFO - Done attempting. 18:02:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:47 INFO - Return code: 0 18:02:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fefd228b76ee3e01cb0d016735ad4da4991ead5b915b07efb70c3c957e0aea9d1e8a2ec1ed85e59a45e8d83eaffc111c4c4380e177a327f6e97737aeb2560e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b578e23337458e21ea946dccff747163a3683c49804d817cb51d296c58272bd9227bb8780f01fb7afb22497035d554cccb1f6eebb3862272b29396bb4256e58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1371dbe9cb10a4f1e132c4e9c4bda86abe6cae86baa8e60c5a4e7945a9fe8847bba9152c0c3992b80b5d0855cd1c29db1bddec608fa1a7f4faced336c1b4f524"} 18:02:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:47 INFO - Contents: 18:02:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fefd228b76ee3e01cb0d016735ad4da4991ead5b915b07efb70c3c957e0aea9d1e8a2ec1ed85e59a45e8d83eaffc111c4c4380e177a327f6e97737aeb2560e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b578e23337458e21ea946dccff747163a3683c49804d817cb51d296c58272bd9227bb8780f01fb7afb22497035d554cccb1f6eebb3862272b29396bb4256e58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1371dbe9cb10a4f1e132c4e9c4bda86abe6cae86baa8e60c5a4e7945a9fe8847bba9152c0c3992b80b5d0855cd1c29db1bddec608fa1a7f4faced336c1b4f524"} 18:02:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:47 INFO - Copying logs to upload dir... 18:02:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.464381 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 18:02:47.520830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 18:02:47.523882) ========= 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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 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/Fx-Team/sha512/fefd228b76ee3e01cb0d016735ad4da4991ead5b915b07efb70c3c957e0aea9d1e8a2ec1ed85e59a45e8d83eaffc111c4c4380e177a327f6e97737aeb2560e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b578e23337458e21ea946dccff747163a3683c49804d817cb51d296c58272bd9227bb8780f01fb7afb22497035d554cccb1f6eebb3862272b29396bb4256e58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1371dbe9cb10a4f1e132c4e9c4bda86abe6cae86baa8e60c5a4e7945a9fe8847bba9152c0c3992b80b5d0855cd1c29db1bddec608fa1a7f4faced336c1b4f524"} build_url:https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fefd228b76ee3e01cb0d016735ad4da4991ead5b915b07efb70c3c957e0aea9d1e8a2ec1ed85e59a45e8d83eaffc111c4c4380e177a327f6e97737aeb2560e22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b578e23337458e21ea946dccff747163a3683c49804d817cb51d296c58272bd9227bb8780f01fb7afb22497035d554cccb1f6eebb3862272b29396bb4256e58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1371dbe9cb10a4f1e132c4e9c4bda86abe6cae86baa8e60c5a4e7945a9fe8847bba9152c0c3992b80b5d0855cd1c29db1bddec608fa1a7f4faced336c1b4f524"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 18:02:47.548685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 18:02:47.548971) ========= 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=df17445c3590ff7897617a0e00000225-1465260131.385261-1631939249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 18:02:47.632133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 18:02:47.632430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 18:02:47.632722) ========= ========= Total master_lag: 0.17 =========