builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1465260386.24 results: success (0) buildid: 20160606053005 builduid: 7afa8ff62dfa40a2ae994ec404a4246c revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.240238) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.241288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.242053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.275849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.276442) ========= 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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 17:46:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-06 17:46:26 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.426787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.427489) ========= 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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:26.479906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 17:46:26.480583) ========= 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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 17:46:26,678 truncating revision to first 12 chars 2016-06-06 17:46:26,678 Setting DEBUG logging. 2016-06-06 17:46:26,678 attempt 1/10 2016-06-06 17:46:26,678 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:46:27,701 unpacking tar archive at: fx-team-6a6cb441259d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 17:46:27.821325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:27.822120) ========= script_repo_revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:27.823136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:27.823945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:46:27.835480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 17:46:27.835832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:46:28 INFO - MultiFileLogger online at 20160606 17:46:28 in /builds/slave/test 17:46:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:46:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:28 INFO - {'append_to_log': False, 17:46:28 INFO - 'base_work_dir': '/builds/slave/test', 17:46:28 INFO - 'blob_upload_branch': 'Fx-Team', 17:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:28 INFO - 'branch': 'Fx-Team', 17:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:28 INFO - 'config_files': ('talos/linux_config.py',), 17:46:28 INFO - 'default_actions': ('clobber', 17:46:28 INFO - 'read-buildbot-config', 17:46:28 INFO - 'download-and-extract', 17:46:28 INFO - 'populate-webroot', 17:46:28 INFO - 'create-virtualenv', 17:46:28 INFO - 'install', 17:46:28 INFO - 'run-tests'), 17:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:28 INFO - 'download_minidump_stackwalk': True, 17:46:28 INFO - 'download_symbols': 'ondemand', 17:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:28 INFO - 'installer_path': 'installer.exe', 17:46:28 INFO - 'log_level': 'info', 17:46:28 INFO - 'log_name': 'talos', 17:46:28 INFO - 'log_to_console': True, 17:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:46:28 INFO - 'opt_config_files': (), 17:46:28 INFO - 'pip_index': False, 17:46:28 INFO - 'sps_profile': False, 17:46:28 INFO - 'sps_profile_interval': 0, 17:46:28 INFO - 'suite': 'dromaeojs', 17:46:28 INFO - 'system_bits': '32', 17:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:28 INFO - 'title': 'talos-linux64-ix-027', 17:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:28 INFO - 'use_talos_json': True, 17:46:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:28 INFO - 'work_dir': 'build'} 17:46:28 INFO - ##### 17:46:28 INFO - ##### Running clobber step. 17:46:28 INFO - ##### 17:46:28 INFO - Running pre-action listener: _resource_record_pre_action 17:46:28 INFO - Running main action method: clobber 17:46:28 INFO - rmtree: /builds/slave/test/build 17:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:29 INFO - Running post-action listener: _resource_record_post_action 17:46:29 INFO - ##### 17:46:29 INFO - ##### Finished clobber step (success) 17:46:29 INFO - ##### 17:46:29 INFO - ##### 17:46:29 INFO - ##### Running read-buildbot-config step. 17:46:29 INFO - ##### 17:46:29 INFO - Running pre-action listener: _resource_record_pre_action 17:46:29 INFO - Running main action method: read_buildbot_config 17:46:29 INFO - Using buildbot properties: 17:46:29 INFO - { 17:46:29 INFO - "project": "", 17:46:29 INFO - "product": "firefox", 17:46:29 INFO - "script_repo_revision": "production", 17:46:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:46:29 INFO - "repository": "", 17:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:46:29 INFO - "buildid": "20160606053005", 17:46:29 INFO - "pgo_build": "True", 17:46:29 INFO - "basedir": "/builds/slave/test", 17:46:29 INFO - "buildnumber": 1230, 17:46:29 INFO - "slavename": "talos-linux64-ix-027", 17:46:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:46:29 INFO - "platform": "ubuntu64_hw", 17:46:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:46:29 INFO - "branch": "fx-team", 17:46:29 INFO - "repo_path": "integration/fx-team", 17:46:29 INFO - "revision": "6a6cb441259d532d321f56272b26a322dbdc2caa", 17:46:29 INFO - "stage_platform": "linux64-pgo", 17:46:29 INFO - "builduid": "7afa8ff62dfa40a2ae994ec404a4246c", 17:46:29 INFO - "slavebuilddir": "test" 17:46:29 INFO - } 17:46:29 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:46:29 INFO - Running post-action listener: _resource_record_post_action 17:46:29 INFO - ##### 17:46:29 INFO - ##### Finished read-buildbot-config step (success) 17:46:29 INFO - ##### 17:46:29 INFO - ##### 17:46:29 INFO - ##### Running download-and-extract step. 17:46:29 INFO - ##### 17:46:29 INFO - Running pre-action listener: _resource_record_pre_action 17:46:29 INFO - Running main action method: download_and_extract 17:46:29 INFO - mkdir: /builds/slave/test/build/tests 17:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:29 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:46:29 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:46:29 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:46:29 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:46:29 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:46:29 INFO - Downloaded 1361 bytes. 17:46:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:46:29 INFO - Using the following test package requirements: 17:46:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:46:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:46:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'jsshell-linux-x86_64.zip'], 17:46:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:46:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:46:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:46:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:46:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:46:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:29 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:46:29 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:46:29 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:46:29 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:46:29 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:46:31 INFO - Downloaded 24443732 bytes. 17:46:31 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:46:31 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:46:32 INFO - Return code: 0 17:46:32 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:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:33 INFO - Downloaded 24443732 bytes. 17:46:33 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:46:33 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:46:34 INFO - Return code: 0 17:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:34 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:46:34 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:46:34 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:46:34 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:46:34 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:46:35 INFO - Downloaded 10833369 bytes. 17:46:35 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:46:35 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:46:36 INFO - Return code: 0 17:46: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:46:36 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:46:36 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:46:36 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:46:36 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:46:36 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:46:37 INFO - Downloaded 59166024 bytes. 17:46:37 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:46:37 INFO - mkdir: /builds/slave/test/properties 17:46:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:46:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:46:37 INFO - Contents: 17:46:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GWunHTwVTFGlqLC9YkF5Hw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:46:38 INFO - Running post-action listener: _resource_record_post_action 17:46:38 INFO - Running post-action listener: set_extra_try_arguments 17:46:38 INFO - ##### 17:46:38 INFO - ##### Finished download-and-extract step (success) 17:46:38 INFO - ##### 17:46:38 INFO - ##### 17:46:38 INFO - ##### Running populate-webroot step. 17:46:38 INFO - ##### 17:46:38 INFO - Running pre-action listener: _resource_record_pre_action 17:46:38 INFO - Running main action method: populate_webroot 17:46:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:46:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:46:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:46:38 INFO - '--tppagecycles', 17:46:38 INFO - '7'], 17:46:38 INFO - 'tests': ['tsvgm']}}, 17:46:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:46:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:46:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:46:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:46:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['damp', 'tps']}, 17:46:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'tests': ['damp', 'tps']}, 17:46:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['dromaeo_dom']}, 17:46:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:46:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'other-e10s': {'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['a11yr', 17:46:38 INFO - 'ts_paint', 17:46:38 INFO - 'tpaint', 17:46:38 INFO - 'sessionrestore', 17:46:38 INFO - 'sessionrestore_no_auto_restore', 17:46:38 INFO - 'tabpaint']}, 17:46:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['tsvgx', 17:46:38 INFO - 'tsvgr_opacity', 17:46:38 INFO - 'tart', 17:46:38 INFO - 'tscrollx', 17:46:38 INFO - 'cart']}, 17:46:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:46:38 INFO - 'tsvgr_opacity', 17:46:38 INFO - 'tart', 17:46:38 INFO - 'tscrollx', 17:46:38 INFO - 'cart']}, 17:46:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'talos_options': ['--disable-e10s'], 17:46:38 INFO - 'tests': ['tp5o']}, 17:46:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'tests': ['tp5o']}, 17:46:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'talos_options': ['--disable-e10s', 17:46:38 INFO - '--xperf_path', 17:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:38 INFO - 'tests': ['tp5n']}, 17:46:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:38 INFO - 'talos_options': ['--xperf_path', 17:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:38 INFO - 'tests': ['tp5n']}}, 17:46:38 INFO - 'talos.zip': {'path': '', 17:46:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:46:38 INFO - Running post-action listener: _resource_record_post_action 17:46:38 INFO - ##### 17:46:38 INFO - ##### Finished populate-webroot step (success) 17:46:38 INFO - ##### 17:46:38 INFO - ##### 17:46:38 INFO - ##### Running create-virtualenv step. 17:46:38 INFO - ##### 17:46:38 INFO - Running pre-action listener: _resource_record_pre_action 17:46:38 INFO - Running main action method: create_virtualenv 17:46:38 INFO - Creating virtualenv /builds/slave/test/build/venv 17:46:38 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:46:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:46:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:46:38 INFO - Using real prefix '/usr' 17:46:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:46:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:46:40 INFO - Installing pip.................done. 17:46:40 INFO - Return code: 0 17:46:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:40 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:40 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:46:40 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:46:40 INFO - Using env: {'DISPLAY': ':0', 17:46:40 INFO - 'HOME': '/home/cltbld', 17:46:40 INFO - 'LANG': 'en_US.UTF-8', 17:46:40 INFO - 'LANGUAGE': 'en_US:en', 17:46:40 INFO - 'LOGNAME': 'cltbld', 17:46:40 INFO - 'MAIL': '/var/mail/cltbld', 17:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:40 INFO - 'MOZ_NO_REMOTE': '1', 17:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:40 INFO - 'NO_EM_RESTART': '1', 17:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:40 INFO - 'PWD': '/builds/slave/test', 17:46:40 INFO - 'SHELL': '/bin/bash', 17:46:40 INFO - 'SHLVL': '1', 17:46:40 INFO - 'TERM': 'linux', 17:46:40 INFO - 'TMOUT': '86400', 17:46:40 INFO - 'USER': 'cltbld', 17:46:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:40 INFO - '_': '/tools/buildbot/bin/python'} 17:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:41 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:46:41 INFO - Cleaning up... 17:46:41 INFO - Return code: 0 17:46:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:41 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:41 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:46:41 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:46:41 INFO - Using env: {'DISPLAY': ':0', 17:46:41 INFO - 'HOME': '/home/cltbld', 17:46:41 INFO - 'LANG': 'en_US.UTF-8', 17:46:41 INFO - 'LANGUAGE': 'en_US:en', 17:46:41 INFO - 'LOGNAME': 'cltbld', 17:46:41 INFO - 'MAIL': '/var/mail/cltbld', 17:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:41 INFO - 'MOZ_NO_REMOTE': '1', 17:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:41 INFO - 'NO_EM_RESTART': '1', 17:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:41 INFO - 'PWD': '/builds/slave/test', 17:46:41 INFO - 'SHELL': '/bin/bash', 17:46:41 INFO - 'SHLVL': '1', 17:46:41 INFO - 'TERM': 'linux', 17:46:41 INFO - 'TMOUT': '86400', 17:46:41 INFO - 'USER': 'cltbld', 17:46:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:41 INFO - '_': '/tools/buildbot/bin/python'} 17:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:41 INFO - Downloading/unpacking psutil>=3.1.1 17:46: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:46: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:46: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:46: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:46: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:46: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:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:43 INFO - Installing collected packages: psutil 17:46:43 INFO - Running setup.py install for psutil 17:46:43 INFO - building 'psutil._psutil_linux' extension 17:46:43 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:46:43 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:46:43 INFO - building 'psutil._psutil_posix' extension 17:46:43 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:46:43 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:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:43 INFO - Successfully installed psutil 17:46:43 INFO - Cleaning up... 17:46:43 INFO - Return code: 0 17:46:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:46: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:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:46: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 mozsystemmonitor==0.3 17:46:43 INFO - Using env: {'DISPLAY': ':0', 17:46:43 INFO - 'HOME': '/home/cltbld', 17:46:43 INFO - 'LANG': 'en_US.UTF-8', 17:46:43 INFO - 'LANGUAGE': 'en_US:en', 17:46:43 INFO - 'LOGNAME': 'cltbld', 17:46:43 INFO - 'MAIL': '/var/mail/cltbld', 17:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:43 INFO - 'MOZ_NO_REMOTE': '1', 17:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:43 INFO - 'NO_EM_RESTART': '1', 17:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:43 INFO - 'PWD': '/builds/slave/test', 17:46:43 INFO - 'SHELL': '/bin/bash', 17:46:43 INFO - 'SHLVL': '1', 17:46:43 INFO - 'TERM': 'linux', 17:46:43 INFO - 'TMOUT': '86400', 17:46:43 INFO - 'USER': 'cltbld', 17:46:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:43 INFO - '_': '/tools/buildbot/bin/python'} 17:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:46: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:46: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:46: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:46: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:46: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:46: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:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:46:46 INFO - Installing collected packages: mozsystemmonitor 17:46:46 INFO - Running setup.py install for mozsystemmonitor 17:46:46 INFO - Successfully installed mozsystemmonitor 17:46:46 INFO - Cleaning up... 17:46:46 INFO - Return code: 0 17:46:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:46:46 INFO - Using env: {'DISPLAY': ':0', 17:46:46 INFO - 'HOME': '/home/cltbld', 17:46:46 INFO - 'LANG': 'en_US.UTF-8', 17:46:46 INFO - 'LANGUAGE': 'en_US:en', 17:46:46 INFO - 'LOGNAME': 'cltbld', 17:46:46 INFO - 'MAIL': '/var/mail/cltbld', 17:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:46 INFO - 'MOZ_NO_REMOTE': '1', 17:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:46 INFO - 'NO_EM_RESTART': '1', 17:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:46 INFO - 'PWD': '/builds/slave/test', 17:46:46 INFO - 'SHELL': '/bin/bash', 17:46:46 INFO - 'SHLVL': '1', 17:46:46 INFO - 'TERM': 'linux', 17:46:46 INFO - 'TMOUT': '86400', 17:46:46 INFO - 'USER': 'cltbld', 17:46:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:46 INFO - '_': '/tools/buildbot/bin/python'} 17:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:46 INFO - Downloading/unpacking jsonschema==2.5.1 17:46: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:46: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:46: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:46: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:46: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:46: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:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:46:48 INFO - warning: no files found matching '*.txt' 17:46:48 INFO - no previously-included directories found matching 'build' 17:46:48 INFO - no previously-included directories found matching 'dist' 17:46:48 INFO - no previously-included directories found matching '.git*' 17:46:48 INFO - Installing collected packages: jsonschema, functools32 17:46:48 INFO - Running setup.py install for functools32 17:46:48 INFO - warning: no files found matching '*.txt' 17:46:48 INFO - no previously-included directories found matching 'build' 17:46:48 INFO - no previously-included directories found matching 'dist' 17:46:48 INFO - no previously-included directories found matching '.git*' 17:46:48 INFO - Successfully installed jsonschema functools32 17:46:48 INFO - Cleaning up... 17:46:48 INFO - Return code: 0 17:46:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:48 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:48 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:46:48 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:46:48 INFO - Using env: {'DISPLAY': ':0', 17:46:48 INFO - 'HOME': '/home/cltbld', 17:46:48 INFO - 'LANG': 'en_US.UTF-8', 17:46:48 INFO - 'LANGUAGE': 'en_US:en', 17:46:48 INFO - 'LOGNAME': 'cltbld', 17:46:48 INFO - 'MAIL': '/var/mail/cltbld', 17:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:48 INFO - 'MOZ_NO_REMOTE': '1', 17:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:48 INFO - 'NO_EM_RESTART': '1', 17:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:48 INFO - 'PWD': '/builds/slave/test', 17:46:48 INFO - 'SHELL': '/bin/bash', 17:46:48 INFO - 'SHLVL': '1', 17:46:48 INFO - 'TERM': 'linux', 17:46:48 INFO - 'TMOUT': '86400', 17:46:48 INFO - 'USER': 'cltbld', 17:46:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:48 INFO - '_': '/tools/buildbot/bin/python'} 17:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:46:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:46:51 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:46:51 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:46:51 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:46:51 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:46:51 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:46:51 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:46:51 INFO - Downloading docopt-0.6.1.tar.gz 17:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:46:51 INFO - Running setup.py install for blobuploader 17:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:46:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:46:51 INFO - Running setup.py install for requests 17:46:52 INFO - Running setup.py install for docopt 17:46:52 INFO - Successfully installed blobuploader requests docopt 17:46:52 INFO - Cleaning up... 17:46:52 INFO - Return code: 0 17:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:52 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:52 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:46:52 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:46:52 INFO - Using env: {'DISPLAY': ':0', 17:46:52 INFO - 'HOME': '/home/cltbld', 17:46:52 INFO - 'LANG': 'en_US.UTF-8', 17:46:52 INFO - 'LANGUAGE': 'en_US:en', 17:46:52 INFO - 'LOGNAME': 'cltbld', 17:46:52 INFO - 'MAIL': '/var/mail/cltbld', 17:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:52 INFO - 'MOZ_NO_REMOTE': '1', 17:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:52 INFO - 'NO_EM_RESTART': '1', 17:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:52 INFO - 'PWD': '/builds/slave/test', 17:46:52 INFO - 'SHELL': '/bin/bash', 17:46:52 INFO - 'SHLVL': '1', 17:46:52 INFO - 'TERM': 'linux', 17:46:52 INFO - 'TMOUT': '86400', 17:46:52 INFO - 'USER': 'cltbld', 17:46:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:52 INFO - '_': '/tools/buildbot/bin/python'} 17:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:52 INFO - Running setup.py (path:/tmp/pip-NEsUfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:52 INFO - Running setup.py (path:/tmp/pip-GbcQWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:52 INFO - Running setup.py (path:/tmp/pip-BWx5nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:52 INFO - Running setup.py (path:/tmp/pip-1kWK8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:52 INFO - Running setup.py (path:/tmp/pip-4e0qZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:52 INFO - Running setup.py (path:/tmp/pip-iLUge9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:52 INFO - Running setup.py (path:/tmp/pip-7b1YxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:52 INFO - Running setup.py (path:/tmp/pip-SEziNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:52 INFO - Running setup.py (path:/tmp/pip-EX8Jjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:53 INFO - Running setup.py (path:/tmp/pip-xuT89_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:53 INFO - Running setup.py (path:/tmp/pip-HWdnDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:53 INFO - Running setup.py (path:/tmp/pip-u1zwY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:53 INFO - Running setup.py (path:/tmp/pip-JGy4Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:53 INFO - Running setup.py (path:/tmp/pip-2e0VP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:53 INFO - Running setup.py (path:/tmp/pip-qcjBro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:53 INFO - Running setup.py (path:/tmp/pip-jz4TXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:53 INFO - Running setup.py (path:/tmp/pip-AAVd0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:46:53 INFO - Running setup.py install for manifestparser 17:46:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:46:53 INFO - Running setup.py install for mozcrash 17:46:53 INFO - Running setup.py install for mozdebug 17:46:53 INFO - Running setup.py install for mozdevice 17:46:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for mozfile 17:46:54 INFO - Running setup.py install for mozhttpd 17:46:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for mozinfo 17:46:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for mozInstall 17:46:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for mozleak 17:46:54 INFO - Running setup.py install for mozlog 17:46:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for moznetwork 17:46:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:46:54 INFO - Running setup.py install for mozprocess 17:46:54 INFO - Running setup.py install for mozprofile 17:46:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:46:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:46:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:46:55 INFO - Running setup.py install for mozrunner 17:46:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:46:55 INFO - Running setup.py install for mozscreenshot 17:46:55 INFO - Running setup.py install for moztest 17:46:55 INFO - Running setup.py install for mozversion 17:46:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:46:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:46:55 INFO - Cleaning up... 17:46:55 INFO - Return code: 0 17:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:55 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:55 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:46:55 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:46:55 INFO - Using env: {'DISPLAY': ':0', 17:46:55 INFO - 'HOME': '/home/cltbld', 17:46:55 INFO - 'LANG': 'en_US.UTF-8', 17:46:55 INFO - 'LANGUAGE': 'en_US:en', 17:46:55 INFO - 'LOGNAME': 'cltbld', 17:46:55 INFO - 'MAIL': '/var/mail/cltbld', 17:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:55 INFO - 'MOZ_NO_REMOTE': '1', 17:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:55 INFO - 'NO_EM_RESTART': '1', 17:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:55 INFO - 'PWD': '/builds/slave/test', 17:46:55 INFO - 'SHELL': '/bin/bash', 17:46:55 INFO - 'SHLVL': '1', 17:46:55 INFO - 'TERM': 'linux', 17:46:55 INFO - 'TMOUT': '86400', 17:46:55 INFO - 'USER': 'cltbld', 17:46:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:55 INFO - '_': '/tools/buildbot/bin/python'} 17:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:55 INFO - Running setup.py (path:/tmp/pip-AuDpSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:55 INFO - Running setup.py (path:/tmp/pip-ApOaRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:55 INFO - Running setup.py (path:/tmp/pip-OaQRo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:55 INFO - Running setup.py (path:/tmp/pip-a8GafW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:55 INFO - Running setup.py (path:/tmp/pip-4KcuV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:56 INFO - Running setup.py (path:/tmp/pip-R0dZed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:56 INFO - Running setup.py (path:/tmp/pip-KDgmeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:56 INFO - Running setup.py (path:/tmp/pip-bAzFpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:56 INFO - Running setup.py (path:/tmp/pip-ePkbm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:56 INFO - Running setup.py (path:/tmp/pip-1ujlrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:56 INFO - Running setup.py (path:/tmp/pip-IbV_LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:56 INFO - Running setup.py (path:/tmp/pip-Fj10Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:56 INFO - Running setup.py (path:/tmp/pip-5vDR3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:56 INFO - Running setup.py (path:/tmp/pip-bvGZxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:56 INFO - Running setup.py (path:/tmp/pip-XdAbVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:56 INFO - Running setup.py (path:/tmp/pip-m_11NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:56 INFO - Running setup.py (path:/tmp/pip-VKOgh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:58 INFO - Downloading blessings-1.6.tar.gz 17:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:46:59 INFO - Installing collected packages: blessings 17:46:59 INFO - Running setup.py install for blessings 17:46:59 INFO - Successfully installed blessings 17:46:59 INFO - Cleaning up... 17:46:59 INFO - Return code: 0 17:46:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:59 INFO - Reading from file tmpfile_stdout 17:46:59 INFO - Current package versions: 17:46:59 INFO - argparse == 1.2.1 17:46:59 INFO - blessings == 1.6 17:46:59 INFO - blobuploader == 1.2.4 17:46:59 INFO - docopt == 0.6.1 17:46:59 INFO - functools32 == 3.2.3-2 17:46:59 INFO - jsonschema == 2.5.1 17:46:59 INFO - manifestparser == 1.1 17:46:59 INFO - mozInstall == 1.12 17:46:59 INFO - mozcrash == 0.17 17:46:59 INFO - mozdebug == 0.1 17:46:59 INFO - mozdevice == 0.48 17:46:59 INFO - mozfile == 1.2 17:46:59 INFO - mozhttpd == 0.7 17:46:59 INFO - mozinfo == 0.9 17:46:59 INFO - mozleak == 0.1 17:46:59 INFO - mozlog == 3.2 17:46:59 INFO - moznetwork == 0.27 17:46:59 INFO - mozprocess == 0.22 17:46:59 INFO - mozprofile == 0.28 17:46:59 INFO - mozrunner == 6.11 17:46:59 INFO - mozscreenshot == 0.1 17:46:59 INFO - mozsystemmonitor == 0.3 17:46:59 INFO - moztest == 0.7 17:46:59 INFO - mozversion == 1.4 17:46:59 INFO - psutil == 3.1.1 17:46:59 INFO - requests == 1.2.3 17:46:59 INFO - wsgiref == 0.1.2 17:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:59 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:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:59 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:46:59 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:46:59 INFO - Using env: {'DISPLAY': ':0', 17:46:59 INFO - 'HOME': '/home/cltbld', 17:46:59 INFO - 'LANG': 'en_US.UTF-8', 17:46:59 INFO - 'LANGUAGE': 'en_US:en', 17:46:59 INFO - 'LOGNAME': 'cltbld', 17:46:59 INFO - 'MAIL': '/var/mail/cltbld', 17:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:59 INFO - 'MOZ_NO_REMOTE': '1', 17:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:59 INFO - 'NO_EM_RESTART': '1', 17:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:59 INFO - 'PWD': '/builds/slave/test', 17:46:59 INFO - 'SHELL': '/bin/bash', 17:46:59 INFO - 'SHLVL': '1', 17:46:59 INFO - 'TERM': 'linux', 17:46:59 INFO - 'TMOUT': '86400', 17:46:59 INFO - 'USER': 'cltbld', 17:46:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:59 INFO - '_': '/tools/buildbot/bin/python'} 17:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 INFO - Cleaning up... 17:46:59 INFO - Return code: 0 17:46:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:46:59 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:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:59 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:46:59 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:46:59 INFO - Using env: {'DISPLAY': ':0', 17:46:59 INFO - 'HOME': '/home/cltbld', 17:46:59 INFO - 'LANG': 'en_US.UTF-8', 17:46:59 INFO - 'LANGUAGE': 'en_US:en', 17:46:59 INFO - 'LOGNAME': 'cltbld', 17:46:59 INFO - 'MAIL': '/var/mail/cltbld', 17:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:59 INFO - 'MOZ_NO_REMOTE': '1', 17:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:59 INFO - 'NO_EM_RESTART': '1', 17:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:59 INFO - 'PWD': '/builds/slave/test', 17:46:59 INFO - 'SHELL': '/bin/bash', 17:46:59 INFO - 'SHLVL': '1', 17:46:59 INFO - 'TERM': 'linux', 17:46:59 INFO - 'TMOUT': '86400', 17:46:59 INFO - 'USER': 'cltbld', 17:46:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:59 INFO - '_': '/tools/buildbot/bin/python'} 17:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:46:59 INFO - Cleaning up... 17:46:59 INFO - Return code: 0 17:46:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:46:59 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:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:59 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 0x7f229c805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, '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': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', '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:46:59 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:46:59 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:46:59 INFO - Using env: {'DISPLAY': ':0', 17:46:59 INFO - 'HOME': '/home/cltbld', 17:46:59 INFO - 'LANG': 'en_US.UTF-8', 17:46:59 INFO - 'LANGUAGE': 'en_US:en', 17:46:59 INFO - 'LOGNAME': 'cltbld', 17:46:59 INFO - 'MAIL': '/var/mail/cltbld', 17:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:59 INFO - 'MOZ_NO_REMOTE': '1', 17:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:59 INFO - 'NO_EM_RESTART': '1', 17:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:59 INFO - 'PWD': '/builds/slave/test', 17:46:59 INFO - 'SHELL': '/bin/bash', 17:46:59 INFO - 'SHLVL': '1', 17:46:59 INFO - 'TERM': 'linux', 17:46:59 INFO - 'TMOUT': '86400', 17:46:59 INFO - 'USER': 'cltbld', 17:46:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:59 INFO - '_': '/tools/buildbot/bin/python'} 17:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:00 INFO - Downloading/unpacking flake8 17:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:47:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:47:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:02 INFO - no previously-included directories found matching 'docs/_build' 17:47:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:47:03 INFO - Running setup.py install for pep8 17:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:03 INFO - no previously-included directories found matching 'docs/_build' 17:47:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:47:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:47:03 INFO - Cleaning up... 17:47:03 INFO - Return code: 0 17:47:03 INFO - Running post-action listener: _resource_record_post_action 17:47:03 INFO - Running post-action listener: _start_resource_monitoring 17:47:03 INFO - Starting resource monitoring. 17:47:03 INFO - ##### 17:47:03 INFO - ##### Finished create-virtualenv step (success) 17:47:03 INFO - ##### 17:47:03 INFO - ##### 17:47:03 INFO - ##### Running install step. 17:47:03 INFO - ##### 17:47:03 INFO - Running pre-action listener: _resource_record_pre_action 17:47:03 INFO - Running main action method: install 17:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:03 INFO - Reading from file tmpfile_stdout 17:47:03 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:03 INFO - Reading from file tmpfile_stdout 17:47:03 INFO - Output received: 17:47:03 INFO - Usage: mozinstall [options] installer 17:47:03 INFO - Options: 17:47:03 INFO - -h, --help show this help message and exit 17:47:03 INFO - -d DEST, --destination=DEST 17:47:03 INFO - Directory to install application into. [default: 17:47:03 INFO - "/builds/slave/test"] 17:47:03 INFO - --app=APP Application being installed. [default: firefox] 17:47:03 INFO - mkdir: /builds/slave/test/build/application 17:47:03 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:47:03 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:47:20 INFO - Reading from file tmpfile_stdout 17:47:20 INFO - Output received: 17:47:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:20 INFO - Running post-action listener: _resource_record_post_action 17:47:20 INFO - ##### 17:47:20 INFO - ##### Finished install step (success) 17:47:20 INFO - ##### 17:47:20 INFO - ##### 17:47:20 INFO - ##### Running run-tests step. 17:47:20 INFO - ##### 17:47:20 INFO - Running pre-action listener: _resource_record_pre_action 17:47:20 INFO - Running main action method: run_tests 17:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:20 INFO - Python 2.7.3 17:47:20 INFO - Return code: 0 17:47:20 INFO - grabbing minidump binary from tooltool 17:47: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:47:20 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 0x1d6a1c0>, '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 0x1d6b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:20 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:47:20 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:47:20 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:47:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:20 INFO - Return code: 0 17:47:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:47:21 INFO - Return code: 0 17:47:21 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', '--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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:47:21 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 --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-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:47:21 INFO - Using env: {'DISPLAY': ':0', 17:47:21 INFO - 'HOME': '/home/cltbld', 17:47:21 INFO - 'LANG': 'en_US.UTF-8', 17:47:21 INFO - 'LANGUAGE': 'en_US:en', 17:47:21 INFO - 'LOGNAME': 'cltbld', 17:47:21 INFO - 'MAIL': '/var/mail/cltbld', 17:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:21 INFO - 'MOZ_NO_REMOTE': '1', 17:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:21 INFO - 'NO_EM_RESTART': '1', 17:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:21 INFO - 'PWD': '/builds/slave/test', 17:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:21 INFO - 'SHELL': '/bin/bash', 17:47:21 INFO - 'SHLVL': '1', 17:47:21 INFO - 'TERM': 'linux', 17:47:21 INFO - 'TMOUT': '86400', 17:47:21 INFO - 'USER': 'cltbld', 17:47:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573', 17:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:21 INFO - '_': '/tools/buildbot/bin/python'} 17:47:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:47:21 INFO - mozversion application_buildid: 20160606053005 17:47:21 INFO - mozversion application_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 17:47:21 INFO - mozversion application_display_name: Nightly 17:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:21 INFO - mozversion application_name: Firefox 17:47:21 INFO - mozversion application_remotingname: firefox 17:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:47:21 INFO - mozversion application_vendor: Mozilla 17:47:21 INFO - mozversion application_version: 49.0a1 17:47:21 INFO - mozversion platform_buildid: 20160606053005 17:47:21 INFO - mozversion platform_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 17:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:47:21 INFO - mozversion platform_version: 49.0a1 17:47:21 INFO - using testdate: 1465260441 17:47:21 INFO - actual date: 1465260441 17:47:21 INFO - starting webserver on 'localhost:51160' 17:47:21 INFO - SUITE-START | Running 2 tests 17:47:21 INFO - TEST-START | dromaeo_css 17:47:21 INFO - operating with platform_type : linux_ 17:47:21 INFO - Initialising browser for dromaeo_css test... 17:47:21 INFO - TEST-INFO | started process 22413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiiskFD/profile http://localhost:51160/getInfo.html) 17:47:25 INFO - PROCESS | 22413 | __metrics Screen width/height:1600/1200 17:47:25 INFO - PROCESS | 22413 | colorDepth:24 17:47:25 INFO - PROCESS | 22413 | Browser inner width/height: 1024/697 17:47:25 INFO - PROCESS | 22413 | __metrics 17:47:26 ERROR - PROCESS | 22413 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:47:26 INFO - PROCESS | 22413 | console.error: PushService: 17:47:26 INFO - PROCESS | 22413 | stateChangeProcessEnqueue: Error transitioning state 17:47:26 INFO - PROCESS | 22413 | UnknownError 17:47:27 INFO - TEST-INFO | 22413: exit 0 17:47:27 INFO - Browser initialized. 17:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:27 INFO - TEST-INFO | started process 22492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiiskFD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:39 INFO - PROCESS | 22492 | RSS: Main: 156438528 17:47:39 INFO - PROCESS | 22492 | 17:48:30 INFO - PROCESS | 22492 | 1465260510343 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:50:37 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51160/tests/dromaeo/cssquery-ext.html) 17:50:38 INFO - PROCESS | 22492 | RSS: Main: 242192384 17:50:38 INFO - PROCESS | 22492 | 17:53:41 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-ext.html (next: http://localhost:51160/tests/dromaeo/cssquery-jquery.html) 17:53:41 INFO - PROCESS | 22492 | RSS: Main: 241192960 17:53:41 INFO - PROCESS | 22492 | 17:56:43 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51160/tests/dromaeo/cssquery-mootools.html) 17:56:44 INFO - PROCESS | 22492 | RSS: Main: 239091712 17:56:44 INFO - PROCESS | 22492 | 17:59:46 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51160/tests/dromaeo/cssquery-prototype.html) 17:59:47 INFO - PROCESS | 22492 | RSS: Main: 235896832 17:59:47 INFO - PROCESS | 22492 | 18:02:49 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51160/tests/dromaeo/cssquery-yui.html) 18:02:50 INFO - PROCESS | 22492 | RSS: Main: 211783680 18:02:50 INFO - PROCESS | 22492 | 18:05:52 INFO - PROCESS | 22492 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-yui.html (next: http://localhost:51160/tests/dromaeo/cssquery-dojo.html) 18:05:53 INFO - PROCESS | 22492 | RSS: Main: 316772352 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | __start_tp_report 18:05:53 INFO - PROCESS | 22492 | _x_x_mozilla_page_load 18:05:53 INFO - PROCESS | 22492 | _x_x_mozilla_page_load_details 18:05:53 INFO - PROCESS | 22492 | |i|pagename|runs| 18:05:53 INFO - PROCESS | 22492 | |0;dojo.html;3083.383323335333;3099.767517436193;3114.7975381600195;3137.9843100784506;3146.276356438018;5284.365876094874;5309.070912590296;5391.353037635485;5405.108157154064;5452.509274165324;5325.920111198326;5338.199270109486;5423.701696406696;5444.428335024825;5502.58730595206;4756.524347565241;4862.34358361622;4871.732054736988;4881.389826271716;5025.824096156635;4874.497641532952;4892.168331383656;4912.508749125094;4932.580730637882;4948.7278199699;4744.952550474485;4766.785494652749;4782.0435912817575;4786.1863483207935;4789.473157952622;4773.594244489223;4806;4858.028394321114;4877.46347901734;4902.877428064291;4805.567498925078;4811.278308253755;4811.879703007417;4824.2040063389495;4872.196087645534;5192.636515443921;5225.686458812484;5313.628046036779;5338.652987555835;5351.197320401932;5759.5968282220265;5817.156512305692;5817.447342502455;5818.2145410369485;5818.359980402152;5868.383819698913;5877.794277200277;5881.470667639933;5887.205227294303;5887.970560147171;5223.451537588575;5302.496262855023;5322.893542129135;5334.839954801401;5411.756470958816;5963.016102343152;5965.612235204698;5993.760249589967;6000.129981152709;6001.939980600226;5576.665400075927;5743.253377061039;5746.281714785652;5750;5757.654540727486;5678.403767604342;5707.086866101404;5707.143928410772;5732.598718089777;5735.053716136874;5658.179563963285;5685.744141513642;5694.97152514243;5705.800296989669;5710.343310519261;5627.43725627434;5671.461211184931;5679.403662615448;5728;5732.369439361667;4321.827126914951;4337.284348082531;4337.674674399433;4386.298192289219;4393.143337049245;3882.728209025341;3885.320068987916;3897.5517815451585;3898.766074035567;3922.980385098056;5402.216678581583;5451.318585176853;5500.889982200333;5524.392316845144;5572.219889215513;5673.1490276458035;5727.8568035799435;5733.426657334317;5751.798687045934;5782.479576838105;5407.702576358338;5415.566754659618;5426.131818909034;5449.237106805051;5456.48163424474;4752.904941901143;4787.880302992384;4819.180739274261;4824.758762061883;4829.758512074382;5871.794487193013;5917.31950825652;5921.319048309413;5922.3485416604135;5977.163197152402;5730.312362516524;5730.914036289376;5731.02572562657;5735.36910939788;5737.942620573741;5889.823305300848;5906.645601263938;5925.85185370352;5957.285125784933;6003.87992240144;5745.798897038583;5759.308882934075;5760.8271751847515;5768.567357448124;5793.652380857162;5810.796622118206;5811.4479124483105;5869.031609784509;5878.853028674317;5880.500157486662;5616.634918730269;5624.943750562442;5642.097264437671;5658.094704847204;5753.769849205984;5610.102383618601;5616.269884914935;5617.297837770278;5620.971895140498;5622.156676498558;5490.835274941758;5494.780208791603;5496.0931446310915;5498.092814685692;5540.584456165884;5569.526590239875;5593.916091258553;5595.160725891149;5616.382197958303;5719.48524632785;5497.972510137423;5502.944970550243;5503.091989821794;5514.476124768141;5561.054620714407 18:05:53 INFO - PROCESS | 22492 | |1;ext.html;591.5563327504372;609.8109586028331;623.1338439569003;633.9144215530902;640.6220330005298;30710.385792284167;31466.370672586563;44203.33694994578;45413.545864541346;45503.54496455035;43150;47261.76369118158;47313;47362;47408;8681.999999999984;8873.68942087027;8873.911260887373;8882.955585222066;8889.288856891466;8681.95659021704;8769.868451973194;8808.383413161082;8813.64745410186;8818.338624603148;8827.646894124227;8877.156670116361;8891.555422228896;8901.243394311492;8901.332400069989;8788.209061184492;8838.646454141826;8841.734747957604;8843.823123537557;8857.557122143931;8659.134086591353;8692.608832602547;8742.08208138149;8751.43115697484;8753.649854005833;43701.34447983283;43913;44014;44067.33898991485;44227.77886110581;3399.7960122392738;3422.8117453540294;3598.082488965323;3894.2990261753157;3927.960720392788;32409.83795081033;32753.34493310144;33184.50223246653;33334.49998250028;33970.49044264338;4285.35719642053;4294.3558466230315;4333.285007973681;4338.240807858612;4364.2798938175165;352135.23932380433;352254;353328;354598;354659;51690;58989.41010589925;59829.40170598238;59895;61089.38910610837;62914;63517;63728;63800;63876.36123638704;16361.91819040921;16569.088700121367;16582.75125873113;16595.83404165967;16597.41909033178;11381.089512838953;12269.509219631293;12494.437750301258;12581.622551323475;12591.874081259253;17112;17112.828871711372;17139.485815425556;17188;17218.913905430392;5892.204552385459;5931.169636250928;5993.130996005642;6002.248594628357;6085.726142323606;1008.8486726990864;1054.7995880782628;1063.1282348474176;1086.6142519405655;1087.907527860125;32994.67005329964;33119.337613248084;33210.17344046052;33341.16647083842;33998.320033599186;1081.3565928272665;1096.4736926275273;1133.2237417369129;1140.1961617059953;1157.0338767129374;16805.495835124966;17646.294148234185;17665.433987296794;17759.467215983543;17846.286148554173;557371;557505;566941;571230;869428;60305;60462.69768651129;60882.39117608856;60919.390806092255;60937.39062609406;1282.5190553542423;1320.6170210638807;1385.6466601016878;1388.0908005256574;1419.5741277616673;29385.412291754474;33667.15832104217;33701.662983370836;33742.49386259159;33816.83091584625;47959.28061079017;47984.760076199396;48341.34122623289;48414.27378589253;48437;377860;380063;381627;382872.5414712578;383002;24334.63498047566;26945.865270673523;27234.5914811274;27787.305317367227;27921;48134.518654813;48189.75905120452;48895.51104489052;49015.26477102918;49602.75198623984;40739.185216294914;40963.38554921619;41365.58634413617;41613.79193104015;42388.78805605952;38764.6123538761;39206.411903820896;39273;39400.211995760495;39499;40573.95695322804;41573.792131039154;42440.787796060824;42519.78740106404;45253;35890.4616430759;38168.61831381651;38229;38894.4165837507;39125.6087439122;28695.71304287014;29217;29228;29292.853535732185;29541.55687664644 18:05:53 INFO - PROCESS | 22492 | |2;jquery.html;386.9767813931166;389.2526349409134;391.92357490289396;393.65358484533607;410.0855093142293;14040.929795351009;17765.46703598891;18307.084645767707;20105.899470502645;20151.697724534126;15510.844891551082;16258.430954916581;17752.644947101082;18394.172262248198;18769.343072992448;5467.917981230285;5784.2480477537865;5795.333536643277;5798.65208087514;5799.594028418012;4244.405783190356;5724.885502289952;5793.5365170786445;5795.739191736361;6169.876602467948;6472.870542589146;6536.640484773336;6561.114249576318;6600.867982640344;6601.438877695402;6320.93679063208;6536.60780353178;6567.080608714784;6580.177477815249;6588.4729221662155;5604.8318550443555;5776.653400795965;5802.477777000048;5805.970970145165;5827.592068555203;22941.885290573442;23548.88225558861;23821.642675359883;23868.522629547486;23872;2351.6354964980455;2396.424858034059;2558.795296376304;2602.4925139597785;2940.882364705409;14629.487967921179;14739.631509212248;14903.32935017916;15007.774883376758;15112.244387780567;1908.9904550477297;1969.901504924748;2010.4772759082744;2026.189524190321;2042.1627132875599;84209;84737.57631211866;85141;85854.57072714597;87105.12894871033;10559.832050385008;10632.893671063344;10702.518386672462;10936.890631093587;11111.666650000512;15156.31796569157;15407.229638518029;15407.537773866801;15411.691766164615;15436.922815385851;7991.520508769492;8297.294729947902;8345.499270043816;8462.61918213682;8514.57427128641;8003.439759216915;8133.511989280544;8149.918500815034;8278.30954939647;8285.461445006054;5771.942280577225;6172.321044685081;6372.394622510854;6525.151730275129;6655.700493477805;1895.175598614607;1911.9808801911802;1935.5161209697576;1952.6094781043564;1988.602279544097;922.064104933493;1018.1549314069453;1049.024407301202;1089.5750657243682;1091.5845405335438;18490.075496225403;19731.50671233202;20790.58418831645;20921;20989.265375711777;1018.1549314069453;1027.429776474049;1030.5465595138114;1097.2045267181388;1114.1087130295894;10542.525586348633;11334.206605537533;11351.432428378548;11813.940930295294;11844.230125041844;487941;491719;496653;497840;501023;92160.53919730359;96749;98152.50923745336;98374.5081274589;100618;931.9673811416703;968.0271327316002;1027.6043723166636;1042.5048102151418;1055.6674647486018;16504.75242871382;16532.338706451606;17159.399421020204;17843.643127137646;18327.175277112296;38084.238315232986;39146.608533914296;40179.39730903981;43607.78196108999;44245;55665;56592.43407566036;57764.71117644385;59036.40963590481;59215.70392148012;6049.546284028804;7557.130929943127;8534.274586660204;8561;8753.124687531195;11905.761884762429;13243.536476223671;13299.734005319646;13338.466461341437;13421.328933553088;11465.541378345106;11683.941580292045;11688.649340519798;11792.174547781917;11983.64049078529;11531;11639.243449175776;11720.824187637363;11817.82273265919;11978.101642376681;11672.249162625674;11829.76340473203;12068.396580171131;12139;12158.878411215775;8507.702230421906;8623.396362254582;8650.895971376918;8758.167974042455;8855.893013373328;11359.943200283946;11744.70638234051;11810.232334898204;11942.34317112567;12164.452599633214 18:05:53 INFO - PROCESS | 22492 | |3;mootools.html;1272.147661067085;1485.8662720355169;1509.5471358592422;1675.4554769699844;1794.703873860813;8202.589870506474;8624.655013799449;8645.69740059098;8854.513001784899;8855.601497932592;8502;8742.344324175681;8764.737057888258;8778.736637900858;8794.91205087949;1980.4256765537978;2031.6241495323338;2033.7356143701372;2345.589521833681;2375.904963801446;2312.8034117100065;2361.3506285771377;2372.6441033844976;2402.3633737059695;2406.639004149374;2342.917997870075;2349.800266977309;2370.928872133839;2374.050379848057;2375.798057165143;1959.706044093383;2022.4236092713654;2267.4444761033487;2294.8737819419925;2296.7473577906417;2004.368623883472;2227.988860055689;2270.67075274086;2271.216430331533;2290.335802617239;8260.628271727786;8309.750707478785;8311.667533298662;8312.33501319893;8313.1271216522;5057.898842023139;5116.641835071547;5174.870628234286;5185.585153187773;5191.247269145991;3217.871285148591;3293.275479394529;3357.7145942594907;3375.831208439593;3433.2790114076074;1114.921955463118;1115.380963565221;1143.6226045404997;1167.64970508847;1172.0564945219096;12000.21998570099;12033.51865925362;12035.759284814343;12038.638840834788;12052.156349055569;4392.5607439256455;4583.220852455091;4651.232546629836;4717.764111794465;4726.432828060586;10128.59485620567;10183.18534517237;10185.064837680817;10189.643362482426;10198.388096714072;5074.644774865724;5082.1360368737405;5095.1847704367865;5098.133317336062;5100.1074811907765;4066.471358723347;4507.797149128297;4640.6751527393435;4688.859334219979;4840.273958906192;3862.343401621731;3862.6716729078344;3945.408188771707;3991.7604943703473;4023.456833327522;1169.3626973299572;1188.3285943441927;1216.3431746856775;1242.1491278474275;1248.1387842388722;941.0824446165071;946;955.9474228917476;958.9376690515094;970.8932017478072;5915.733791979371;6017.368176341509;6092.421219984094;6192.628442293477;6205.565610407319;480.68034756886277;483.09660934053545;486.79797883877796;1056.1709058389129;1072.3512275073467;3986.60133986599;4095.28332541804;4096.713230073926;4253.680973926967;4284.228838808982;9831.754206144904;10235.692929212135;10250.026247506625;10251.48742562869;10267.435291058913;10144.036316549917;10156.949215253877;10169.644062457779;10175.84736228957;10176.745581360377;7883.448158628956;7990.760277191694;8004.119546849842;8034.638441270157;8036.919630803734;5768.653880767168;5907.763689452546;5938.287405511366;6077.058056001327;6328.493720502441;9689.70930872075;9854.458004809805;10051.949740251252;10057.949710251401;10114.595416183565;10180.694579162637;10189.74525636865;10261.486925653837;10285.53715082838;10297.07326340633;6541.70562324687;7191.640417979184;7481.438892083007;7625.351845093229;7637;8415.663373465237;8424.915750842412;8483.36374771907;8520.105388934073;8524.104968978168;7470.701171953278;7519;7604.771856844303;7723.189065148079;7766.417518686008;7272.96363518179;7420.220876807857;7447.553146810992;7579.355754760686;7595.202503737028;6977.79066628002;7008.789736307919;7049.859002820018;7056.470764692771;7058.188308344606;5222.242774797557;5240.213967904845;5384.407715151252;5422.403535611001;5441.102218133963;4799.640026997919;4955.45489996093;4968.155413579772;4971.751412429292;4978.5270399312 18:05:53 INFO - PROCESS | 22492 | |4;prototype.html;326.56566766200956;331.42497766375334;340.5062659144241;343.585978895431;344.51595508310834;5297.576193904488;5312.92030619541;5330.733463326833;5342;5412;5310.495502927216;5339.492748188916;5356.196570514425;5374.516293533581;5382.865428364293;3933.960660393388;4198.895027624311;4208;4219.185750127444;4223.113146239278;4162.627302437611;4174.499060112791;4192.9790351048205;4209.915801683965;4212.873613791591;4151.315033019563;4158.230727315441;4164.583541645827;4178.164367126572;4185.723354376929;3897.376419772837;3999.6000399959917;4111.958880411187;4136.338185890243;4138.937915931264;3616.716065796657;3625.4199328107375;3626.34725749365;3632.473291372736;3651.4887915691825;4881.8535443936735;5035.79856805731;5150.639455238135;5161.406438259573;5165.638405311592;4546.29532422475;4692.920628255486;4708.634495996192;4721.244600863845;4725.149473094842;5467.289252397163;5482.259894914176;5487.122060470306;5490.6431081979945;5503.889922201533;3797.905052373685;3945.230680017398;3946.7039972002217;3994.2810294147043;4003.4195041718785;5765.769369225226;5779.88440231193;5790;5811.854703632401;5815.883682326372;4056.472658554369;4088.448059511928;4088.672906167559;4098.4876890388705;4112.670986321087;4160.54234034256;4161.2301724181125;4178.498580170338;4179.623833854967;4182.786991772352;4566.543345665474;4693.155232058194;4693.873470367155;4702;4742.193827049341;5565.495527012779;5569.164625306236;5594.13290939905;5598.608097433222;5652.547796176296;1406.1352268355092;1406.8171137752026;1427.4932398998415;1431.2843578210895;1431.4775107086048;892.9866052009226;909.3543584055395;919.3794188922451;926.6979893249994;930.3115694386106;4839.540243676845;4889.315495830587;4896.4124305083615;4950.9009819803405;4980.302757613937;4842.322074909515;5073.441921388644;5077.26379674945;5079.466656001066;5108.642395032386;4856.757162141878;5171.689698618095;5303.416624171338;5403.9459605403445;5408.648437851606;3020.7130322619314;3037.6962303769446;3052.359004609057;3053.4656435123766;3069.017914267413;5631;5832.533397328203;5864.530837532987;5873;5878.412828536271;5800.8259752207505;5831.88336233273;5833.4749872511675;5837.3870743571315;5837.532997360201;5883.970580147157;5884.764609415661;5886.499647530008;5889.911651325147;5901;5478.315210598676;5701.4298570142655;5766;5784.07904008473;5814.825555233349;5692.857678558069;5719.799807006735;5723.969685456658;5750.367459579359;5760.567957403296;5733.283339582552;5942.405759424023;5944.64332140073;5956.426144313377;5986.431289027535;4069.593040695907;4070.2266569351727;4072.124493233969;4074.7555146691293;4094.2016306819883;5825.242718446575;5867.266591676041;5889.38161493037;5897.852553686193;5918.467337939606;5451.264079349237;5616.410276920865;5660.915086273627;5732.426757324234;5737.454941780524;5629.971850140887;5640.830775076754;5657.4059723728415;5667.659940403424;5673.461021202979;5500.862478438071;5517.200005999028;5536;5537.750801214036;5557.888842223052;5552.583556233218;5687.402822703557;5689.971550142222;5706.714664266853;5718.170865224436;5237.319148510669;5521.806736764194;5525.696086715269;5529.695866727207;5568.303962004749 18:05:53 INFO - PROCESS | 22492 | |5;yui.html;648.28688442713;703.6727921516493;740.6148802622637;755.1994885421452;833.6415341403198;14730.558083257505;15888;15906.443274485395;15915.761263581055;15924.442644507415;13056.543020994268;13170.143940643875;13190.208587484758;13756.793648095287;13853.238071906042;670.1957650819037;776.9261920117608;794.0590400375559;797.2505844506146;800.2717527050386;800.2117913854848;811.7848770075934;811.8457493076326;811.8619834628128;812.3907069697726;841.0748177005275;841.7348535211389;843.5191940593834;844.0209357145712;844.1558441558442;691.3846676457956;805.5770720371793;830.4353039932844;834.1533343656164;836.3267569606464;611.7858749437705;612.4059662127773;613.6318209074565;613.7575657615217;613.7790395457631;13981.720365592631;14058.507952221726;14150.504732334319;14198.858011419858;14207.431702731878;14081.5071472499;14746.852531474655;14778.704425911528;14804.851951480456;14933;12685.36573171347;12885.549005784753;13032.934835325763;13059.542915997894;13081;4517.2094883395275;4582.6104781093645;4584.15193189261;4584.88537786558;4593.862184134481;61986.69006654938;65446;65554.0166897497;74958;75086;10719.892801072045;11033.448327583588;11841.585544506073;11863.88136118645;12054.890394180984;19353.903230483756;19565.315213967442;19624.313149039714;19637.410877673694;19641.41075767729;8295.502269863828;8306.916930830736;8776.122387761172;8906.332025098143;9232.307576931757;4824.396950381202;4907.092187945242;5001.924971125436;5003.724795136302;5025.346704928336;3344.3311337732553;3444.1389652586854;3475.6350583188905;3479.6520347965507;3492.2491664292297;509.9209622508517;621.3972446726668;627.5136769004058;643.3919945651409;645.6707079389452;610.8228613701976;654.1888058807045;661.4014317043084;703.5040296590892;731.8609464201785;9871.259655525864;10021.949890250502;10040.497975101216;10194.286399951932;10238.744031399274;632.7500637248261;643.3823529411724;649.0297005976001;649.3474058571106;650.5738741124571;4738.3129446230105;4769.35613692154;4775.474697783241;4833.3958255218095;4878.780454879539;71562.64218678873;73178.63410682912;118179;119165.8083419172;124536.37731811283;63625.68187159034;63904.36095638984;66855.66572167107;101514;101821.49089254506;88359;92069;92074.53962730277;94654.58018129734;94912.52543737376;9161.86257206129;9372.484513351832;9413.623455061721;9461.148496635336;9479.857802133112;53328.4667153339;53533.464665354404;54879;54905.45094549003;55862.16206756983;65526.43025342899;67014;74894;80255;80283;13198.60404187876;13549.59351219465;13595.86404135946;13611.795823062464;13618.863811362156;14987.700245995236;15150.242487875783;15195.086166164994;15760.527184184493;15771;9136.908630913606;14244.931630127574;14451.78322325187;14497.20265385414;14614.926925365306;13653.795193071914;14288.142711437347;14436.639084022983;14554.781678275047;14964.102153870803;13316.933415332862;13681.452741890611;14037.719245615235;14570.125792452487;14714.19071951053;11759.353235572125;11893.524259029542;12015.399230038638;12237.449314781034;12321.383930803604;12174.695632609255;12347.581434884518;12449.875501244871;12572.371381431074;12575.371231438574 18:05:53 INFO - PROCESS | 22492 | __end_tp_report 18:05:53 INFO - PROCESS | 22492 | __start_cc_report 18:05:53 INFO - PROCESS | 22492 | _x_x_mozilla_cycle_collect,979 18:05:53 INFO - PROCESS | 22492 | __end_cc_report 18:05:53 INFO - PROCESS | 22492 | __startTimestamp1465261553121__endTimestamp 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | ------- Summary: start ------- 18:05:53 INFO - PROCESS | 22492 | Number of tests: 6 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#0] dojo.html Cycles:165 Average:5334.55 Median:5540.58 stddev:624.95 (11.3%) stddev-sans-first:601.40 18:05:53 INFO - PROCESS | 22492 | Values: 3083.4 3099.8 3114.8 3138.0 3146.3 5284.4 5309.1 5391.4 5405.1 5452.5 5325.9 5338.2 5423.7 5444.4 5502.6 4756.5 4862.3 4871.7 4881.4 5025.8 4874.5 4892.2 4912.5 4932.6 4948.7 4745.0 4766.8 4782.0 4786.2 4789.5 4773.6 4806.0 4858.0 4877.5 4902.9 4805.6 4811.3 4811.9 4824.2 4872.2 5192.6 5225.7 5313.6 5338.7 5351.2 5759.6 5817.2 5817.4 5818.2 5818.4 5868.4 5877.8 5881.5 5887.2 5888.0 5223.5 5302.5 5322.9 5334.8 5411.8 5963.0 5965.6 5993.8 6000.1 6001.9 5576.7 5743.3 5746.3 5750.0 5757.7 5678.4 5707.1 5707.1 5732.6 5735.1 5658.2 5685.7 5695.0 5705.8 5710.3 5627.4 5671.5 5679.4 5728.0 5732.4 4321.8 4337.3 4337.7 4386.3 4393.1 3882.7 3885.3 3897.6 3898.8 3923.0 5402.2 5451.3 5500.9 5524.4 5572.2 5673.1 5727.9 5733.4 5751.8 5782.5 5407.7 5415.6 5426.1 5449.2 5456.5 4752.9 4787.9 4819.2 4824.8 4829.8 5871.8 5917.3 5921.3 5922.3 5977.2 5730.3 5730.9 5731.0 5735.4 5737.9 5889.8 5906.6 5925.9 5957.3 6003.9 5745.8 5759.3 5760.8 5768.6 5793.7 5810.8 5811.4 5869.0 5878.9 5880.5 5616.6 5624.9 5642.1 5658.1 5753.8 5610.1 5616.3 5617.3 5621.0 5622.2 5490.8 5494.8 5496.1 5498.1 5540.6 5569.5 5593.9 5595.2 5616.4 5719.5 5498.0 5502.9 5503.1 5514.5 5561.1 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#1] ext.html Cycles:180 Average:61408.11 Median:41469.69 stddev:126600.77 (305.3%) stddev-sans-first:126873.58 18:05:53 INFO - PROCESS | 22492 | Values: 591.6 609.8 623.1 633.9 640.6 30710.4 31466.4 44203.3 45413.5 45503.5 43150.0 47261.8 47313.0 47362.0 47408.0 8682.0 8873.7 8873.9 8883.0 8889.3 8682.0 8769.9 8808.4 8813.6 8818.3 8827.6 8877.2 8891.6 8901.2 8901.3 8788.2 8838.6 8841.7 8843.8 8857.6 8659.1 8692.6 8742.1 8751.4 8753.6 43701.3 43913.0 44014.0 44067.3 44227.8 3399.8 3422.8 3598.1 3894.3 3928.0 32409.8 32753.3 33184.5 33334.5 33970.5 4285.4 4294.4 4333.3 4338.2 4364.3 352135.2 352254.0 353328.0 354598.0 354659.0 51690.0 58989.4 59829.4 59895.0 61089.4 62914.0 63517.0 63728.0 63800.0 63876.4 16361.9 16569.1 16582.8 16595.8 16597.4 11381.1 12269.5 12494.4 12581.6 12591.9 17112.0 17112.8 17139.5 17188.0 17218.9 5892.2 5931.2 5993.1 6002.2 6085.7 1008.8 1054.8 1063.1 1086.6 1087.9 32994.7 33119.3 33210.2 33341.2 33998.3 1081.4 1096.5 1133.2 1140.2 1157.0 16805.5 17646.3 17665.4 17759.5 17846.3 557371.0 557505.0 566941.0 571230.0 869428.0 60305.0 60462.7 60882.4 60919.4 60937.4 1282.5 1320.6 1385.6 1388.1 1419.6 29385.4 33667.2 33701.7 33742.5 33816.8 47959.3 47984.8 48341.3 48414.3 48437.0 377860.0 380063.0 381627.0 382872.5 383002.0 24334.6 26945.9 27234.6 27787.3 27921.0 48134.5 48189.8 48895.5 49015.3 49602.8 40739.2 40963.4 41365.6 41613.8 42388.8 38764.6 39206.4 39273.0 39400.2 39499.0 40574.0 41573.8 42440.8 42519.8 45253.0 35890.5 38168.6 38229.0 38894.4 39125.6 28695.7 29217.0 29228.0 29292.9 29541.6 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#2] jquery.html Cycles:180 Average:29583.18 Median:23685.26 stddev:81739.46 (345.1%) stddev-sans-first:81939.37 18:05:53 INFO - PROCESS | 22492 | Values: 387.0 389.3 391.9 393.7 410.1 14040.9 17765.5 18307.1 20105.9 20151.7 15510.8 16258.4 17752.6 18394.2 18769.3 5467.9 5784.2 5795.3 5798.7 5799.6 4244.4 5724.9 5793.5 5795.7 6169.9 6472.9 6536.6 6561.1 6600.9 6601.4 6320.9 6536.6 6567.1 6580.2 6588.5 5604.8 5776.7 5802.5 5806.0 5827.6 22941.9 23548.9 23821.6 23868.5 23872.0 2351.6 2396.4 2558.8 2602.5 2940.9 14629.5 14739.6 14903.3 15007.8 15112.2 1909.0 1969.9 2010.5 2026.2 2042.2 84209.0 84737.6 85141.0 85854.6 87105.1 10559.8 10632.9 10702.5 10936.9 11111.7 15156.3 15407.2 15407.5 15411.7 15436.9 7991.5 8297.3 8345.5 8462.6 8514.6 8003.4 8133.5 8149.9 8278.3 8285.5 5771.9 6172.3 6372.4 6525.2 6655.7 1895.2 1912.0 1935.5 1952.6 1988.6 922.1 1018.2 1049.0 1089.6 1091.6 18490.1 19731.5 20790.6 20921.0 20989.3 1018.2 1027.4 1030.5 1097.2 1114.1 10542.5 11334.2 11351.4 11813.9 11844.2 487941.0 491719.0 496653.0 497840.0 501023.0 92160.5 96749.0 98152.5 98374.5 100618.0 932.0 968.0 1027.6 1042.5 1055.7 16504.8 16532.3 17159.4 17843.6 18327.2 38084.2 39146.6 40179.4 43607.8 44245.0 55665.0 56592.4 57764.7 59036.4 59215.7 6049.5 7557.1 8534.3 8561.0 8753.1 11905.8 13243.5 13299.7 13338.5 13421.3 11465.5 11683.9 11688.6 11792.2 11983.6 11531.0 11639.2 11720.8 11817.8 11978.1 11672.2 11829.8 12068.4 12139.0 12158.9 8507.7 8623.4 8650.9 8758.2 8855.9 11359.9 11744.7 11810.2 11942.3 12164.5 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#3] mootools.html Cycles:180 Average:5674.54 Median:4703.31 stddev:3206.72 (68.2%) stddev-sans-first:3198.65 18:05:53 INFO - PROCESS | 22492 | Values: 1272.1 1485.9 1509.5 1675.5 1794.7 8202.6 8624.7 8645.7 8854.5 8855.6 8502.0 8742.3 8764.7 8778.7 8794.9 1980.4 2031.6 2033.7 2345.6 2375.9 2312.8 2361.4 2372.6 2402.4 2406.6 2342.9 2349.8 2370.9 2374.1 2375.8 1959.7 2022.4 2267.4 2294.9 2296.7 2004.4 2228.0 2270.7 2271.2 2290.3 8260.6 8309.8 8311.7 8312.3 8313.1 5057.9 5116.6 5174.9 5185.6 5191.2 3217.9 3293.3 3357.7 3375.8 3433.3 1114.9 1115.4 1143.6 1167.6 1172.1 12000.2 12033.5 12035.8 12038.6 12052.2 4392.6 4583.2 4651.2 4717.8 4726.4 10128.6 10183.2 10185.1 10189.6 10198.4 5074.6 5082.1 5095.2 5098.1 5100.1 4066.5 4507.8 4640.7 4688.9 4840.3 3862.3 3862.7 3945.4 3991.8 4023.5 1169.4 1188.3 1216.3 1242.1 1248.1 941.1 946.0 955.9 958.9 970.9 5915.7 6017.4 6092.4 6192.6 6205.6 480.7 483.1 486.8 1056.2 1072.4 3986.6 4095.3 4096.7 4253.7 4284.2 9831.8 10235.7 10250.0 10251.5 10267.4 10144.0 10156.9 10169.6 10175.8 10176.7 7883.4 7990.8 8004.1 8034.6 8036.9 5768.7 5907.8 5938.3 6077.1 6328.5 9689.7 9854.5 10051.9 10057.9 10114.6 10180.7 10189.7 10261.5 10285.5 10297.1 6541.7 7191.6 7481.4 7625.4 7637.0 8415.7 8424.9 8483.4 8520.1 8524.1 7470.7 7519.0 7604.8 7723.2 7766.4 7273.0 7420.2 7447.6 7579.4 7595.2 6977.8 7008.8 7049.9 7056.5 7058.2 5222.2 5240.2 5384.4 5422.4 5441.1 4799.6 4955.5 4968.2 4971.8 4978.5 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#4] prototype.html Cycles:180 Average:4669.81 Median:5311.71 stddev:1377.47 (25.9%) stddev-sans-first:1342.20 18:05:53 INFO - PROCESS | 22492 | Values: 326.6 331.4 340.5 343.6 344.5 5297.6 5312.9 5330.7 5342.0 5412.0 5310.5 5339.5 5356.2 5374.5 5382.9 3934.0 4198.9 4208.0 4219.2 4223.1 4162.6 4174.5 4193.0 4209.9 4212.9 4151.3 4158.2 4164.6 4178.2 4185.7 3897.4 3999.6 4112.0 4136.3 4138.9 3616.7 3625.4 3626.3 3632.5 3651.5 4881.9 5035.8 5150.6 5161.4 5165.6 4546.3 4692.9 4708.6 4721.2 4725.1 5467.3 5482.3 5487.1 5490.6 5503.9 3797.9 3945.2 3946.7 3994.3 4003.4 5765.8 5779.9 5790.0 5811.9 5815.9 4056.5 4088.4 4088.7 4098.5 4112.7 4160.5 4161.2 4178.5 4179.6 4182.8 4566.5 4693.2 4693.9 4702.0 4742.2 5565.5 5569.2 5594.1 5598.6 5652.5 1406.1 1406.8 1427.5 1431.3 1431.5 893.0 909.4 919.4 926.7 930.3 4839.5 4889.3 4896.4 4950.9 4980.3 4842.3 5073.4 5077.3 5079.5 5108.6 4856.8 5171.7 5303.4 5403.9 5408.6 3020.7 3037.7 3052.4 3053.5 3069.0 5631.0 5832.5 5864.5 5873.0 5878.4 5800.8 5831.9 5833.5 5837.4 5837.5 5884.0 5884.8 5886.5 5889.9 5901.0 5478.3 5701.4 5766.0 5784.1 5814.8 5692.9 5719.8 5724.0 5750.4 5760.6 5733.3 5942.4 5944.6 5956.4 5986.4 4069.6 4070.2 4072.1 4074.8 4094.2 5825.2 5867.3 5889.4 5897.9 5918.5 5451.3 5616.4 5660.9 5732.4 5737.5 5630.0 5640.8 5657.4 5667.7 5673.5 5500.9 5517.2 5536.0 5537.8 5557.9 5552.6 5687.4 5690.0 5706.7 5718.2 5237.3 5521.8 5525.7 5529.7 5568.3 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - PROCESS | 22492 | [#5] yui.html Cycles:180 Average:19985.55 Median:4799.94 stddev:27964.75 (582.6%) stddev-sans-first:28005.50 18:05:53 INFO - PROCESS | 22492 | Values: 648.3 703.7 740.6 755.2 833.6 14730.6 15888.0 15906.4 15915.8 15924.4 13056.5 13170.1 13190.2 13756.8 13853.2 670.2 776.9 794.1 797.3 800.3 800.2 811.8 811.8 811.9 812.4 841.1 841.7 843.5 844.0 844.2 691.4 805.6 830.4 834.2 836.3 611.8 612.4 613.6 613.8 613.8 13981.7 14058.5 14150.5 14198.9 14207.4 14081.5 14746.9 14778.7 14804.9 14933.0 12685.4 12885.5 13032.9 13059.5 13081.0 4517.2 4582.6 4584.2 4584.9 4593.9 61986.7 65446.0 65554.0 74958.0 75086.0 10719.9 11033.4 11841.6 11863.9 12054.9 19353.9 19565.3 19624.3 19637.4 19641.4 8295.5 8306.9 8776.1 8906.3 9232.3 4824.4 4907.1 5001.9 5003.7 5025.3 3344.3 3444.1 3475.6 3479.7 3492.2 509.9 621.4 627.5 643.4 645.7 610.8 654.2 661.4 703.5 731.9 9871.3 10021.9 10040.5 10194.3 10238.7 632.8 643.4 649.0 649.3 650.6 4738.3 4769.4 4775.5 4833.4 4878.8 71562.6 73178.6 118179.0 119165.8 124536.4 63625.7 63904.4 66855.7 101514.0 101821.5 88359.0 92069.0 92074.5 94654.6 94912.5 9161.9 9372.5 9413.6 9461.1 9479.9 53328.5 53533.5 54879.0 54905.5 55862.2 65526.4 67014.0 74894.0 80255.0 80283.0 13198.6 13549.6 13595.9 13611.8 13618.9 14987.7 15150.2 15195.1 15760.5 15771.0 9136.9 14244.9 14451.8 14497.2 14614.9 13653.8 14288.1 14436.6 14554.8 14964.1 13316.9 13681.5 14037.7 14570.1 14714.2 11759.4 11893.5 12015.4 12237.4 12321.4 12174.7 12347.6 12449.9 12572.4 12575.4 18:05:53 INFO - PROCESS | 22492 | -------- Summary: end -------- 18:05:53 INFO - PROCESS | 22492 | 18:05:53 INFO - TEST-INFO | 22492: exit 0 18:05:53 INFO - TEST-OK | dromaeo_css | took 1112279ms 18:05:53 INFO - TEST-START | kraken 18:05:53 INFO - operating with platform_type : linux_ 18:05:53 INFO - Initialising browser for kraken test... 18:05:53 INFO - TEST-INFO | started process 22674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi_q_NE/profile http://localhost:51160/getInfo.html) 18:05:57 INFO - PROCESS | 22674 | __metrics Screen width/height:1600/1200 18:05:57 INFO - PROCESS | 22674 | colorDepth:24 18:05:57 INFO - PROCESS | 22674 | Browser inner width/height: 1024/697 18:05:57 INFO - PROCESS | 22674 | __metrics 18:05:58 ERROR - PROCESS | 22674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:05:58 INFO - PROCESS | 22674 | console.error: PushService: 18:05:58 INFO - PROCESS | 22674 | stateChangeProcessEnqueue: Error transitioning state 18:05:58 INFO - PROCESS | 22674 | UnknownError 18:05:59 INFO - TEST-INFO | 22674: exit 0 18:05:59 INFO - Browser initialized. 18:05:59 INFO - Running cycle 1/1 for kraken test... 18:05:59 INFO - TEST-INFO | started process 22755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi_q_NE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:11 INFO - PROCESS | 22755 | RSS: Main: 156180480 18:06:11 INFO - PROCESS | 22755 | 18:06:13 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:14 INFO - PROCESS | 22755 | RSS: Main: 214466560 18:06:14 INFO - PROCESS | 22755 | 18:06:17 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-dft) 18:06:17 INFO - PROCESS | 22755 | RSS: Main: 201519104 18:06:17 INFO - PROCESS | 22755 | 18:06:21 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-fft) 18:06:21 INFO - PROCESS | 22755 | RSS: Main: 268353536 18:06:21 INFO - PROCESS | 22755 | 18:06:23 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-oscillator) 18:06:24 INFO - PROCESS | 22755 | RSS: Main: 179601408 18:06:24 INFO - PROCESS | 22755 | 18:06:26 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:27 INFO - PROCESS | 22755 | RSS: Main: 183279616 18:06:27 INFO - PROCESS | 22755 | 18:06:30 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:30 INFO - PROCESS | 22755 | RSS: Main: 219574272 18:06:30 INFO - PROCESS | 22755 | 18:06:34 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-desaturate) 18:06:34 INFO - PROCESS | 22755 | RSS: Main: 220483584 18:06:34 INFO - PROCESS | 22755 | 18:06:37 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51160/tests/kraken/driver.html?testName=json-parse-financial) 18:06:38 INFO - PROCESS | 22755 | RSS: Main: 220409856 18:06:38 INFO - PROCESS | 22755 | 18:06:39 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:06:40 INFO - PROCESS | 22755 | RSS: Main: 207048704 18:06:40 INFO - PROCESS | 22755 | 18:06:42 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:06:42 INFO - PROCESS | 22755 | RSS: Main: 211193856 18:06:42 INFO - PROCESS | 22755 | 18:06:44 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:06:45 INFO - PROCESS | 22755 | RSS: Main: 217473024 18:06:45 INFO - PROCESS | 22755 | 18:06:48 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:06:48 INFO - PROCESS | 22755 | RSS: Main: 223211520 18:06:48 INFO - PROCESS | 22755 | 18:06:51 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:06:51 INFO - PROCESS | 22755 | RSS: Main: 221237248 18:06:51 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51160/tests/kraken/driver.html?testName=ai-astar) 18:06:53 INFO - PROCESS | 22755 | RSS: Main: 263356416 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | __start_tp_report 18:06:53 INFO - PROCESS | 22755 | _x_x_mozilla_page_load 18:06:53 INFO - PROCESS | 22755 | _x_x_mozilla_page_load_details 18:06:53 INFO - PROCESS | 22755 | |i|pagename|runs| 18:06:53 INFO - PROCESS | 22755 | |0;ai-astar;111;104;110;109;111;111;110;111;111;110 18:06:53 INFO - PROCESS | 22755 | |1;audio-beat-detection;151;125;133;182;133;128;156;126;177;127 18:06:53 INFO - PROCESS | 22755 | |2;audio-dft;161;161;161;162;161;161;163;162;162;162 18:06:53 INFO - PROCESS | 22755 | |3;audio-fft;75;74;76;121;76;76;74;74;105;74 18:06:53 INFO - PROCESS | 22755 | |4;audio-oscillator;86;85;127;85;85;85;119;85;84;121 18:06:53 INFO - PROCESS | 22755 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;116;117;116 18:06:53 INFO - PROCESS | 22755 | |6;imaging-darkroom;146;147;145;146;146;146;145;145;145;145 18:06:53 INFO - PROCESS | 22755 | |7;imaging-desaturate;95;95;94;94;95;94;95;95;95;95 18:06:53 INFO - PROCESS | 22755 | |8;json-parse-financial;54;51;53;54;53;53;52;53;55;52 18:06:53 INFO - PROCESS | 22755 | |9;json-stringify-tinderbox;61;63;61;61;62;62;67;62;62;62 18:06:53 INFO - PROCESS | 22755 | |10;stanford-crypto-aes;79;84;82;79;86;83;87;87;107;84 18:06:53 INFO - PROCESS | 22755 | |11;stanford-crypto-ccm;121;143;129;122;128;128;117;124;125;137 18:06:53 INFO - PROCESS | 22755 | |12;stanford-crypto-pbkdf2;167;166;164;169;169;166;161;163;168;162 18:06:53 INFO - PROCESS | 22755 | |13;stanford-crypto-sha256-iterative;66;64;64;63;63;61;63;62;65;66 18:06:53 INFO - PROCESS | 22755 | __end_tp_report 18:06:53 INFO - PROCESS | 22755 | __start_cc_report 18:06:53 INFO - PROCESS | 22755 | _x_x_mozilla_cycle_collect,1607 18:06:53 INFO - PROCESS | 22755 | __end_cc_report 18:06:53 INFO - PROCESS | 22755 | __startTimestamp1465261613885__endTimestamp 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | ------- Summary: start ------- 18:06:53 INFO - PROCESS | 22755 | Number of tests: 14 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.15 (1.9%) stddev-sans-first:2.24 18:06:53 INFO - PROCESS | 22755 | Values: 111.0 104.0 110.0 109.0 111.0 111.0 110.0 111.0 111.0 110.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:142.00 stddev:21.60 (15.2%) stddev-sans-first:22.75 18:06:53 INFO - PROCESS | 22755 | Values: 151.0 125.0 133.0 182.0 133.0 128.0 156.0 126.0 177.0 127.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 18:06:53 INFO - PROCESS | 22755 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 163.0 162.0 162.0 162.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:16.53 (22.2%) stddev-sans-first:17.31 18:06:53 INFO - PROCESS | 22755 | Values: 75.0 74.0 76.0 121.0 76.0 76.0 74.0 74.0 105.0 74.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.15 (21.3%) stddev-sans-first:18.87 18:06:53 INFO - PROCESS | 22755 | Values: 86.0 85.0 127.0 85.0 85.0 85.0 119.0 85.0 84.0 121.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:06:53 INFO - PROCESS | 22755 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:06:53 INFO - PROCESS | 22755 | Values: 146.0 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:06:53 INFO - PROCESS | 22755 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.15 (2.2%) stddev-sans-first:1.17 18:06:53 INFO - PROCESS | 22755 | Values: 54.0 51.0 53.0 54.0 53.0 53.0 52.0 53.0 55.0 52.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.77 (2.8%) stddev-sans-first:1.81 18:06:53 INFO - PROCESS | 22755 | Values: 61.0 63.0 61.0 61.0 62.0 62.0 67.0 62.0 62.0 62.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.00 stddev:7.98 (9.5%) stddev-sans-first:8.08 18:06:53 INFO - PROCESS | 22755 | Values: 79.0 84.0 82.0 79.0 86.0 83.0 87.0 87.0 107.0 84.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:7.71 (6.0%) stddev-sans-first:7.82 18:06:53 INFO - PROCESS | 22755 | Values: 121.0 143.0 129.0 122.0 128.0 128.0 117.0 124.0 125.0 137.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:166.50 stddev:2.88 (1.7%) stddev-sans-first:3.00 18:06:53 INFO - PROCESS | 22755 | Values: 167.0 166.0 164.0 169.0 169.0 166.0 161.0 163.0 168.0 162.0 18:06:53 INFO - PROCESS | 22755 | 18:06:53 INFO - PROCESS | 22755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.64 (2.6%) stddev-sans-first:1.51 18:06:53 INFO - PROCESS | 22755 | Values: 66.0 64.0 64.0 63.0 63.0 61.0 63.0 62.0 65.0 66.0 18:06:53 INFO - PROCESS | 22755 | -------- Summary: end -------- 18:06:53 INFO - PROCESS | 22755 | 18:06:54 INFO - TEST-INFO | 22755: exit 0 18:06:54 INFO - TEST-OK | kraken | took 61052ms 18:06:54 INFO - SUITE-END | took 1173s 18:06:55 INFO - Completed test suite (00:19:33) 18:06:55 INFO - javascript benchmark 18:06:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.383323335333, 3099.767517436193, 3114.7975381600195, 3137.9843100784506, 3146.276356438018, 5284.365876094874, 5309.070912590296, 5391.353037635485, 5405.108157154064, 5452.509274165324, 5325.920111198326, 5338.199270109486, 5423.701696406696, 5444.428335024825, 5502.58730595206, 4756.524347565241, 4862.34358361622, 4871.732054736988, 4881.389826271716, 5025.824096156635, 4874.497641532952, 4892.168331383656, 4912.508749125094, 4932.580730637882, 4948.7278199699, 4744.952550474485, 4766.785494652749, 4782.0435912817575, 4786.1863483207935, 4789.473157952622, 4773.594244489223, 4806.0, 4858.028394321114, 4877.46347901734, 4902.877428064291, 4805.567498925078, 4811.278308253755, 4811.879703007417, 4824.2040063389495, 4872.196087645534, 5192.636515443921, 5225.686458812484, 5313.628046036779, 5338.652987555835, 5351.197320401932, 5759.5968282220265, 5817.156512305692, 5817.447342502455, 5818.2145410369485, 5818.359980402152, 5868.383819698913, 5877.794277200277, 5881.470667639933, 5887.205227294303, 5887.970560147171, 5223.451537588575, 5302.496262855023, 5322.893542129135, 5334.839954801401, 5411.756470958816, 5963.016102343152, 5965.612235204698, 5993.760249589967, 6000.129981152709, 6001.939980600226, 5576.665400075927, 5743.253377061039, 5746.281714785652, 5750.0, 5757.654540727486, 5678.403767604342, 5707.086866101404, 5707.143928410772, 5732.598718089777, 5735.053716136874, 5658.179563963285, 5685.744141513642, 5694.97152514243, 5705.800296989669, 5710.343310519261, 5627.43725627434, 5671.461211184931, 5679.403662615448, 5728.0, 5732.369439361667, 4321.827126914951, 4337.284348082531, 4337.674674399433, 4386.298192289219, 4393.143337049245, 3882.728209025341, 3885.320068987916, 3897.5517815451585, 3898.766074035567, 3922.980385098056, 5402.216678581583, 5451.318585176853, 5500.889982200333, 5524.392316845144, 5572.219889215513, 5673.1490276458035, 5727.8568035799435, 5733.426657334317, 5751.798687045934, 5782.479576838105, 5407.702576358338, 5415.566754659618, 5426.131818909034, 5449.237106805051, 5456.48163424474, 4752.904941901143, 4787.880302992384, 4819.180739274261, 4824.758762061883, 4829.758512074382, 5871.794487193013, 5917.31950825652, 5921.319048309413, 5922.3485416604135, 5977.163197152402, 5730.312362516524, 5730.914036289376, 5731.02572562657, 5735.36910939788, 5737.942620573741, 5889.823305300848, 5906.645601263938, 5925.85185370352, 5957.285125784933, 6003.87992240144, 5745.798897038583, 5759.308882934075, 5760.8271751847515, 5768.567357448124, 5793.652380857162, 5810.796622118206, 5811.4479124483105, 5869.031609784509, 5878.853028674317, 5880.500157486662, 5616.634918730269, 5624.943750562442, 5642.097264437671, 5658.094704847204, 5753.769849205984, 5610.102383618601, 5616.269884914935, 5617.297837770278, 5620.971895140498, 5622.156676498558, 5490.835274941758, 5494.780208791603, 5496.0931446310915, 5498.092814685692, 5540.584456165884, 5569.526590239875, 5593.916091258553, 5595.160725891149, 5616.382197958303, 5719.48524632785, 5497.972510137423, 5502.944970550243, 5503.091989821794, 5514.476124768141, 5561.054620714407], "value": 5291.33250703476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.5563327504372, 609.8109586028331, 623.1338439569003, 633.9144215530902, 640.6220330005298, 30710.385792284167, 31466.370672586563, 44203.33694994578, 45413.545864541346, 45503.54496455035, 43150.0, 47261.76369118158, 47313.0, 47362.0, 47408.0, 8681.999999999984, 8873.68942087027, 8873.911260887373, 8882.955585222066, 8889.288856891466, 8681.95659021704, 8769.868451973194, 8808.383413161082, 8813.64745410186, 8818.338624603148, 8827.646894124227, 8877.156670116361, 8891.555422228896, 8901.243394311492, 8901.332400069989, 8788.209061184492, 8838.646454141826, 8841.734747957604, 8843.823123537557, 8857.557122143931, 8659.134086591353, 8692.608832602547, 8742.08208138149, 8751.43115697484, 8753.649854005833, 43701.34447983283, 43913.0, 44014.0, 44067.33898991485, 44227.77886110581, 3399.7960122392738, 3422.8117453540294, 3598.082488965323, 3894.2990261753157, 3927.960720392788, 32409.83795081033, 32753.34493310144, 33184.50223246653, 33334.49998250028, 33970.49044264338, 4285.35719642053, 4294.3558466230315, 4333.285007973681, 4338.240807858612, 4364.2798938175165, 352135.23932380433, 352254.0, 353328.0, 354598.0, 354659.0, 51690.0, 58989.41010589925, 59829.40170598238, 59895.0, 61089.38910610837, 62914.0, 63517.0, 63728.0, 63800.0, 63876.36123638704, 16361.91819040921, 16569.088700121367, 16582.75125873113, 16595.83404165967, 16597.41909033178, 11381.089512838953, 12269.509219631293, 12494.437750301258, 12581.622551323475, 12591.874081259253, 17112.0, 17112.828871711372, 17139.485815425556, 17188.0, 17218.913905430392, 5892.204552385459, 5931.169636250928, 5993.130996005642, 6002.248594628357, 6085.726142323606, 1008.8486726990864, 1054.7995880782628, 1063.1282348474176, 1086.6142519405655, 1087.907527860125, 32994.67005329964, 33119.337613248084, 33210.17344046052, 33341.16647083842, 33998.320033599186, 1081.3565928272665, 1096.4736926275273, 1133.2237417369129, 1140.1961617059953, 1157.0338767129374, 16805.495835124966, 17646.294148234185, 17665.433987296794, 17759.467215983543, 17846.286148554173, 557371.0, 557505.0, 566941.0, 571230.0, 869428.0, 60305.0, 60462.69768651129, 60882.39117608856, 60919.390806092255, 60937.39062609406, 1282.5190553542423, 1320.6170210638807, 1385.6466601016878, 1388.0908005256574, 1419.5741277616673, 29385.412291754474, 33667.15832104217, 33701.662983370836, 33742.49386259159, 33816.83091584625, 47959.28061079017, 47984.760076199396, 48341.34122623289, 48414.27378589253, 48437.0, 377860.0, 380063.0, 381627.0, 382872.5414712578, 383002.0, 24334.63498047566, 26945.865270673523, 27234.5914811274, 27787.305317367227, 27921.0, 48134.518654813, 48189.75905120452, 48895.51104489052, 49015.26477102918, 49602.75198623984, 40739.185216294914, 40963.38554921619, 41365.58634413617, 41613.79193104015, 42388.78805605952, 38764.6123538761, 39206.411903820896, 39273.0, 39400.211995760495, 39499.0, 40573.95695322804, 41573.792131039154, 42440.787796060824, 42519.78740106404, 45253.0, 35890.4616430759, 38168.61831381651, 38229.0, 38894.4165837507, 39125.6087439122, 28695.71304287014, 29217.0, 29228.0, 29292.853535732185, 29541.55687664644], "value": 20101.981484115677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.9767813931166, 389.2526349409134, 391.92357490289396, 393.65358484533607, 410.0855093142293, 14040.929795351009, 17765.46703598891, 18307.084645767707, 20105.899470502645, 20151.697724534126, 15510.844891551082, 16258.430954916581, 17752.644947101082, 18394.172262248198, 18769.343072992448, 5467.917981230285, 5784.2480477537865, 5795.333536643277, 5798.65208087514, 5799.594028418012, 4244.405783190356, 5724.885502289952, 5793.5365170786445, 5795.739191736361, 6169.876602467948, 6472.870542589146, 6536.640484773336, 6561.114249576318, 6600.867982640344, 6601.438877695402, 6320.93679063208, 6536.60780353178, 6567.080608714784, 6580.177477815249, 6588.4729221662155, 5604.8318550443555, 5776.653400795965, 5802.477777000048, 5805.970970145165, 5827.592068555203, 22941.885290573442, 23548.88225558861, 23821.642675359883, 23868.522629547486, 23872.0, 2351.6354964980455, 2396.424858034059, 2558.795296376304, 2602.4925139597785, 2940.882364705409, 14629.487967921179, 14739.631509212248, 14903.32935017916, 15007.774883376758, 15112.244387780567, 1908.9904550477297, 1969.901504924748, 2010.4772759082744, 2026.189524190321, 2042.1627132875599, 84209.0, 84737.57631211866, 85141.0, 85854.57072714597, 87105.12894871033, 10559.832050385008, 10632.893671063344, 10702.518386672462, 10936.890631093587, 11111.666650000512, 15156.31796569157, 15407.229638518029, 15407.537773866801, 15411.691766164615, 15436.922815385851, 7991.520508769492, 8297.294729947902, 8345.499270043816, 8462.61918213682, 8514.57427128641, 8003.439759216915, 8133.511989280544, 8149.918500815034, 8278.30954939647, 8285.461445006054, 5771.942280577225, 6172.321044685081, 6372.394622510854, 6525.151730275129, 6655.700493477805, 1895.175598614607, 1911.9808801911802, 1935.5161209697576, 1952.6094781043564, 1988.602279544097, 922.064104933493, 1018.1549314069453, 1049.024407301202, 1089.5750657243682, 1091.5845405335438, 18490.075496225403, 19731.50671233202, 20790.58418831645, 20921.0, 20989.265375711777, 1018.1549314069453, 1027.429776474049, 1030.5465595138114, 1097.2045267181388, 1114.1087130295894, 10542.525586348633, 11334.206605537533, 11351.432428378548, 11813.940930295294, 11844.230125041844, 487941.0, 491719.0, 496653.0, 497840.0, 501023.0, 92160.53919730359, 96749.0, 98152.50923745336, 98374.5081274589, 100618.0, 931.9673811416703, 968.0271327316002, 1027.6043723166636, 1042.5048102151418, 1055.6674647486018, 16504.75242871382, 16532.338706451606, 17159.399421020204, 17843.643127137646, 18327.175277112296, 38084.238315232986, 39146.608533914296, 40179.39730903981, 43607.78196108999, 44245.0, 55665.0, 56592.43407566036, 57764.71117644385, 59036.40963590481, 59215.70392148012, 6049.546284028804, 7557.130929943127, 8534.274586660204, 8561.0, 8753.124687531195, 11905.761884762429, 13243.536476223671, 13299.734005319646, 13338.466461341437, 13421.328933553088, 11465.541378345106, 11683.941580292045, 11688.649340519798, 11792.174547781917, 11983.64049078529, 11531.0, 11639.243449175776, 11720.824187637363, 11817.82273265919, 11978.101642376681, 11672.249162625674, 11829.76340473203, 12068.396580171131, 12139.0, 12158.878411215775, 8507.702230421906, 8623.396362254582, 8650.895971376918, 8758.167974042455, 8855.893013373328, 11359.943200283946, 11744.70638234051, 11810.232334898204, 11942.34317112567, 12164.452599633214], "value": 9530.581791173992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.147661067085, 1485.8662720355169, 1509.5471358592422, 1675.4554769699844, 1794.703873860813, 8202.589870506474, 8624.655013799449, 8645.69740059098, 8854.513001784899, 8855.601497932592, 8502.0, 8742.344324175681, 8764.737057888258, 8778.736637900858, 8794.91205087949, 1980.4256765537978, 2031.6241495323338, 2033.7356143701372, 2345.589521833681, 2375.904963801446, 2312.8034117100065, 2361.3506285771377, 2372.6441033844976, 2402.3633737059695, 2406.639004149374, 2342.917997870075, 2349.800266977309, 2370.928872133839, 2374.050379848057, 2375.798057165143, 1959.706044093383, 2022.4236092713654, 2267.4444761033487, 2294.8737819419925, 2296.7473577906417, 2004.368623883472, 2227.988860055689, 2270.67075274086, 2271.216430331533, 2290.335802617239, 8260.628271727786, 8309.750707478785, 8311.667533298662, 8312.33501319893, 8313.1271216522, 5057.898842023139, 5116.641835071547, 5174.870628234286, 5185.585153187773, 5191.247269145991, 3217.871285148591, 3293.275479394529, 3357.7145942594907, 3375.831208439593, 3433.2790114076074, 1114.921955463118, 1115.380963565221, 1143.6226045404997, 1167.64970508847, 1172.0564945219096, 12000.21998570099, 12033.51865925362, 12035.759284814343, 12038.638840834788, 12052.156349055569, 4392.5607439256455, 4583.220852455091, 4651.232546629836, 4717.764111794465, 4726.432828060586, 10128.59485620567, 10183.18534517237, 10185.064837680817, 10189.643362482426, 10198.388096714072, 5074.644774865724, 5082.1360368737405, 5095.1847704367865, 5098.133317336062, 5100.1074811907765, 4066.471358723347, 4507.797149128297, 4640.6751527393435, 4688.859334219979, 4840.273958906192, 3862.343401621731, 3862.6716729078344, 3945.408188771707, 3991.7604943703473, 4023.456833327522, 1169.3626973299572, 1188.3285943441927, 1216.3431746856775, 1242.1491278474275, 1248.1387842388722, 941.0824446165071, 946.0, 955.9474228917476, 958.9376690515094, 970.8932017478072, 5915.733791979371, 6017.368176341509, 6092.421219984094, 6192.628442293477, 6205.565610407319, 480.68034756886277, 483.09660934053545, 486.79797883877796, 1056.1709058389129, 1072.3512275073467, 3986.60133986599, 4095.28332541804, 4096.713230073926, 4253.680973926967, 4284.228838808982, 9831.754206144904, 10235.692929212135, 10250.026247506625, 10251.48742562869, 10267.435291058913, 10144.036316549917, 10156.949215253877, 10169.644062457779, 10175.84736228957, 10176.745581360377, 7883.448158628956, 7990.760277191694, 8004.119546849842, 8034.638441270157, 8036.919630803734, 5768.653880767168, 5907.763689452546, 5938.287405511366, 6077.058056001327, 6328.493720502441, 9689.70930872075, 9854.458004809805, 10051.949740251252, 10057.949710251401, 10114.595416183565, 10180.694579162637, 10189.74525636865, 10261.486925653837, 10285.53715082838, 10297.07326340633, 6541.70562324687, 7191.640417979184, 7481.438892083007, 7625.351845093229, 7637.0, 8415.663373465237, 8424.915750842412, 8483.36374771907, 8520.105388934073, 8524.104968978168, 7470.701171953278, 7519.0, 7604.771856844303, 7723.189065148079, 7766.417518686008, 7272.96363518179, 7420.220876807857, 7447.553146810992, 7579.355754760686, 7595.202503737028, 6977.79066628002, 7008.789736307919, 7049.859002820018, 7056.470764692771, 7058.188308344606, 5222.242774797557, 5240.213967904845, 5384.407715151252, 5422.403535611001, 5441.102218133963, 4799.640026997919, 4955.45489996093, 4968.155413579772, 4971.751412429292, 4978.5270399312], "value": 4521.813272452718, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.56566766200956, 331.42497766375334, 340.5062659144241, 343.585978895431, 344.51595508310834, 5297.576193904488, 5312.92030619541, 5330.733463326833, 5342.0, 5412.0, 5310.495502927216, 5339.492748188916, 5356.196570514425, 5374.516293533581, 5382.865428364293, 3933.960660393388, 4198.895027624311, 4208.0, 4219.185750127444, 4223.113146239278, 4162.627302437611, 4174.499060112791, 4192.9790351048205, 4209.915801683965, 4212.873613791591, 4151.315033019563, 4158.230727315441, 4164.583541645827, 4178.164367126572, 4185.723354376929, 3897.376419772837, 3999.6000399959917, 4111.958880411187, 4136.338185890243, 4138.937915931264, 3616.716065796657, 3625.4199328107375, 3626.34725749365, 3632.473291372736, 3651.4887915691825, 4881.8535443936735, 5035.79856805731, 5150.639455238135, 5161.406438259573, 5165.638405311592, 4546.29532422475, 4692.920628255486, 4708.634495996192, 4721.244600863845, 4725.149473094842, 5467.289252397163, 5482.259894914176, 5487.122060470306, 5490.6431081979945, 5503.889922201533, 3797.905052373685, 3945.230680017398, 3946.7039972002217, 3994.2810294147043, 4003.4195041718785, 5765.769369225226, 5779.88440231193, 5790.0, 5811.854703632401, 5815.883682326372, 4056.472658554369, 4088.448059511928, 4088.672906167559, 4098.4876890388705, 4112.670986321087, 4160.54234034256, 4161.2301724181125, 4178.498580170338, 4179.623833854967, 4182.786991772352, 4566.543345665474, 4693.155232058194, 4693.873470367155, 4702.0, 4742.193827049341, 5565.495527012779, 5569.164625306236, 5594.13290939905, 5598.608097433222, 5652.547796176296, 1406.1352268355092, 1406.8171137752026, 1427.4932398998415, 1431.2843578210895, 1431.4775107086048, 892.9866052009226, 909.3543584055395, 919.3794188922451, 926.6979893249994, 930.3115694386106, 4839.540243676845, 4889.315495830587, 4896.4124305083615, 4950.9009819803405, 4980.302757613937, 4842.322074909515, 5073.441921388644, 5077.26379674945, 5079.466656001066, 5108.642395032386, 4856.757162141878, 5171.689698618095, 5303.416624171338, 5403.9459605403445, 5408.648437851606, 3020.7130322619314, 3037.6962303769446, 3052.359004609057, 3053.4656435123766, 3069.017914267413, 5631.0, 5832.533397328203, 5864.530837532987, 5873.0, 5878.412828536271, 5800.8259752207505, 5831.88336233273, 5833.4749872511675, 5837.3870743571315, 5837.532997360201, 5883.970580147157, 5884.764609415661, 5886.499647530008, 5889.911651325147, 5901.0, 5478.315210598676, 5701.4298570142655, 5766.0, 5784.07904008473, 5814.825555233349, 5692.857678558069, 5719.799807006735, 5723.969685456658, 5750.367459579359, 5760.567957403296, 5733.283339582552, 5942.405759424023, 5944.64332140073, 5956.426144313377, 5986.431289027535, 4069.593040695907, 4070.2266569351727, 4072.124493233969, 4074.7555146691293, 4094.2016306819883, 5825.242718446575, 5867.266591676041, 5889.38161493037, 5897.852553686193, 5918.467337939606, 5451.264079349237, 5616.410276920865, 5660.915086273627, 5732.426757324234, 5737.454941780524, 5629.971850140887, 5640.830775076754, 5657.4059723728415, 5667.659940403424, 5673.461021202979, 5500.862478438071, 5517.200005999028, 5536.0, 5537.750801214036, 5557.888842223052, 5552.583556233218, 5687.402822703557, 5689.971550142222, 5706.714664266853, 5718.170865224436, 5237.319148510669, 5521.806736764194, 5525.696086715269, 5529.695866727207, 5568.303962004749], "value": 4231.118796825044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.28688442713, 703.6727921516493, 740.6148802622637, 755.1994885421452, 833.6415341403198, 14730.558083257505, 15888.0, 15906.443274485395, 15915.761263581055, 15924.442644507415, 13056.543020994268, 13170.143940643875, 13190.208587484758, 13756.793648095287, 13853.238071906042, 670.1957650819037, 776.9261920117608, 794.0590400375559, 797.2505844506146, 800.2717527050386, 800.2117913854848, 811.7848770075934, 811.8457493076326, 811.8619834628128, 812.3907069697726, 841.0748177005275, 841.7348535211389, 843.5191940593834, 844.0209357145712, 844.1558441558442, 691.3846676457956, 805.5770720371793, 830.4353039932844, 834.1533343656164, 836.3267569606464, 611.7858749437705, 612.4059662127773, 613.6318209074565, 613.7575657615217, 613.7790395457631, 13981.720365592631, 14058.507952221726, 14150.504732334319, 14198.858011419858, 14207.431702731878, 14081.5071472499, 14746.852531474655, 14778.704425911528, 14804.851951480456, 14933.0, 12685.36573171347, 12885.549005784753, 13032.934835325763, 13059.542915997894, 13081.0, 4517.2094883395275, 4582.6104781093645, 4584.15193189261, 4584.88537786558, 4593.862184134481, 61986.69006654938, 65446.0, 65554.0166897497, 74958.0, 75086.0, 10719.892801072045, 11033.448327583588, 11841.585544506073, 11863.88136118645, 12054.890394180984, 19353.903230483756, 19565.315213967442, 19624.313149039714, 19637.410877673694, 19641.41075767729, 8295.502269863828, 8306.916930830736, 8776.122387761172, 8906.332025098143, 9232.307576931757, 4824.396950381202, 4907.092187945242, 5001.924971125436, 5003.724795136302, 5025.346704928336, 3344.3311337732553, 3444.1389652586854, 3475.6350583188905, 3479.6520347965507, 3492.2491664292297, 509.9209622508517, 621.3972446726668, 627.5136769004058, 643.3919945651409, 645.6707079389452, 610.8228613701976, 654.1888058807045, 661.4014317043084, 703.5040296590892, 731.8609464201785, 9871.259655525864, 10021.949890250502, 10040.497975101216, 10194.286399951932, 10238.744031399274, 632.7500637248261, 643.3823529411724, 649.0297005976001, 649.3474058571106, 650.5738741124571, 4738.3129446230105, 4769.35613692154, 4775.474697783241, 4833.3958255218095, 4878.780454879539, 71562.64218678873, 73178.63410682912, 118179.0, 119165.8083419172, 124536.37731811283, 63625.68187159034, 63904.36095638984, 66855.66572167107, 101514.0, 101821.49089254506, 88359.0, 92069.0, 92074.53962730277, 94654.58018129734, 94912.52543737376, 9161.86257206129, 9372.484513351832, 9413.623455061721, 9461.148496635336, 9479.857802133112, 53328.4667153339, 53533.464665354404, 54879.0, 54905.45094549003, 55862.16206756983, 65526.43025342899, 67014.0, 74894.0, 80255.0, 80283.0, 13198.60404187876, 13549.59351219465, 13595.86404135946, 13611.795823062464, 13618.863811362156, 14987.700245995236, 15150.242487875783, 15195.086166164994, 15760.527184184493, 15771.0, 9136.908630913606, 14244.931630127574, 14451.78322325187, 14497.20265385414, 14614.926925365306, 13653.795193071914, 14288.142711437347, 14436.639084022983, 14554.781678275047, 14964.102153870803, 13316.933415332862, 13681.452741890611, 14037.719245615235, 14570.125792452487, 14714.19071951053, 11759.353235572125, 11893.524259029542, 12015.399230038638, 12237.449314781034, 12321.383930803604, 12174.695632609255, 12347.581434884518, 12449.875501244871, 12572.371381431074, 12575.371231438574], "value": 7514.290264575901, "unit": "score"}], "name": "dromaeo_css", "value": 7254.446434446605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 109.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 133.0, 182.0, 133.0, 128.0, 156.0, 126.0, 177.0, 127.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 121.0, 76.0, 76.0, 74.0, 74.0, 105.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 127.0, 85.0, 85.0, 85.0, 119.0, 85.0, 84.0, 121.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0, 55.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 62.0, 62.0, 67.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 82.0, 79.0, 86.0, 83.0, 87.0, 87.0, 107.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 143.0, 129.0, 122.0, 128.0, 128.0, 117.0, 124.0, 125.0, 137.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 164.0, 169.0, 169.0, 166.0, 161.0, 163.0, 168.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 63.0, 61.0, 63.0, 62.0, 65.0, 66.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1508.4000000000003, "alertThreshold": 2.0}]} 18:06:55 INFO - Return code: 0 18:06:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:06:55 ERROR - # TBPL SUCCESS # 18:06:55 INFO - Running post-action listener: _resource_record_post_action 18:06:55 INFO - ##### 18:06:55 INFO - ##### Finished run-tests step (success) 18:06:55 INFO - ##### 18:06:55 INFO - Running post-run listener: _resource_record_post_run 18:06:55 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 542310400; Read time: 0; Write time: 438628 18:06:55 INFO - TinderboxPrint: CPU usage
13.1% 18:06:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:06:55 INFO - TinderboxPrint: I/O write bytes / time
542,310,400 / 438,628 18:06:55 INFO - TinderboxPrint: CPU idle
8,258.0 (86.9%) 18:06:55 INFO - TinderboxPrint: CPU user
1,203.3 (12.7%) 18:06:55 INFO - TinderboxPrint: Swap in / out
0 / 0 18:06:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 228073472; Read time: 0; Write time: 238804 18:06:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293597184; Read time: 0; Write time: 189860 18:06:55 INFO - Running post-run listener: _upload_blobber_files 18:06:55 INFO - Blob upload gear active. 18:06:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:06:55 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:06:55 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:06:55 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:06:56 INFO - (blobuploader) - INFO - Open directory for files ... 18:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:00 INFO - (blobuploader) - INFO - Done attempting. 18:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:01 INFO - (blobuploader) - INFO - Done attempting. 18:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:02 INFO - (blobuploader) - INFO - Done attempting. 18:07:02 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:02 INFO - Return code: 0 18:07:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db47eeeed456b893a0b50cbee4ed92546320e76fc3d9baa09aee36e10523debd0ade094eff15d3a6e79798085f9a39aae426c266b5dcfa9d65c726485062ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43573a00b13c10502a06fadf645161ff3d5b50d83e1a3efb0730a00c3137a972fb84743323e988bd6f8a41efada7d920d1880f35a5f93ef6846e9f7472e5b170", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b13169fa466a323ab92f78bd142d9ebd8d4ef500c6a990b43d2f8a217f23ace479c4bce62efaa0275e380c8c8fa0e247d0a8f4d716ffee3427f481cc87af88"} 18:07:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:02 INFO - Contents: 18:07:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db47eeeed456b893a0b50cbee4ed92546320e76fc3d9baa09aee36e10523debd0ade094eff15d3a6e79798085f9a39aae426c266b5dcfa9d65c726485062ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43573a00b13c10502a06fadf645161ff3d5b50d83e1a3efb0730a00c3137a972fb84743323e988bd6f8a41efada7d920d1880f35a5f93ef6846e9f7472e5b170", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b13169fa466a323ab92f78bd142d9ebd8d4ef500c6a990b43d2f8a217f23ace479c4bce62efaa0275e380c8c8fa0e247d0a8f4d716ffee3427f481cc87af88"} 18:07:02 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:02 INFO - Copying logs to upload dir... 18:07:02 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.888699 ========= 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:07:02.744600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 18:07:02.750105) ========= 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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db47eeeed456b893a0b50cbee4ed92546320e76fc3d9baa09aee36e10523debd0ade094eff15d3a6e79798085f9a39aae426c266b5dcfa9d65c726485062ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43573a00b13c10502a06fadf645161ff3d5b50d83e1a3efb0730a00c3137a972fb84743323e988bd6f8a41efada7d920d1880f35a5f93ef6846e9f7472e5b170", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b13169fa466a323ab92f78bd142d9ebd8d4ef500c6a990b43d2f8a217f23ace479c4bce62efaa0275e380c8c8fa0e247d0a8f4d716ffee3427f481cc87af88"} 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.011388 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db47eeeed456b893a0b50cbee4ed92546320e76fc3d9baa09aee36e10523debd0ade094eff15d3a6e79798085f9a39aae426c266b5dcfa9d65c726485062ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43573a00b13c10502a06fadf645161ff3d5b50d83e1a3efb0730a00c3137a972fb84743323e988bd6f8a41efada7d920d1880f35a5f93ef6846e9f7472e5b170", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b13169fa466a323ab92f78bd142d9ebd8d4ef500c6a990b43d2f8a217f23ace479c4bce62efaa0275e380c8c8fa0e247d0a8f4d716ffee3427f481cc87af88"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 18:07:02.776555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 18:07:02.776897) ========= 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=1f5564757af27664ca02d71f000001b0-1465260385.425271-562873573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 18:07:02.859539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 18:07:02.859865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 18:07:02.860176) ========= ========= Total master_lag: 0.18 =========