builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1470268796.91 results: success (0) buildid: 20160803141223 builduid: 87a0ac5ce7c942a7bd252bf6f65d4026 revision: 02304924791d467a6efe240d9012c02d91fe4703 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:56.913074) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:56.913572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:56.913873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:56.954589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:56.954890) ========= 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=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 16:59:57-- 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% 221M=0s 2016-08-03 16:59:57 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.076071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.076529) ========= 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=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014029 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.127875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.128256) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02304924791d467a6efe240d9012c02d91fe4703 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02304924791d467a6efe240d9012c02d91fe4703 --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=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 16:59:57,516 truncating revision to first 12 chars 2016-08-03 16:59:57,516 Setting DEBUG logging. 2016-08-03 16:59:57,517 attempt 1/10 2016-08-03 16:59:57,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/02304924791d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 16:59:57,832 unpacking tar archive at: mozilla-beta-02304924791d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.858404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.858696) ========= script_repo_revision: 02304924791d467a6efe240d9012c02d91fe4703 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.859134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.859427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 16:59:57.870591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-03 16:59:57.870865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:58 INFO - MultiFileLogger online at 20160803 16:59:58 in /builds/slave/test 16:59:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:59:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:58 INFO - {'append_to_log': False, 16:59:58 INFO - 'base_work_dir': '/builds/slave/test', 16:59:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:59:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:58 INFO - 'branch': 'Mozilla-Beta', 16:59:58 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:58 INFO - 'config_files': ('talos/linux_config.py',), 16:59:58 INFO - 'default_actions': ('clobber', 16:59:58 INFO - 'read-buildbot-config', 16:59:58 INFO - 'download-and-extract', 16:59:58 INFO - 'populate-webroot', 16:59:58 INFO - 'create-virtualenv', 16:59:58 INFO - 'install', 16:59:58 INFO - 'run-tests'), 16:59:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:58 INFO - 'download_minidump_stackwalk': True, 16:59:58 INFO - 'download_symbols': 'ondemand', 16:59:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:58 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:58 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:58 INFO - 'installer_path': 'installer.exe', 16:59:58 INFO - 'log_level': 'info', 16:59:58 INFO - 'log_name': 'talos', 16:59:58 INFO - 'log_to_console': True, 16:59:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:58 INFO - 'opt_config_files': (), 16:59:58 INFO - 'pip_index': False, 16:59:58 INFO - 'sps_profile': False, 16:59:58 INFO - 'sps_profile_interval': 0, 16:59:58 INFO - 'suite': 'dromaeojs-e10s', 16:59:58 INFO - 'system_bits': '32', 16:59:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:58 INFO - 'title': 'talos-linux64-ix-028', 16:59:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:58 INFO - 'use_talos_json': True, 16:59:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:58 INFO - 'work_dir': 'build'} 16:59:58 INFO - ##### 16:59:58 INFO - ##### Running clobber step. 16:59:58 INFO - ##### 16:59:58 INFO - Running pre-action listener: _resource_record_pre_action 16:59:58 INFO - Running main action method: clobber 16:59:58 INFO - rmtree: /builds/slave/test/build 16:59:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:59 INFO - Running post-action listener: _resource_record_post_action 16:59:59 INFO - ##### 16:59:59 INFO - ##### Finished clobber step (success) 16:59:59 INFO - ##### 16:59:59 INFO - ##### 16:59:59 INFO - ##### Running read-buildbot-config step. 16:59:59 INFO - ##### 16:59:59 INFO - Running pre-action listener: _resource_record_pre_action 16:59:59 INFO - Running main action method: read_buildbot_config 16:59:59 INFO - Using buildbot properties: 16:59:59 INFO - { 16:59:59 INFO - "project": "", 16:59:59 INFO - "product": "firefox", 16:59:59 INFO - "script_repo_revision": "production", 16:59:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:59:59 INFO - "repository": "", 16:59:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:59:59 INFO - "buildid": "20160803141223", 16:59:59 INFO - "pgo_build": "True", 16:59:59 INFO - "basedir": "/builds/slave/test", 16:59:59 INFO - "buildnumber": 196, 16:59:59 INFO - "slavename": "talos-linux64-ix-028", 16:59:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:59:59 INFO - "platform": "ubuntu64_hw", 16:59:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:59:59 INFO - "branch": "mozilla-beta", 16:59:59 INFO - "repo_path": "releases/mozilla-beta", 16:59:59 INFO - "revision": "02304924791d467a6efe240d9012c02d91fe4703", 16:59:59 INFO - "stage_platform": "linux64-pgo", 16:59:59 INFO - "builduid": "87a0ac5ce7c942a7bd252bf6f65d4026", 16:59:59 INFO - "slavebuilddir": "test" 16:59:59 INFO - } 16:59:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 16:59:59 INFO - Running post-action listener: _resource_record_post_action 16:59:59 INFO - ##### 16:59:59 INFO - ##### Finished read-buildbot-config step (success) 16:59:59 INFO - ##### 16:59:59 INFO - ##### 16:59:59 INFO - ##### Running download-and-extract step. 16:59:59 INFO - ##### 16:59:59 INFO - Running pre-action listener: _resource_record_pre_action 16:59:59 INFO - Running main action method: download_and_extract 16:59:59 INFO - mkdir: /builds/slave/test/build/tests 16:59: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')]} 16:59:59 INFO - https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:59:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:59:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:59:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 16:59:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:00:11 INFO - Downloaded 1327 bytes. 17:00:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 17:00:11 INFO - Using the following test package requirements: 17:00:11 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 17:00:11 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:00:11 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 17:00:11 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'jsshell-linux-x86_64.zip'], 17:00:11 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:00:11 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 17:00:11 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 17:00:11 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 17:00:11 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:00:11 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 17:00:11 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:00:11 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:00:11 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:00:11 INFO - https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:17 INFO - Downloaded 21968535 bytes. 17:00:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:00:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:00:19 INFO - Return code: 0 17:00:19 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:00:19 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:00:19 INFO - https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 17:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:20 INFO - Downloaded 21968535 bytes. 17:00:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:00:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:00:21 INFO - Return code: 0 17:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:21 INFO - https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 17:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 17:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 17:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:00:23 INFO - Downloaded 10833369 bytes. 17:00:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:00:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:00:23 INFO - Return code: 0 17:00:23 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:00:23 INFO - https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 17:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 17:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 17:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:00:24 INFO - Downloaded 55280261 bytes. 17:00:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 17:00:24 INFO - mkdir: /builds/slave/test/properties 17:00:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:24 INFO - Contents: 17:00:24 INFO - build_url:https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 17:00:25 INFO - Running post-action listener: _resource_record_post_action 17:00:25 INFO - Running post-action listener: set_extra_try_arguments 17:00:25 INFO - ##### 17:00:25 INFO - ##### Finished download-and-extract step (success) 17:00:25 INFO - ##### 17:00:25 INFO - ##### 17:00:25 INFO - ##### Running populate-webroot step. 17:00:25 INFO - ##### 17:00:25 INFO - Running pre-action listener: _resource_record_pre_action 17:00:25 INFO - Running main action method: populate_webroot 17:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:25 INFO - '--tppagecycles', 17:00:25 INFO - '7'], 17:00:25 INFO - 'tests': ['tsvgm']}}, 17:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['damp', 'tps']}, 17:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'tests': ['damp', 'tps']}, 17:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['dromaeo_dom']}, 17:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['a11yr', 17:00:25 INFO - 'ts_paint', 17:00:25 INFO - 'tpaint', 17:00:25 INFO - 'sessionrestore', 17:00:25 INFO - 'sessionrestore_no_auto_restore', 17:00:25 INFO - 'tabpaint']}, 17:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['tsvgx', 17:00:25 INFO - 'tsvgr_opacity', 17:00:25 INFO - 'tart', 17:00:25 INFO - 'tscrollx', 17:00:25 INFO - 'cart']}, 17:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:00:25 INFO - 'tsvgr_opacity', 17:00:25 INFO - 'tart', 17:00:25 INFO - 'tscrollx', 17:00:25 INFO - 'cart']}, 17:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'talos_options': ['--disable-e10s'], 17:00:25 INFO - 'tests': ['tp5o']}, 17:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'tests': ['tp5o']}, 17:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'talos_options': ['--disable-e10s', 17:00:25 INFO - '--xperf_path', 17:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:25 INFO - 'tests': ['tp5n']}, 17:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:25 INFO - 'talos_options': ['--xperf_path', 17:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:25 INFO - 'tests': ['tp5n']}}, 17:00:25 INFO - 'talos.zip': {'path': '', 17:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:25 INFO - Running post-action listener: _resource_record_post_action 17:00:25 INFO - ##### 17:00:25 INFO - ##### Finished populate-webroot step (success) 17:00:25 INFO - ##### 17:00:25 INFO - ##### 17:00:25 INFO - ##### Running create-virtualenv step. 17:00:25 INFO - ##### 17:00:25 INFO - Running pre-action listener: _resource_record_pre_action 17:00:25 INFO - Running main action method: create_virtualenv 17:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00:25 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:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:25 INFO - Using real prefix '/usr' 17:00:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:27 INFO - Installing pip.................done. 17:00:28 INFO - Return code: 0 17:00:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:00:28 INFO - Using env: {'DISPLAY': ':0', 17:00:28 INFO - 'HOME': '/home/cltbld', 17:00:28 INFO - 'LANG': 'en_US.UTF-8', 17:00:28 INFO - 'LANGUAGE': 'en_US:en', 17:00:28 INFO - 'LOGNAME': 'cltbld', 17:00:28 INFO - 'MAIL': '/var/mail/cltbld', 17:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:28 INFO - 'MOZ_NO_REMOTE': '1', 17:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:28 INFO - 'NO_EM_RESTART': '1', 17:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:28 INFO - 'PWD': '/builds/slave/test', 17:00:28 INFO - 'SHELL': '/bin/bash', 17:00:28 INFO - 'SHLVL': '1', 17:00:28 INFO - 'TERM': 'linux', 17:00:28 INFO - 'TMOUT': '86400', 17:00:28 INFO - 'USER': 'cltbld', 17:00:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:28 INFO - '_': '/tools/buildbot/bin/python'} 17:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:28 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:00:28 INFO - Cleaning up... 17:00:28 INFO - Return code: 0 17:00:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:00:28 INFO - Using env: {'DISPLAY': ':0', 17:00:28 INFO - 'HOME': '/home/cltbld', 17:00:28 INFO - 'LANG': 'en_US.UTF-8', 17:00:28 INFO - 'LANGUAGE': 'en_US:en', 17:00:28 INFO - 'LOGNAME': 'cltbld', 17:00:28 INFO - 'MAIL': '/var/mail/cltbld', 17:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:28 INFO - 'MOZ_NO_REMOTE': '1', 17:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:28 INFO - 'NO_EM_RESTART': '1', 17:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:28 INFO - 'PWD': '/builds/slave/test', 17:00:28 INFO - 'SHELL': '/bin/bash', 17:00:28 INFO - 'SHLVL': '1', 17:00:28 INFO - 'TERM': 'linux', 17:00:28 INFO - 'TMOUT': '86400', 17:00:28 INFO - 'USER': 'cltbld', 17:00:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:28 INFO - '_': '/tools/buildbot/bin/python'} 17:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:28 INFO - Downloading/unpacking psutil>=3.1.1 17:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:30 INFO - Installing collected packages: psutil 17:00:30 INFO - Running setup.py install for psutil 17:00:30 INFO - building 'psutil._psutil_linux' extension 17:00:30 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:00:30 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:00:30 INFO - building 'psutil._psutil_posix' extension 17:00:30 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:00:30 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:00:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:30 INFO - Successfully installed psutil 17:00:30 INFO - Cleaning up... 17:00:30 INFO - Return code: 0 17:00:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:00:30 INFO - Using env: {'DISPLAY': ':0', 17:00:30 INFO - 'HOME': '/home/cltbld', 17:00:30 INFO - 'LANG': 'en_US.UTF-8', 17:00:30 INFO - 'LANGUAGE': 'en_US:en', 17:00:30 INFO - 'LOGNAME': 'cltbld', 17:00:30 INFO - 'MAIL': '/var/mail/cltbld', 17:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:30 INFO - 'MOZ_NO_REMOTE': '1', 17:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:30 INFO - 'NO_EM_RESTART': '1', 17:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:30 INFO - 'PWD': '/builds/slave/test', 17:00:30 INFO - 'SHELL': '/bin/bash', 17:00:30 INFO - 'SHLVL': '1', 17:00:30 INFO - 'TERM': 'linux', 17:00:30 INFO - 'TMOUT': '86400', 17:00:30 INFO - 'USER': 'cltbld', 17:00:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:30 INFO - '_': '/tools/buildbot/bin/python'} 17:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:00:31 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:00:31 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:00:31 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:00:31 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:00:31 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:00:31 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:00:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:00:33 INFO - Installing collected packages: mozsystemmonitor 17:00:33 INFO - Running setup.py install for mozsystemmonitor 17:00:33 INFO - Successfully installed mozsystemmonitor 17:00:33 INFO - Cleaning up... 17:00:33 INFO - Return code: 0 17:00:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:00:33 INFO - Using env: {'DISPLAY': ':0', 17:00:33 INFO - 'HOME': '/home/cltbld', 17:00:33 INFO - 'LANG': 'en_US.UTF-8', 17:00:33 INFO - 'LANGUAGE': 'en_US:en', 17:00:33 INFO - 'LOGNAME': 'cltbld', 17:00:33 INFO - 'MAIL': '/var/mail/cltbld', 17:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:33 INFO - 'MOZ_NO_REMOTE': '1', 17:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:33 INFO - 'NO_EM_RESTART': '1', 17:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:33 INFO - 'PWD': '/builds/slave/test', 17:00:33 INFO - 'SHELL': '/bin/bash', 17:00:33 INFO - 'SHLVL': '1', 17:00:33 INFO - 'TERM': 'linux', 17:00:33 INFO - 'TMOUT': '86400', 17:00:33 INFO - 'USER': 'cltbld', 17:00:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:33 INFO - '_': '/tools/buildbot/bin/python'} 17:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:35 INFO - warning: no files found matching '*.txt' 17:00:35 INFO - no previously-included directories found matching 'build' 17:00:35 INFO - no previously-included directories found matching 'dist' 17:00:35 INFO - no previously-included directories found matching '.git*' 17:00:35 INFO - Installing collected packages: jsonschema, functools32 17:00:35 INFO - Running setup.py install for functools32 17:00:35 INFO - warning: no files found matching '*.txt' 17:00:35 INFO - no previously-included directories found matching 'build' 17:00:35 INFO - no previously-included directories found matching 'dist' 17:00:35 INFO - no previously-included directories found matching '.git*' 17:00:35 INFO - Successfully installed jsonschema functools32 17:00:35 INFO - Cleaning up... 17:00:35 INFO - Return code: 0 17:00:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:35 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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:35 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:00:35 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:00:35 INFO - Using env: {'DISPLAY': ':0', 17:00:35 INFO - 'HOME': '/home/cltbld', 17:00:35 INFO - 'LANG': 'en_US.UTF-8', 17:00:35 INFO - 'LANGUAGE': 'en_US:en', 17:00:35 INFO - 'LOGNAME': 'cltbld', 17:00:35 INFO - 'MAIL': '/var/mail/cltbld', 17:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:35 INFO - 'MOZ_NO_REMOTE': '1', 17:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:35 INFO - 'NO_EM_RESTART': '1', 17:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:35 INFO - 'PWD': '/builds/slave/test', 17:00:35 INFO - 'SHELL': '/bin/bash', 17:00:35 INFO - 'SHLVL': '1', 17:00:35 INFO - 'TERM': 'linux', 17:00:35 INFO - 'TMOUT': '86400', 17:00:35 INFO - 'USER': 'cltbld', 17:00:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:35 INFO - '_': '/tools/buildbot/bin/python'} 17:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:00:36 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:00:36 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:00:36 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:00:36 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:00:36 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:00:36 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:00:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 INFO - Downloading docopt-0.6.1.tar.gz 17:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:38 INFO - Running setup.py install for blobuploader 17:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:38 INFO - Running setup.py install for requests 17:00:39 INFO - Running setup.py install for docopt 17:00:39 INFO - Successfully installed blobuploader requests docopt 17:00:39 INFO - Cleaning up... 17:00:39 INFO - Return code: 0 17:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:39 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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:39 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:00:39 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:00:39 INFO - Using env: {'DISPLAY': ':0', 17:00:39 INFO - 'HOME': '/home/cltbld', 17:00:39 INFO - 'LANG': 'en_US.UTF-8', 17:00:39 INFO - 'LANGUAGE': 'en_US:en', 17:00:39 INFO - 'LOGNAME': 'cltbld', 17:00:39 INFO - 'MAIL': '/var/mail/cltbld', 17:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:39 INFO - 'MOZ_NO_REMOTE': '1', 17:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:39 INFO - 'NO_EM_RESTART': '1', 17:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:39 INFO - 'PWD': '/builds/slave/test', 17:00:39 INFO - 'SHELL': '/bin/bash', 17:00:39 INFO - 'SHLVL': '1', 17:00:39 INFO - 'TERM': 'linux', 17:00:39 INFO - 'TMOUT': '86400', 17:00:39 INFO - 'USER': 'cltbld', 17:00:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:39 INFO - '_': '/tools/buildbot/bin/python'} 17:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:39 INFO - Running setup.py (path:/tmp/pip-U_fhyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:39 INFO - Running setup.py (path:/tmp/pip-VHZv5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:39 INFO - Running setup.py (path:/tmp/pip-4B5d7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:39 INFO - Running setup.py (path:/tmp/pip-TzZIv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:39 INFO - Running setup.py (path:/tmp/pip-MyEBy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:39 INFO - Running setup.py (path:/tmp/pip-eXhMmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:40 INFO - Running setup.py (path:/tmp/pip-OX3TLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:40 INFO - Running setup.py (path:/tmp/pip-rgcUFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:40 INFO - Running setup.py (path:/tmp/pip-426FhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:40 INFO - Running setup.py (path:/tmp/pip-2DBiVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:40 INFO - Running setup.py (path:/tmp/pip-xwrlxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:40 INFO - Running setup.py (path:/tmp/pip-jqa5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:40 INFO - Running setup.py (path:/tmp/pip-b8yv7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:40 INFO - Running setup.py (path:/tmp/pip-glg896-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:40 INFO - Running setup.py (path:/tmp/pip-DKGuaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:40 INFO - Running setup.py (path:/tmp/pip-Xn4YtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:40 INFO - Running setup.py (path:/tmp/pip-8u7N66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:40 INFO - Running setup.py install for manifestparser 17:00:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:40 INFO - Running setup.py install for mozcrash 17:00:41 INFO - Running setup.py install for mozdebug 17:00:41 INFO - Running setup.py install for mozdevice 17:00:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozfile 17:00:41 INFO - Running setup.py install for mozhttpd 17:00:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozinfo 17:00:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozInstall 17:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozleak 17:00:41 INFO - Running setup.py install for mozlog 17:00:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for moznetwork 17:00:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozprocess 17:00:42 INFO - Running setup.py install for mozprofile 17:00:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozrunner 17:00:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozscreenshot 17:00:42 INFO - Running setup.py install for moztest 17:00:42 INFO - Running setup.py install for mozversion 17:00:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:42 INFO - Cleaning up... 17:00:42 INFO - Return code: 0 17:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:42 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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:42 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:00:42 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:00:42 INFO - Using env: {'DISPLAY': ':0', 17:00:42 INFO - 'HOME': '/home/cltbld', 17:00:42 INFO - 'LANG': 'en_US.UTF-8', 17:00:42 INFO - 'LANGUAGE': 'en_US:en', 17:00:42 INFO - 'LOGNAME': 'cltbld', 17:00:42 INFO - 'MAIL': '/var/mail/cltbld', 17:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:42 INFO - 'MOZ_NO_REMOTE': '1', 17:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:42 INFO - 'NO_EM_RESTART': '1', 17:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:42 INFO - 'PWD': '/builds/slave/test', 17:00:42 INFO - 'SHELL': '/bin/bash', 17:00:42 INFO - 'SHLVL': '1', 17:00:42 INFO - 'TERM': 'linux', 17:00:42 INFO - 'TMOUT': '86400', 17:00:42 INFO - 'USER': 'cltbld', 17:00:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:42 INFO - '_': '/tools/buildbot/bin/python'} 17:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:42 INFO - Running setup.py (path:/tmp/pip-x7a3DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:42 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:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:42 INFO - Running setup.py (path:/tmp/pip-ujet26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:42 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:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:42 INFO - Running setup.py (path:/tmp/pip-SVr4L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:43 INFO - Running setup.py (path:/tmp/pip-PU9EDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:43 INFO - Running setup.py (path:/tmp/pip-Ce5HHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:43 INFO - Running setup.py (path:/tmp/pip-ul8nJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:43 INFO - Running setup.py (path:/tmp/pip-337f6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:43 INFO - Running setup.py (path:/tmp/pip-IZe5bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:43 INFO - Running setup.py (path:/tmp/pip-hbOjUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:43 INFO - Running setup.py (path:/tmp/pip-R1uICO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:43 INFO - Running setup.py (path:/tmp/pip-_zlzME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:43 INFO - Running setup.py (path:/tmp/pip-oBmDk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:43 INFO - Running setup.py (path:/tmp/pip-ULIAzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:43 INFO - Running setup.py (path:/tmp/pip-LaE929-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:43 INFO - Running setup.py (path:/tmp/pip-dgfFDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:43 INFO - Running setup.py (path:/tmp/pip-V9gusQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:43 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:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:43 INFO - Running setup.py (path:/tmp/pip-5R7Tfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:44 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:00:44 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:00:44 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:00:44 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:00:44 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:00:44 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:00:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00: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:00: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:00: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:00: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:00: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:00: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:00:45 INFO - Downloading blessings-1.6.tar.gz 17:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:46 INFO - Installing collected packages: blessings 17:00:46 INFO - Running setup.py install for blessings 17:00:46 INFO - Successfully installed blessings 17:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:46 INFO - Reading from file tmpfile_stdout 17:00:46 INFO - Current package versions: 17:00:46 INFO - argparse == 1.2.1 17:00:46 INFO - blessings == 1.6 17:00:46 INFO - blobuploader == 1.2.4 17:00:46 INFO - docopt == 0.6.1 17:00:46 INFO - functools32 == 3.2.3-2 17:00:46 INFO - jsonschema == 2.5.1 17:00:46 INFO - manifestparser == 1.1 17:00:46 INFO - mozInstall == 1.12 17:00:46 INFO - mozcrash == 0.17 17:00:46 INFO - mozdebug == 0.1 17:00:46 INFO - mozdevice == 0.48 17:00:46 INFO - mozfile == 1.2 17:00:46 INFO - mozhttpd == 0.7 17:00:46 INFO - mozinfo == 0.9 17:00:46 INFO - mozleak == 0.1 17:00:46 INFO - mozlog == 3.2 17:00:46 INFO - moznetwork == 0.27 17:00:46 INFO - mozprocess == 0.23 17:00:46 INFO - mozprofile == 0.28 17:00:46 INFO - mozrunner == 6.12 17:00:46 INFO - mozscreenshot == 0.1 17:00:46 INFO - mozsystemmonitor == 0.3 17:00:46 INFO - moztest == 0.7 17:00:46 INFO - mozversion == 1.4 17:00:46 INFO - psutil == 3.1.1 17:00:46 INFO - requests == 1.2.3 17:00:46 INFO - wsgiref == 0.1.2 17:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 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 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00:46 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:00:46 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:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 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:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00: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:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00: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'] in /builds/slave/test/build 17:00: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 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:00: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:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27c4dcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, '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': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', '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:00: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', 'flake8'] in /builds/slave/test/build 17:00: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 flake8 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:47 INFO - Downloading/unpacking flake8 17:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00: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:00: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:00: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:00: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:00: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:00: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:00:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:49 INFO - no previously-included directories found matching 'docs/_build' 17:00:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:49 INFO - Running setup.py install for pep8 17:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:49 INFO - no previously-included directories found matching 'docs/_build' 17:00:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:00:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:49 INFO - Cleaning up... 17:00:49 INFO - Return code: 0 17:00:49 INFO - Running post-action listener: _resource_record_post_action 17:00:49 INFO - Running post-action listener: _start_resource_monitoring 17:00:49 INFO - Starting resource monitoring. 17:00:49 INFO - ##### 17:00:49 INFO - ##### Finished create-virtualenv step (success) 17:00:49 INFO - ##### 17:00:49 INFO - ##### 17:00:49 INFO - ##### Running install step. 17:00:49 INFO - ##### 17:00:49 INFO - Running pre-action listener: _resource_record_pre_action 17:00:49 INFO - Running main action method: install 17:00:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:50 INFO - Reading from file tmpfile_stdout 17:00:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:50 INFO - Reading from file tmpfile_stdout 17:00:50 INFO - Output received: 17:00:50 INFO - Usage: mozinstall [options] installer 17:00:50 INFO - Options: 17:00:50 INFO - -h, --help show this help message and exit 17:00:50 INFO - -d DEST, --destination=DEST 17:00:50 INFO - Directory to install application into. [default: 17:00:50 INFO - "/builds/slave/test"] 17:00:50 INFO - --app=APP Application being installed. [default: firefox] 17:00:50 INFO - mkdir: /builds/slave/test/build/application 17:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:01:03 INFO - Reading from file tmpfile_stdout 17:01:03 INFO - Output received: 17:01:03 INFO - /builds/slave/test/build/application/firefox/firefox 17:01:03 INFO - Running post-action listener: _resource_record_post_action 17:01:03 INFO - ##### 17:01:03 INFO - ##### Finished install step (success) 17:01:03 INFO - ##### 17:01:03 INFO - ##### 17:01:03 INFO - ##### Running run-tests step. 17:01:03 INFO - ##### 17:01:03 INFO - Running pre-action listener: _resource_record_pre_action 17:01:03 INFO - Running main action method: run_tests 17:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:01:03 INFO - Python 2.7.3 17:01:03 INFO - Return code: 0 17:01:03 INFO - grabbing minidump binary from tooltool 17:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:03 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 0x10962e0>, '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 0x1002140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10025d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:01:03 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:01:03 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:01:03 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:01:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:01:03 INFO - Return code: 0 17:01:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:01:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:01:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:01:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:01:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:01:04 INFO - Return code: 0 17:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:01:04 INFO - Using env: {'DISPLAY': ':0', 17:01:04 INFO - 'HOME': '/home/cltbld', 17:01:04 INFO - 'LANG': 'en_US.UTF-8', 17:01:04 INFO - 'LANGUAGE': 'en_US:en', 17:01:04 INFO - 'LOGNAME': 'cltbld', 17:01:04 INFO - 'MAIL': '/var/mail/cltbld', 17:01:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:01:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:04 INFO - 'MOZ_NO_REMOTE': '1', 17:01:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:04 INFO - 'NO_EM_RESTART': '1', 17:01:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:04 INFO - 'PWD': '/builds/slave/test', 17:01:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:01:04 INFO - 'SHELL': '/bin/bash', 17:01:04 INFO - 'SHLVL': '1', 17:01:04 INFO - 'TERM': 'linux', 17:01:04 INFO - 'TMOUT': '86400', 17:01:04 INFO - 'USER': 'cltbld', 17:01:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236', 17:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:04 INFO - '_': '/tools/buildbot/bin/python'} 17:01:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:01:04 INFO - mozversion application_buildid: 20160803141223 17:01:04 INFO - mozversion application_changeset: 02304924791d467a6efe240d9012c02d91fe4703 17:01:04 INFO - mozversion application_display_name: Firefox 17:01:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:01:04 INFO - mozversion application_name: Firefox 17:01:04 INFO - mozversion application_remotingname: firefox 17:01:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:01:04 INFO - mozversion application_vendor: Mozilla 17:01:04 INFO - mozversion application_version: 49.0 17:01:04 INFO - mozversion platform_buildid: 20160803141223 17:01:04 INFO - mozversion platform_changeset: 02304924791d467a6efe240d9012c02d91fe4703 17:01:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:01:04 INFO - mozversion platform_version: 49.0 17:01:04 INFO - using testdate: 1470268864 17:01:04 INFO - actual date: 1470268864 17:01:04 INFO - starting webserver on 'localhost:35144' 17:01:04 INFO - SUITE-START | Running 2 tests 17:01:04 INFO - TEST-START | dromaeo_css 17:01:04 INFO - operating with platform_type : linux_ 17:01:04 INFO - Initialising browser for dromaeo_css test... 17:01:04 INFO - TEST-INFO | started process 5349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8l2Le/profile http://localhost:35144/getInfo.html) 17:01:09 INFO - PROCESS | 5349 | __metrics Screen width/height:1600/1200 17:01:09 INFO - PROCESS | 5349 | colorDepth:24 17:01:09 INFO - PROCESS | 5349 | Browser inner width/height: 1024/697 17:01:09 INFO - PROCESS | 5349 | __metrics 17:01:10 ERROR - PROCESS | 5349 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:01:11 INFO - TEST-INFO | 5349: exit 0 17:01:11 INFO - Browser initialized. 17:01:11 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:11 INFO - TEST-INFO | started process 5476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8l2Le/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:22 INFO - PROCESS | 5476 | RSS: Main: 153423872 17:01:22 INFO - PROCESS | 5476 | 17:02:12 INFO - PROCESS | 5476 | 1470268932536 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:04:20 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35144/tests/dromaeo/cssquery-ext.html) 17:04:21 INFO - PROCESS | 5476 | RSS: Main: 157700096 17:04:21 INFO - PROCESS | 5476 | 17:07:23 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-ext.html (next: http://localhost:35144/tests/dromaeo/cssquery-jquery.html) 17:07:24 INFO - PROCESS | 5476 | RSS: Main: 155062272 17:07:24 INFO - PROCESS | 5476 | 17:10:25 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35144/tests/dromaeo/cssquery-mootools.html) 17:10:26 INFO - PROCESS | 5476 | RSS: Main: 154341376 17:10:26 INFO - PROCESS | 5476 | 17:13:28 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35144/tests/dromaeo/cssquery-prototype.html) 17:13:28 INFO - PROCESS | 5476 | RSS: Main: 155623424 17:13:28 INFO - PROCESS | 5476 | 17:16:31 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35144/tests/dromaeo/cssquery-yui.html) 17:16:31 INFO - PROCESS | 5476 | RSS: Main: 153890816 17:16:31 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-yui.html (next: http://localhost:35144/tests/dromaeo/cssquery-dojo.html) 17:19:34 INFO - PROCESS | 5476 | RSS: Main: 157511680 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | __start_tp_report 17:19:34 INFO - PROCESS | 5476 | _x_x_mozilla_page_load 17:19:34 INFO - PROCESS | 5476 | _x_x_mozilla_page_load_details 17:19:34 INFO - PROCESS | 5476 | |i|pagename|runs| 17:19:34 INFO - PROCESS | 5476 | |0;dojo.html;3429.022728522372;3432;3450.1374656335925;3465.4282043462813;3471.87848425305;5721.713914304284;5728.6562806231605;5758.078707406816;5783.306003279612;5809.506191973687;5755.798547050854;5798.188253644493;5824.563157763164;5827.329857066438;5859.501942334896;5104.05574968631;5165.509276618715;5204.947950520503;5252.894942101156;5260.289860868791;5135.35808023997;5146.305248791421;5246.632735708502;5253.395859476152;5257.789688412478;5106.821261255856;5163.251328557357;5187.014467251229;5213.426523082458;5279.076161671692;5212.400573934008;5230.032443997872;5280.313559237313;5300.708461034642;5313.681179129265;5195.324607801;5214;5267.683938963636;5287.391949925731;5289.845687929002;5451.754671039813;5528.198411230349;5532.419095994903;5534.4742249486635;5582.665040097567;6088.595852493199;6095.512359011268;6119.624418755179;6161.4146656067605;6184.907226391608;6223.973044447661;6235.844103897393;6236.844078898019;6245.843853903643;6254.437100660917;5591.8881622367735;5745.425457454263;5804.59367844251;5805.767769289266;5848;6388.297287298394;6409.4231519163495;6418.935810641927;6444.097826304321;6451.451626611697;6070.605410648293;6156.353582873823;6189.938100619026;6190.978488549339;6201.441870231701;5994.67029313392;6141.048137538689;6215.409536094064;6249.96875015622;6279.152314437584;6165.568410211242;6168.814935551941;6175.783847565313;6205.751769929243;6206.131141640174;6185.783497577563;6202.596831205957;6221.3778622138325;6224.128621992924;6230.59501132425;4645.837395691135;4651.348811166439;4681.578657920803;4701.130290896127;4709.222978208626;4190.638042636156;4214.831406743696;4224.070704445017;4250;4251.213525497793;5764.365919748824;5928.970355148197;5958.46373826349;5961.970190149022;5989.79035733756;6049.455549000611;6125.815438131368;6140.749659041545;6182.752689892354;6207.379262073847;5961.701914904237;5962.761489540369;5998.7300571473515;6013.51891848651;6015.0676645120075;5194.3247377840635;5349.277847490617;5358.946410535923;5359.062164121263;5381.973090134525;6375.23497180332;6397.328280530477;6405.19935008124;6522.249941256721;6524.478041756648;6286.622802631857;6293.905591416133;6299.370062993664;6307.36926307384;6311.116443697794;6142.999999999821;6251.6874156292915;6538.215414150332;6559.7376104955265;6569.638669873012;5995.040793473024;6107.6640784757265;6112.1995365628145;6115.694215289129;6138.5396095292135;6164.815055548341;6210.347913469202;6218.689065546795;6224.688765561613;6225.750969961332;5846.6784326862435;6029.3669164737075;6043.576949613484;6047.969760151347;6055.273367195965;6036;6088.269407671108;6096.993995990611;6103.938960610337;6135.417135372132;6001.2498437695285;6024.698765061642;6032.306284777307;6050.878982420415;6067.757289708539;5734.770609175586;5822.039363504974;5825.126231065374;5910.852228694317;6171.259448866164;5748.48263656273;5754.194412782297;5759;5759.424057594207;5760.423957604206 17:19:34 INFO - PROCESS | 5476 | |1;ext.html;594.3313772006493;654.5156584127745;658.3021996683519;669.9933000669994;680.2924958043635;41811.79094104529;45577;46285.76857115714;46319;46420.999999999956;45721.54278457214;46805.297920531135;46814.531854681445;46822.53177468224;46908;8921.821563568725;9093.636254549843;9095.909040909606;9100.317476189279;9127.634894604207;8940.552972351388;8970.416922900024;9009.684661036865;9042.869641294837;9053.637854485845;8860.24687901529;8878.911210887905;8885.333599979995;8893;8937.73186804397;8879.467231966102;8945.597448114786;8957.686480973167;8970.775730606754;8980.730578082668;8902.465852048897;9007.279417646572;9007.414518056305;9008.099190081006;9012.729618111467;41675.58324416778;41969.37045944313;41990.16019679589;41999;42040.579594204275;3510.052285882797;3613.8193090345376;3643.6720695137565;3661.3226553087766;3934.0558266016237;33246.50130248048;33315.500267496005;33479.6652033479;34086.829565852015;34322.48516272258;3838.2323535293053;3838.347480928249;3846.442265871433;3853.8843834685003;3877.6510114089583;385913;388434;388557;389444;389482;65704.34295657078;66254.33745662482;66304.6684766573;66325.6683716588;66416.33583664101;40369.39445908314;40605.59394406077;40972.79513602413;42988.355174672404;43112.56887431148;19113.808861911482;19185.424437266905;19414.417567473;19431;19490.415287541397;14449.927750361181;14543.20012399307;14618.707625847423;14632.19522926228;14656.120632761855;21983.890080549816;22077;22084.227052053102;22199.779012154486;22211.66682499764;7678.308952194217;7711.26742959418;7830.960845195737;7884;7978.880316795136;1049.8530205771199;1089.2593036734938;1175.8706542280343;1178.7465694875643;1188.8216767484773;33407.665923340945;33456.66543334584;33696.83151584226;33714.325713485596;33902.49146262808;1157.739508610556;1179.151011271883;1179.7935361311736;1231.2920070959235;1243.0118056145386;17343.3062677494;17602.11989400525;17623.118844057746;17807.376741814234;17844.55388615295;568493;580300;580337;587029;588591;61005.694971524856;61481;61639;61751.69124154351;61924.38075619186;1529.8852586055868;1539.961500962485;1558.1741676911256;1565.1235308227429;1586.7064593050322;31466.52800207953;31576.526352105197;32003.199920002186;32233.194170145933;32599.18502037468;53745.19382209192;54472.45527544674;54497.45502545082;54544;54550.18174727462;408045;410786;412217;413322;414980;30192.84903575556;30421.543676845307;30945.535816963213;30955.0713478596;31069.378612427172;48903.75548122237;48927.26609100795;48957;49531.75234123806;49864.75067624639;40974.59025409708;41218;41568;41872;42897.35653965255;40652.39021414622;41786;42185.789071054445;42279.577204227564;42826;41246.58753412427;41526;41554;42340.576594234895;42412.575874240865;34879.302413952086;35006.47490287597;35341;35628.82185589056;35847.64152358443;27771.583426249028;28174.2956426091;28344.14967550977;28355.57466637961;28424.715752842207 17:19:34 INFO - PROCESS | 5476 | |2;jquery.html;420.77278269734325;428.17148817039015;430.75016490435553;434.2639226511063;441.69743725548;18789;19600.50998725031;20381.49046273842;20442.2845200418;20465.079071441785;18835.058247087658;18866.339678111235;19528.121234544444;19724.901375493104;19739;5588.944110558903;5788.623739456922;5800.390958949313;5806.390329015456;5806.767729290823;5585.385607583163;5727.34135574408;5728.971355143219;5763.135529670562;5788.6237394569425;5706.258186435757;5740.942590574083;5741.397153298906;5747.971260143693;5756.107803290476;5530.861728456801;5692.146178073281;5722.942770572304;5729.770809167629;5735.569832262576;5123.1546794778815;5155.61332900034;5163.612729045337;5188.792448302063;5192.428832828424;22523.211687591018;23032.193873214357;23549.29352119439;23656.763432365628;23781.405464863343;2216.9224077157382;2233.039792889057;2275.6017696902977;2566.2814411964678;2801.033643393026;14900.850991490055;14905.925470372578;14956.850431495655;15190.164540950243;15323;1863.0870873272;1904.277899016474;1904.9142788574547;1912.1395372082618;1914.4065339744723;78110.6094469524;78117.60941195258;78228.60885695535;79317.20682793156;80344.19655803425;10907.563697452013;11175.105991520659;11233.438328083726;11262.549498019987;11508.712282192844;15696.76454853178;15750.68498630021;15787.763183552255;15797.68404631901;15805.446809361618;8859.335549833659;8884.777880553038;8957.14907083839;9019.503927283931;9131.680391186277;8849.469031858109;8857.158569935846;8886.86669699955;8939.910600893907;8994.685186018458;6967.303269672992;6972.4073453757;7074.752383666547;7109.964450177716;7117.252688467636;1980.7127966444784;2001.8198362147477;2015.1435639853005;2025.7062725904661;2041.428400047989;1062.3519653011656;1065.616378103882;1083.3554035348955;1136.363636363639;1213.7269114449177;18588.535286617673;18722.344717934808;19393.806061939482;19567.510812229524;19760.60478790416;1025.7128004158847;1054.1303424674675;1058.7088550648634;1059.9576016959236;1064.7799338379411;10217.795644087077;10474.423906685206;10543.84184237237;10548.261621686563;10649.627263045757;382806;386884;388827;522642;548587;101195.37448567794;102532;106301.46849265705;106815.46592266989;106872;1095.9616413425492;1101.730076131353;1114.3258328711013;1135.1769966773857;1135.2961164078158;17434.73847892308;17496.91251543785;17529.56176095608;17657.82342176613;17903;40464.59535404726;41070;42248.5775142257;42550;43166.352504711824;56082;56957.43042569687;59760.10359844693;60017.39982600118;61829.690851545456;8130.674773009014;8263.256306932404;8304.335653147855;8361;8428;11524.654260372203;12752.171108877894;12775.23348599087;12797.872021279669;12934.288614126313;8215.712450064219;11008.669739907815;11161;11303.773924521627;11361.715957100809;11105.555777768799;11234.55061797519;11275.605353812578;11405.828912566483;11541.538338466704;11416.31502109876;11540.192186547198;11670;12035.45840437165;12120.696982575506;8176.877346839921;8187.79530511742;8218.671253149807;8311.542865142475;8314.293285070837;10786.352818830896;10957.287776294515;11330.60342887995;11337.773244535229;11448.084153267886 17:19:34 INFO - PROCESS | 5476 | |3;mootools.html;1552.2859484637067;1604.4625050608047;1855.2300795170006;1929.7008963610645;1975.8913259770716;8643.0924752901;9338.579763910624;9440.527973601327;10024.39853608783;10031.699049028522;9487.051294870527;9766.951165244182;9769.70690879273;9816.361936474124;9869.309148359618;2512.397024714069;2555;2556.987215063922;2557.1177943609423;2557.884895179712;2450.9754902451014;2518.848869067862;2519.0301733832516;2522.5963845784677;2527.166035208386;2493.164789795421;2525.053105085593;2556.2586849813624;2557.6035714464288;2570.4345044090364;2474.072222916406;2482.751724827521;2488.6267059940974;2525.393905462694;2530.367408147963;2401.2556107606697;2415.1546958564536;2415.3961509622595;2436.1595249638845;2483.242611003643;9791.853122203172;9898.703038908845;9912.752181195456;9913.107820296136;9921.355111917703;5797.855053623651;5952.285725712899;5955.166276721263;5959.761609535613;5961.672108034057;3590.4075827488696;3598.802065886375;3634.527511423498;3701.3707669695946;3795.3737633290475;1119.149446420718;1132.5356603792488;1168.6669299249759;1198.4726720243152;1207.0584943743893;13723.588292351245;13744.381502832397;13753.587392378144;13768.105073170213;13772.10481318721;5097.108006098918;5120.846374608767;5137.588992880561;5248.317718696621;5270.894582108336;11571.826422603668;11606.129540284512;11615.070794336432;11647.30116193031;11655.708607284716;5858.121281807677;5933.703314834241;5934.851628709231;5937;5938.465538101592;4760.619150467955;5118.411382690963;5341.732913354394;5354.41101478837;5417.322834645669;4375.343698445258;4426.557344265548;4486.2597671383855;4495.977520112444;4563.06457176278;1403.6631208509884;1425.3942074618453;1438.9352479138463;1446.1395469695515;1448.2903377345026;822.3626689315709;888.2716172738421;962.6197651927449;1003.4781913404988;1005.5726316315537;6100.267967843798;6242.531810114259;6309.652969086653;6341.619502829845;6372.235331760218;482.57051224410304;484.9054434385261;488.81180745413275;490.0590865538175;496.53573908395765;4115.855945041909;4312.956870431255;4314.935275970863;4316.6546676265825;4317.00708836963;11935.224210426295;12241.265524068584;12257.448414821354;12275;12327.383630818424;11206.21556491054;11638.243514171721;11653.766924661459;11825.645230643095;11910.52357905674;8950.776230594158;9222.44665320083;9239.260859131253;9263.536823158815;9264.722058338395;6477.190351206099;6681.498887583548;6740.730370785113;6784.3554862288;6906.896396554156;10755.838662419914;11028;11069.944650276697;11078.11375090007;11182.888171118184;11001.61494347694;11004.504797283982;11290.15323850698;11314.773704526027;11316.37759923212;8450.492970421794;8667.263282621048;8685.522296273766;8694;8757.299416046573;9530.618775248913;9570.95214523923;9591.760205994906;9641.614335426504;9655.324127311022;8378.162183781573;8601.82796344082;8646.351523635878;8731.869021964803;8774.56127193625;8356.206160414751;8398.202170793766;8431.030431500456;8432.747017589481;8683.348748843988;7863.017122859643;7876.72431464896;7914.722984695508;7972.202779721982;7977.760667179994;5367.463253674601;5490.862728431821;5557.777688892399;5593.0771422716425;5637.408072152365;5298.7350632469;5594.9720251398485;5595.384507704068;5686.914696279642;5715.885682286248 17:19:34 INFO - PROCESS | 5476 | |4;prototype.html;366.9376206044972;367.35162438296396;367.6470588235295;368.17345060339534;370.82385866713315;5585.245991791107;5633.943660563393;5722.427757224275;5723.771049158034;5797.478226959578;5603.80386686466;5653.604247702662;5678.744456499458;5691.573132015105;5710.1434784782305;4448.266036104039;4453.755043472608;4485.461744590653;4500.189965806154;4535.931961020588;4414.3378493225955;4420.359047938063;4451.332300154971;4488.685791994561;4533.750643714594;4363.410939523155;4409.603135717784;4416.425864637608;4416.984093658461;4465.307877279027;4404.977975110136;4424.84513042042;4436.800343984496;4461.24158892989;4490.371348011281;3864.555576108727;4001.979990100031;4011.438398624195;4014.6149578395407;4015.859444919414;5549.38956714761;5559.749811258503;5570.805021824257;5571.860703482445;5573.749181286852;5156.432792392834;5174.3790745110455;5185.870353241162;5218.765155568009;5263.894722105575;5951.3219051426595;6016.308124565643;6020.96989515054;6037.54718396122;6060.515158787331;4429.75966729313;4459.754713490756;4461.754603496806;4466.821327146943;4489.416375871116;6049.153118563405;6213.875722485525;6225.260885210493;6255.717577896566;6305.653189074599;4538.931916021263;4556.88607784808;4570.223062079454;4572.9314060289125;4573.6569757268335;4627.514111018362;4635.814567417266;4637.188492013952;4639.559241872017;4640.605548528413;4931.358923340014;5196.558292545176;5204.297419848348;5206.3752349717515;5217.808520421357;5862.267216597926;6049.1833602463985;6072.6336574270435;6089.360617135226;6111.960966635683;1596.6806638672313;1606.7991501062368;1611.1944027986008;1619.4170098764434;1621.3057355063986;1038.3665963762098;1039.4906495816995;1040.2770074798093;1048.4600430778155;1060.8886066963012;5250;5287.391949925731;5300.284461597635;5323.893522129536;5345.705986170798;5581.5255703265675;5618.162827771949;5619.7471113799975;5622.803201887914;5667.631603945731;5351.973240133852;5406.378266499403;5489.807856724996;5932.584719069624;5933.6736479493175;3276.410246155667;3286.9342613147605;3295.8516866740574;3295.9011229663147;3296.587926509186;6222.191115155001;6452.612843229421;6452.935470645328;6455.677216139175;6465.870682586322;6318.08387783778;6322.3561873912195;6327.430531252209;6327.797718433483;6331.683415829282;6401.911675015259;6426.935730642727;6471;6476.352364763486;6483.448906842971;5875.588708790515;6260.467860231749;6266.655333956493;6267.373262673878;6284.874302514016;6144.938550614615;6169.290531588925;6173.6913154343;6173.84565385869;6186.752529898754;6236.594621349598;6470.288268290578;6478.6760661967655;6503.642299673564;6540.50946179029;4422.933655995098;4456.2647163219;4482.8879278017;4490.820367185276;4503.842365517191;5872.1778950947755;6069.150318955438;6271.209311856363;6273.435390814849;6305.8108256752375;6041.6375017499095;6043.425874541911;6055.485283750931;6056.9091463628965;6060.484858786876;5976.372480889444;5981.162637230704;6006.33930267679;6012.218411606463;6041.305249896318;5641.238432811682;5940.61386009908;5944.970275148597;5971.940280597139;5975.16347711312;6064.666443345658;6079.513638908788;6082.749382728419;6085.391460853879;6108.267007958895;5759.769609215585;5867.618604790846;5943.64338139713;5960.701964901824;6010.287068185547 17:19:34 INFO - PROCESS | 5476 | |5;yui.html;708.7519368221126;715.2561336210341;760.6501009535614;794.249434284601;838.6729175621507;14800.259987000647;14833;14856.55430337089;15002.924985375057;15299.84700152998;14387.856121438783;14531.055481393701;14625.853741462583;14723.631909202275;14756.335964881579;872.4939535069644;881.2861582118488;893.2630579771682;906.8866391701038;908.5275656658566;906.60109551797;910.6721580231111;912.6121398405684;912.9817403651923;914.419343716738;938.9530523473833;939.5302348825587;940.5203346293371;945.5366870233605;951.7335146159052;936.4989730494153;939.6476321379482;941.0495399646338;942.0532364973158;942.29328003997;692.4322055914153;692.9826754331132;693.1093544794915;693.9757108501178;694.1080711285973;15837.92081039599;15914;15945.681086378323;15982.360705571764;16014.279357428944;14898.851011489854;15206.771898421532;15207;15433.845661543353;15489.612759680986;11029.944850275697;11101;11146.275492092987;11235.887641123565;11242.887571124347;3870.8838734838;3878.8514955413543;3889.397143442771;3890.5914878937588;3928.508936382952;82714.58642706748;83648.58175709083;84143.15856841415;84379.15620843774;85859.14140858637;10251.58993640246;10626.73433164177;10628.734281643021;10658.094062004817;10690.35857848516;21707.674384884238;21865.890670546545;21877.562448750938;21949;22415.43961400978;7766.330238998642;7801.726939557088;8019.5990200490905;8043.517388956681;8176.3458923286;4572.359869618256;4582;4619.9076018479445;4631;4648.302754586839;3647.9635203648154;3779.2063666629765;3813.828377723009;3822.2928758179823;3826.5025546678753;635.1171871099176;639.338284875152;639.8432384065934;641.0288413054227;642.5534253693638;654.2312782480566;695.7495301691387;709.2729951799447;715.3919168706661;720.0962791696387;8904.154105359981;9062.04848490912;9225.769355766159;9308.069193080773;9352.53237338144;643.5784561112479;654.3162395296927;664.5315052887703;688.404530081486;699.1610067918518;4540.500544940054;4547.567981041796;4624.791884365211;4657.650676199299;4659.5573420525;74040.62979685175;113106.43446782713;118623;119811;120257.39871300763;73218.63390683013;76912;94872.52563737275;103547.4822625897;107689;88520.5573972126;92601;92802;93576;94490.52754736182;8353.83292334162;8376.916230837858;8476.660933562589;8607.784805379915;8649.8702519461;40344;46589.53410465988;49761.50238497713;52552;54004.459955401515;58889;74587.62706186435;77690.22309777056;77799.61100194464;78545;12503.499860005499;12904;12932.224066556037;13027.934860326017;13040.54358097462;14649.707005860037;14766.261686915397;15027.323770430576;15114.829625345164;15175.848241517444;13599.184048957095;13804.447822087004;13812.240326782123;14028.438862445388;14056.226907520184;12989.28558929268;13023.739525209254;13025.934870325587;13057.869421305666;13073.346332683517;13296.135751176143;13675;13788.379522921292;13876.791848122488;13902.096363736326;11032.84859452399;11464.484098215433;11477.483513241757;11674.649760507198;11811.82282265784;11381.47174375946;11658.88341116578;11691.240069395462;11718.941405292919;11758.412079396167 17:19:34 INFO - PROCESS | 5476 | __end_tp_report 17:19:34 INFO - PROCESS | 5476 | __start_cc_report 17:19:34 INFO - PROCESS | 5476 | _x_x_mozilla_cycle_collect,326 17:19:34 INFO - PROCESS | 5476 | __end_cc_report 17:19:34 INFO - PROCESS | 5476 | __startTimestamp1470269974394__endTimestamp 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | ------- Summary: start ------- 17:19:34 INFO - PROCESS | 5476 | Number of tests: 6 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#0] dojo.html Cycles:165 Average:5741.66 Median:5994.67 stddev:657.51 (11.0%) stddev-sans-first:634.00 17:19:34 INFO - PROCESS | 5476 | Values: 3429.0 3432.0 3450.1 3465.4 3471.9 5721.7 5728.7 5758.1 5783.3 5809.5 5755.8 5798.2 5824.6 5827.3 5859.5 5104.1 5165.5 5204.9 5252.9 5260.3 5135.4 5146.3 5246.6 5253.4 5257.8 5106.8 5163.3 5187.0 5213.4 5279.1 5212.4 5230.0 5280.3 5300.7 5313.7 5195.3 5214.0 5267.7 5287.4 5289.8 5451.8 5528.2 5532.4 5534.5 5582.7 6088.6 6095.5 6119.6 6161.4 6184.9 6224.0 6235.8 6236.8 6245.8 6254.4 5591.9 5745.4 5804.6 5805.8 5848.0 6388.3 6409.4 6418.9 6444.1 6451.5 6070.6 6156.4 6189.9 6191.0 6201.4 5994.7 6141.0 6215.4 6250.0 6279.2 6165.6 6168.8 6175.8 6205.8 6206.1 6185.8 6202.6 6221.4 6224.1 6230.6 4645.8 4651.3 4681.6 4701.1 4709.2 4190.6 4214.8 4224.1 4250.0 4251.2 5764.4 5929.0 5958.5 5962.0 5989.8 6049.5 6125.8 6140.7 6182.8 6207.4 5961.7 5962.8 5998.7 6013.5 6015.1 5194.3 5349.3 5358.9 5359.1 5382.0 6375.2 6397.3 6405.2 6522.2 6524.5 6286.6 6293.9 6299.4 6307.4 6311.1 6143.0 6251.7 6538.2 6559.7 6569.6 5995.0 6107.7 6112.2 6115.7 6138.5 6164.8 6210.3 6218.7 6224.7 6225.8 5846.7 6029.4 6043.6 6048.0 6055.3 6036.0 6088.3 6097.0 6103.9 6135.4 6001.2 6024.7 6032.3 6050.9 6067.8 5734.8 5822.0 5825.1 5910.9 6171.3 5748.5 5754.2 5759.0 5759.4 5760.4 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#1] ext.html Cycles:180 Average:62374.19 Median:414151.00 stddev:124246.06 (30.0%) stddev-sans-first:124508.01 17:19:34 INFO - PROCESS | 5476 | Values: 594.3 654.5 658.3 670.0 680.3 41811.8 45577.0 46285.8 46319.0 46421.0 45721.5 46805.3 46814.5 46822.5 46908.0 8921.8 9093.6 9095.9 9100.3 9127.6 8940.6 8970.4 9009.7 9042.9 9053.6 8860.2 8878.9 8885.3 8893.0 8937.7 8879.5 8945.6 8957.7 8970.8 8980.7 8902.5 9007.3 9007.4 9008.1 9012.7 41675.6 41969.4 41990.2 41999.0 42040.6 3510.1 3613.8 3643.7 3661.3 3934.1 33246.5 33315.5 33479.7 34086.8 34322.5 3838.2 3838.3 3846.4 3853.9 3877.7 385913.0 388434.0 388557.0 389444.0 389482.0 65704.3 66254.3 66304.7 66325.7 66416.3 40369.4 40605.6 40972.8 42988.4 43112.6 19113.8 19185.4 19414.4 19431.0 19490.4 14449.9 14543.2 14618.7 14632.2 14656.1 21983.9 22077.0 22084.2 22199.8 22211.7 7678.3 7711.3 7831.0 7884.0 7978.9 1049.9 1089.3 1175.9 1178.7 1188.8 33407.7 33456.7 33696.8 33714.3 33902.5 1157.7 1179.2 1179.8 1231.3 1243.0 17343.3 17602.1 17623.1 17807.4 17844.6 568493.0 580300.0 580337.0 587029.0 588591.0 61005.7 61481.0 61639.0 61751.7 61924.4 1529.9 1540.0 1558.2 1565.1 1586.7 31466.5 31576.5 32003.2 32233.2 32599.2 53745.2 54472.5 54497.5 54544.0 54550.2 408045.0 410786.0 412217.0 413322.0 414980.0 30192.8 30421.5 30945.5 30955.1 31069.4 48903.8 48927.3 48957.0 49531.8 49864.8 40974.6 41218.0 41568.0 41872.0 42897.4 40652.4 41786.0 42185.8 42279.6 42826.0 41246.6 41526.0 41554.0 42340.6 42412.6 34879.3 35006.5 35341.0 35628.8 35847.6 27771.6 28174.3 28344.1 28355.6 28424.7 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#2] jquery.html Cycles:180 Average:28312.35 Median:11211.46 stddev:75071.53 (669.6%) stddev-sans-first:75252.91 17:19:34 INFO - PROCESS | 5476 | Values: 420.8 428.2 430.8 434.3 441.7 18789.0 19600.5 20381.5 20442.3 20465.1 18835.1 18866.3 19528.1 19724.9 19739.0 5588.9 5788.6 5800.4 5806.4 5806.8 5585.4 5727.3 5729.0 5763.1 5788.6 5706.3 5740.9 5741.4 5748.0 5756.1 5530.9 5692.1 5722.9 5729.8 5735.6 5123.2 5155.6 5163.6 5188.8 5192.4 22523.2 23032.2 23549.3 23656.8 23781.4 2216.9 2233.0 2275.6 2566.3 2801.0 14900.9 14905.9 14956.9 15190.2 15323.0 1863.1 1904.3 1904.9 1912.1 1914.4 78110.6 78117.6 78228.6 79317.2 80344.2 10907.6 11175.1 11233.4 11262.5 11508.7 15696.8 15750.7 15787.8 15797.7 15805.4 8859.3 8884.8 8957.1 9019.5 9131.7 8849.5 8857.2 8886.9 8939.9 8994.7 6967.3 6972.4 7074.8 7110.0 7117.3 1980.7 2001.8 2015.1 2025.7 2041.4 1062.4 1065.6 1083.4 1136.4 1213.7 18588.5 18722.3 19393.8 19567.5 19760.6 1025.7 1054.1 1058.7 1060.0 1064.8 10217.8 10474.4 10543.8 10548.3 10649.6 382806.0 386884.0 388827.0 522642.0 548587.0 101195.4 102532.0 106301.5 106815.5 106872.0 1096.0 1101.7 1114.3 1135.2 1135.3 17434.7 17496.9 17529.6 17657.8 17903.0 40464.6 41070.0 42248.6 42550.0 43166.4 56082.0 56957.4 59760.1 60017.4 61829.7 8130.7 8263.3 8304.3 8361.0 8428.0 11524.7 12752.2 12775.2 12797.9 12934.3 8215.7 11008.7 11161.0 11303.8 11361.7 11105.6 11234.6 11275.6 11405.8 11541.5 11416.3 11540.2 11670.0 12035.5 12120.7 8176.9 8187.8 8218.7 8311.5 8314.3 10786.4 10957.3 11330.6 11337.8 11448.1 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#3] mootools.html Cycles:180 Average:6390.67 Median:483.74 stddev:3698.43 (764.6%) stddev-sans-first:3690.93 17:19:34 INFO - PROCESS | 5476 | Values: 1552.3 1604.5 1855.2 1929.7 1975.9 8643.1 9338.6 9440.5 10024.4 10031.7 9487.1 9767.0 9769.7 9816.4 9869.3 2512.4 2555.0 2557.0 2557.1 2557.9 2451.0 2518.8 2519.0 2522.6 2527.2 2493.2 2525.1 2556.3 2557.6 2570.4 2474.1 2482.8 2488.6 2525.4 2530.4 2401.3 2415.2 2415.4 2436.2 2483.2 9791.9 9898.7 9912.8 9913.1 9921.4 5797.9 5952.3 5955.2 5959.8 5961.7 3590.4 3598.8 3634.5 3701.4 3795.4 1119.1 1132.5 1168.7 1198.5 1207.1 13723.6 13744.4 13753.6 13768.1 13772.1 5097.1 5120.8 5137.6 5248.3 5270.9 11571.8 11606.1 11615.1 11647.3 11655.7 5858.1 5933.7 5934.9 5937.0 5938.5 4760.6 5118.4 5341.7 5354.4 5417.3 4375.3 4426.6 4486.3 4496.0 4563.1 1403.7 1425.4 1438.9 1446.1 1448.3 822.4 888.3 962.6 1003.5 1005.6 6100.3 6242.5 6309.7 6341.6 6372.2 482.6 484.9 488.8 490.1 496.5 4115.9 4313.0 4314.9 4316.7 4317.0 11935.2 12241.3 12257.4 12275.0 12327.4 11206.2 11638.2 11653.8 11825.6 11910.5 8950.8 9222.4 9239.3 9263.5 9264.7 6477.2 6681.5 6740.7 6784.4 6906.9 10755.8 11028.0 11069.9 11078.1 11182.9 11001.6 11004.5 11290.2 11314.8 11316.4 8450.5 8667.3 8685.5 8694.0 8757.3 9530.6 9571.0 9591.8 9641.6 9655.3 8378.2 8601.8 8646.4 8731.9 8774.6 8356.2 8398.2 8431.0 8432.7 8683.3 7863.0 7876.7 7914.7 7972.2 7977.8 5367.5 5490.9 5557.8 5593.1 5637.4 5298.7 5595.0 5595.4 5686.9 5715.9 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#4] prototype.html Cycles:180 Average:5067.07 Median:5610.98 stddev:1470.60 (26.2%) stddev-sans-first:1431.78 17:19:34 INFO - PROCESS | 5476 | Values: 366.9 367.4 367.6 368.2 370.8 5585.2 5633.9 5722.4 5723.8 5797.5 5603.8 5653.6 5678.7 5691.6 5710.1 4448.3 4453.8 4485.5 4500.2 4535.9 4414.3 4420.4 4451.3 4488.7 4533.8 4363.4 4409.6 4416.4 4417.0 4465.3 4405.0 4424.8 4436.8 4461.2 4490.4 3864.6 4002.0 4011.4 4014.6 4015.9 5549.4 5559.7 5570.8 5571.9 5573.7 5156.4 5174.4 5185.9 5218.8 5263.9 5951.3 6016.3 6021.0 6037.5 6060.5 4429.8 4459.8 4461.8 4466.8 4489.4 6049.2 6213.9 6225.3 6255.7 6305.7 4538.9 4556.9 4570.2 4572.9 4573.7 4627.5 4635.8 4637.2 4639.6 4640.6 4931.4 5196.6 5204.3 5206.4 5217.8 5862.3 6049.2 6072.6 6089.4 6112.0 1596.7 1606.8 1611.2 1619.4 1621.3 1038.4 1039.5 1040.3 1048.5 1060.9 5250.0 5287.4 5300.3 5323.9 5345.7 5581.5 5618.2 5619.7 5622.8 5667.6 5352.0 5406.4 5489.8 5932.6 5933.7 3276.4 3286.9 3295.9 3295.9 3296.6 6222.2 6452.6 6452.9 6455.7 6465.9 6318.1 6322.4 6327.4 6327.8 6331.7 6401.9 6426.9 6471.0 6476.4 6483.4 5875.6 6260.5 6266.7 6267.4 6284.9 6144.9 6169.3 6173.7 6173.8 6186.8 6236.6 6470.3 6478.7 6503.6 6540.5 4422.9 4456.3 4482.9 4490.8 4503.8 5872.2 6069.2 6271.2 6273.4 6305.8 6041.6 6043.4 6055.5 6056.9 6060.5 5976.4 5981.2 6006.3 6012.2 6041.3 5641.2 5940.6 5945.0 5971.9 5975.2 6064.7 6079.5 6082.7 6085.4 6108.3 5759.8 5867.6 5943.6 5960.7 6010.3 17:19:34 INFO - PROCESS | 5476 | 17:19:34 INFO - PROCESS | 5476 | [#5] yui.html Cycles:180 Average:20688.30 Median:4600.95 stddev:29879.84 (649.4%) stddev-sans-first:29926.00 17:19:34 INFO - PROCESS | 5476 | Values: 708.8 715.3 760.7 794.2 838.7 14800.3 14833.0 14856.6 15002.9 15299.8 14387.9 14531.1 14625.9 14723.6 14756.3 872.5 881.3 893.3 906.9 908.5 906.6 910.7 912.6 913.0 914.4 939.0 939.5 940.5 945.5 951.7 936.5 939.6 941.0 942.1 942.3 692.4 693.0 693.1 694.0 694.1 15837.9 15914.0 15945.7 15982.4 16014.3 14898.9 15206.8 15207.0 15433.8 15489.6 11029.9 11101.0 11146.3 11235.9 11242.9 3870.9 3878.9 3889.4 3890.6 3928.5 82714.6 83648.6 84143.2 84379.2 85859.1 10251.6 10626.7 10628.7 10658.1 10690.4 21707.7 21865.9 21877.6 21949.0 22415.4 7766.3 7801.7 8019.6 8043.5 8176.3 4572.4 4582.0 4619.9 4631.0 4648.3 3648.0 3779.2 3813.8 3822.3 3826.5 635.1 639.3 639.8 641.0 642.6 654.2 695.7 709.3 715.4 720.1 8904.2 9062.0 9225.8 9308.1 9352.5 643.6 654.3 664.5 688.4 699.2 4540.5 4547.6 4624.8 4657.7 4659.6 74040.6 113106.4 118623.0 119811.0 120257.4 73218.6 76912.0 94872.5 103547.5 107689.0 88520.6 92601.0 92802.0 93576.0 94490.5 8353.8 8376.9 8476.7 8607.8 8649.9 40344.0 46589.5 49761.5 52552.0 54004.5 58889.0 74587.6 77690.2 77799.6 78545.0 12503.5 12904.0 12932.2 13027.9 13040.5 14649.7 14766.3 15027.3 15114.8 15175.8 13599.2 13804.4 13812.2 14028.4 14056.2 12989.3 13023.7 13025.9 13057.9 13073.3 13296.1 13675.0 13788.4 13876.8 13902.1 11032.8 11464.5 11477.5 11674.6 11811.8 11381.5 11658.9 11691.2 11718.9 11758.4 17:19:34 INFO - PROCESS | 5476 | -------- Summary: end -------- 17:19:34 INFO - PROCESS | 5476 | 17:19:35 INFO - TEST-INFO | 5476: exit 0 17:19:35 INFO - TEST-OK | dromaeo_css | took 1110483ms 17:19:35 INFO - TEST-START | kraken 17:19:35 INFO - operating with platform_type : linux_ 17:19:35 INFO - Initialising browser for kraken test... 17:19:35 INFO - TEST-INFO | started process 5724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKcaqu/profile http://localhost:35144/getInfo.html) 17:19:39 INFO - PROCESS | 5724 | __metrics Screen width/height:1600/1200 17:19:39 INFO - PROCESS | 5724 | colorDepth:24 17:19:39 INFO - PROCESS | 5724 | Browser inner width/height: 1024/697 17:19:39 INFO - PROCESS | 5724 | __metrics 17:19:40 ERROR - PROCESS | 5724 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:19:41 INFO - TEST-INFO | 5724: exit 0 17:19:41 INFO - Browser initialized. 17:19:41 INFO - Running cycle 1/1 for kraken test... 17:19:41 INFO - TEST-INFO | started process 5851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKcaqu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:52 INFO - PROCESS | 5851 | RSS: Main: 153354240 17:19:52 INFO - PROCESS | 5851 | 17:19:55 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:56 INFO - PROCESS | 5851 | RSS: Main: 158396416 17:19:56 INFO - PROCESS | 5851 | 17:19:58 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-dft) 17:19:59 INFO - PROCESS | 5851 | RSS: Main: 157057024 17:19:59 INFO - PROCESS | 5851 | 17:20:02 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-fft) 17:20:03 INFO - PROCESS | 5851 | RSS: Main: 157933568 17:20:03 INFO - PROCESS | 5851 | 17:20:05 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-oscillator) 17:20:05 INFO - PROCESS | 5851 | RSS: Main: 158179328 17:20:05 INFO - PROCESS | 5851 | 17:20:07 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:08 INFO - PROCESS | 5851 | RSS: Main: 157822976 17:20:08 INFO - PROCESS | 5851 | 17:20:11 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:12 INFO - PROCESS | 5851 | RSS: Main: 157040640 17:20:12 INFO - PROCESS | 5851 | 17:20:15 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:16 INFO - PROCESS | 5851 | RSS: Main: 157605888 17:20:16 INFO - PROCESS | 5851 | 17:20:19 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35144/tests/kraken/driver.html?testName=json-parse-financial) 17:20:19 INFO - PROCESS | 5851 | RSS: Main: 158384128 17:20:19 INFO - PROCESS | 5851 | 17:20:21 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:21 INFO - PROCESS | 5851 | RSS: Main: 158203904 17:20:21 INFO - PROCESS | 5851 | 17:20:23 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:24 INFO - PROCESS | 5851 | RSS: Main: 158273536 17:20:24 INFO - PROCESS | 5851 | 17:20:26 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:26 INFO - PROCESS | 5851 | RSS: Main: 158367744 17:20:26 INFO - PROCESS | 5851 | 17:20:29 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:29 INFO - PROCESS | 5851 | RSS: Main: 157958144 17:20:29 INFO - PROCESS | 5851 | 17:20:32 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:33 INFO - PROCESS | 5851 | RSS: Main: 158232576 17:20:33 INFO - PROCESS | 5851 | 17:20:34 INFO - PROCESS | 5851 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35144/tests/kraken/driver.html?testName=ai-astar) 17:20:35 INFO - PROCESS | 5851 | RSS: Main: 158486528 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | __start_tp_report 17:20:35 INFO - PROCESS | 5851 | _x_x_mozilla_page_load 17:20:35 INFO - PROCESS | 5851 | _x_x_mozilla_page_load_details 17:20:35 INFO - PROCESS | 5851 | |i|pagename|runs| 17:20:35 INFO - PROCESS | 5851 | |0;ai-astar;112;106;109;111;114;113;111;110;112;111 17:20:35 INFO - PROCESS | 5851 | |1;audio-beat-detection;152;123;159;174;133;162;161;129;189;124 17:20:35 INFO - PROCESS | 5851 | |2;audio-dft;162;165;163;161;163;171;160;161;162;164 17:20:35 INFO - PROCESS | 5851 | |3;audio-fft;75;75;75;175;78;75;75;74;184;76 17:20:35 INFO - PROCESS | 5851 | |4;audio-oscillator;84;83;150;84;83;85;133;85;84;143 17:20:35 INFO - PROCESS | 5851 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;118;118;118 17:20:35 INFO - PROCESS | 5851 | |6;imaging-darkroom;147;153;147;148;149;149;147;148;146;146 17:20:35 INFO - PROCESS | 5851 | |7;imaging-desaturate;95;95;94;94;96;95;95;95;94;96 17:20:35 INFO - PROCESS | 5851 | |8;json-parse-financial;52;52;56;52;53;55;52;55;52;51 17:20:35 INFO - PROCESS | 5851 | |9;json-stringify-tinderbox;58;59;59;63;59;59;58;61;58;59 17:20:35 INFO - PROCESS | 5851 | |10;stanford-crypto-aes;78;81;77;77;79;77;78;78;108;77 17:20:35 INFO - PROCESS | 5851 | |11;stanford-crypto-ccm;126;132;119;135;117;120;117;135;128;119 17:20:35 INFO - PROCESS | 5851 | |12;stanford-crypto-pbkdf2;161;153;160;151;152;153;161;152;163;155 17:20:35 INFO - PROCESS | 5851 | |13;stanford-crypto-sha256-iterative;61;63;61;63;63;61;61;61;62;59 17:20:35 INFO - PROCESS | 5851 | __end_tp_report 17:20:35 INFO - PROCESS | 5851 | __start_cc_report 17:20:35 INFO - PROCESS | 5851 | _x_x_mozilla_cycle_collect,823 17:20:35 INFO - PROCESS | 5851 | __end_cc_report 17:20:35 INFO - PROCESS | 5851 | __startTimestamp1470270035090__endTimestamp 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | ------- Summary: start ------- 17:20:35 INFO - PROCESS | 5851 | Number of tests: 14 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.23 (2.0%) stddev-sans-first:2.33 17:20:35 INFO - PROCESS | 5851 | Values: 112.0 106.0 109.0 111.0 114.0 113.0 111.0 110.0 112.0 111.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:160.00 stddev:22.55 (14.1%) stddev-sans-first:23.92 17:20:35 INFO - PROCESS | 5851 | Values: 152.0 123.0 159.0 174.0 133.0 162.0 161.0 129.0 189.0 124.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:3.12 (1.9%) stddev-sans-first:3.28 17:20:35 INFO - PROCESS | 5851 | Values: 162.0 165.0 163.0 161.0 163.0 171.0 160.0 161.0 162.0 164.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#3] audio-fft Cycles:10 Average:96.20 Median:75.00 stddev:43.97 (58.6%) stddev-sans-first:45.96 17:20:35 INFO - PROCESS | 5851 | Values: 75.0 75.0 75.0 175.0 78.0 75.0 75.0 74.0 184.0 76.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.00 stddev:28.31 (33.7%) stddev-sans-first:29.32 17:20:35 INFO - PROCESS | 5851 | Values: 84.0 83.0 150.0 84.0 83.0 85.0 133.0 85.0 84.0 143.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:20:35 INFO - PROCESS | 5851 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:2.05 (1.4%) stddev-sans-first:2.15 17:20:35 INFO - PROCESS | 5851 | Values: 147.0 153.0 147.0 148.0 149.0 149.0 147.0 148.0 146.0 146.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 17:20:35 INFO - PROCESS | 5851 | Values: 95.0 95.0 94.0 94.0 96.0 95.0 95.0 95.0 94.0 96.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.50 stddev:1.70 (3.2%) stddev-sans-first:1.76 17:20:35 INFO - PROCESS | 5851 | Values: 52.0 52.0 56.0 52.0 53.0 55.0 52.0 55.0 52.0 51.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:1.57 (2.7%) stddev-sans-first:1.59 17:20:35 INFO - PROCESS | 5851 | Values: 58.0 59.0 59.0 63.0 59.0 59.0 58.0 61.0 58.0 59.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:78.00 stddev:9.57 (12.3%) stddev-sans-first:10.09 17:20:35 INFO - PROCESS | 5851 | Values: 78.0 81.0 77.0 77.0 79.0 77.0 78.0 78.0 108.0 77.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.00 stddev:7.33 (5.8%) stddev-sans-first:7.76 17:20:35 INFO - PROCESS | 5851 | Values: 126.0 132.0 119.0 135.0 117.0 120.0 117.0 135.0 128.0 119.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:157.50 stddev:4.61 (2.9%) stddev-sans-first:4.53 17:20:35 INFO - PROCESS | 5851 | Values: 161.0 153.0 160.0 151.0 152.0 153.0 161.0 152.0 163.0 155.0 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - PROCESS | 5851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.27 (2.1%) stddev-sans-first:1.33 17:20:35 INFO - PROCESS | 5851 | Values: 61.0 63.0 61.0 63.0 63.0 61.0 61.0 61.0 62.0 59.0 17:20:35 INFO - PROCESS | 5851 | -------- Summary: end -------- 17:20:35 INFO - PROCESS | 5851 | 17:20:35 INFO - TEST-INFO | 5851: exit 0 17:20:36 INFO - TEST-OK | kraken | took 60947ms 17:20:36 INFO - SUITE-END | took 1171s 17:20:36 INFO - Completed test suite (00:19:31) 17:20:36 INFO - javascript benchmark 17:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7631.222355381372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.022728522372, 3432.0, 3450.1374656335925, 3465.4282043462813, 3471.87848425305, 5721.713914304284, 5728.6562806231605, 5758.078707406816, 5783.306003279612, 5809.506191973687, 5755.798547050854, 5798.188253644493, 5824.563157763164, 5827.329857066438, 5859.501942334896, 5104.05574968631, 5165.509276618715, 5204.947950520503, 5252.894942101156, 5260.289860868791, 5135.35808023997, 5146.305248791421, 5246.632735708502, 5253.395859476152, 5257.789688412478, 5106.821261255856, 5163.251328557357, 5187.014467251229, 5213.426523082458, 5279.076161671692, 5212.400573934008, 5230.032443997872, 5280.313559237313, 5300.708461034642, 5313.681179129265, 5195.324607801, 5214.0, 5267.683938963636, 5287.391949925731, 5289.845687929002, 5451.754671039813, 5528.198411230349, 5532.419095994903, 5534.4742249486635, 5582.665040097567, 6088.595852493199, 6095.512359011268, 6119.624418755179, 6161.4146656067605, 6184.907226391608, 6223.973044447661, 6235.844103897393, 6236.844078898019, 6245.843853903643, 6254.437100660917, 5591.8881622367735, 5745.425457454263, 5804.59367844251, 5805.767769289266, 5848.0, 6388.297287298394, 6409.4231519163495, 6418.935810641927, 6444.097826304321, 6451.451626611697, 6070.605410648293, 6156.353582873823, 6189.938100619026, 6190.978488549339, 6201.441870231701, 5994.67029313392, 6141.048137538689, 6215.409536094064, 6249.96875015622, 6279.152314437584, 6165.568410211242, 6168.814935551941, 6175.783847565313, 6205.751769929243, 6206.131141640174, 6185.783497577563, 6202.596831205957, 6221.3778622138325, 6224.128621992924, 6230.59501132425, 4645.837395691135, 4651.348811166439, 4681.578657920803, 4701.130290896127, 4709.222978208626, 4190.638042636156, 4214.831406743696, 4224.070704445017, 4250.0, 4251.213525497793, 5764.365919748824, 5928.970355148197, 5958.46373826349, 5961.970190149022, 5989.79035733756, 6049.455549000611, 6125.815438131368, 6140.749659041545, 6182.752689892354, 6207.379262073847, 5961.701914904237, 5962.761489540369, 5998.7300571473515, 6013.51891848651, 6015.0676645120075, 5194.3247377840635, 5349.277847490617, 5358.946410535923, 5359.062164121263, 5381.973090134525, 6375.23497180332, 6397.328280530477, 6405.19935008124, 6522.249941256721, 6524.478041756648, 6286.622802631857, 6293.905591416133, 6299.370062993664, 6307.36926307384, 6311.116443697794, 6142.999999999821, 6251.6874156292915, 6538.215414150332, 6559.7376104955265, 6569.638669873012, 5995.040793473024, 6107.6640784757265, 6112.1995365628145, 6115.694215289129, 6138.5396095292135, 6164.815055548341, 6210.347913469202, 6218.689065546795, 6224.688765561613, 6225.750969961332, 5846.6784326862435, 6029.3669164737075, 6043.576949613484, 6047.969760151347, 6055.273367195965, 6036.0, 6088.269407671108, 6096.993995990611, 6103.938960610337, 6135.417135372132, 6001.2498437695285, 6024.698765061642, 6032.306284777307, 6050.878982420415, 6067.757289708539, 5734.770609175586, 5822.039363504974, 5825.126231065374, 5910.852228694317, 6171.259448866164, 5748.48263656273, 5754.194412782297, 5759.0, 5759.424057594207, 5760.423957604206], "value": 5697.965815357421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3313772006493, 654.5156584127745, 658.3021996683519, 669.9933000669994, 680.2924958043635, 41811.79094104529, 45577.0, 46285.76857115714, 46319.0, 46420.999999999956, 45721.54278457214, 46805.297920531135, 46814.531854681445, 46822.53177468224, 46908.0, 8921.821563568725, 9093.636254549843, 9095.909040909606, 9100.317476189279, 9127.634894604207, 8940.552972351388, 8970.416922900024, 9009.684661036865, 9042.869641294837, 9053.637854485845, 8860.24687901529, 8878.911210887905, 8885.333599979995, 8893.0, 8937.73186804397, 8879.467231966102, 8945.597448114786, 8957.686480973167, 8970.775730606754, 8980.730578082668, 8902.465852048897, 9007.279417646572, 9007.414518056305, 9008.099190081006, 9012.729618111467, 41675.58324416778, 41969.37045944313, 41990.16019679589, 41999.0, 42040.579594204275, 3510.052285882797, 3613.8193090345376, 3643.6720695137565, 3661.3226553087766, 3934.0558266016237, 33246.50130248048, 33315.500267496005, 33479.6652033479, 34086.829565852015, 34322.48516272258, 3838.2323535293053, 3838.347480928249, 3846.442265871433, 3853.8843834685003, 3877.6510114089583, 385913.0, 388434.0, 388557.0, 389444.0, 389482.0, 65704.34295657078, 66254.33745662482, 66304.6684766573, 66325.6683716588, 66416.33583664101, 40369.39445908314, 40605.59394406077, 40972.79513602413, 42988.355174672404, 43112.56887431148, 19113.808861911482, 19185.424437266905, 19414.417567473, 19431.0, 19490.415287541397, 14449.927750361181, 14543.20012399307, 14618.707625847423, 14632.19522926228, 14656.120632761855, 21983.890080549816, 22077.0, 22084.227052053102, 22199.779012154486, 22211.66682499764, 7678.308952194217, 7711.26742959418, 7830.960845195737, 7884.0, 7978.880316795136, 1049.8530205771199, 1089.2593036734938, 1175.8706542280343, 1178.7465694875643, 1188.8216767484773, 33407.665923340945, 33456.66543334584, 33696.83151584226, 33714.325713485596, 33902.49146262808, 1157.739508610556, 1179.151011271883, 1179.7935361311736, 1231.2920070959235, 1243.0118056145386, 17343.3062677494, 17602.11989400525, 17623.118844057746, 17807.376741814234, 17844.55388615295, 568493.0, 580300.0, 580337.0, 587029.0, 588591.0, 61005.694971524856, 61481.0, 61639.0, 61751.69124154351, 61924.38075619186, 1529.8852586055868, 1539.961500962485, 1558.1741676911256, 1565.1235308227429, 1586.7064593050322, 31466.52800207953, 31576.526352105197, 32003.199920002186, 32233.194170145933, 32599.18502037468, 53745.19382209192, 54472.45527544674, 54497.45502545082, 54544.0, 54550.18174727462, 408045.0, 410786.0, 412217.0, 413322.0, 414980.0, 30192.84903575556, 30421.543676845307, 30945.535816963213, 30955.0713478596, 31069.378612427172, 48903.75548122237, 48927.26609100795, 48957.0, 49531.75234123806, 49864.75067624639, 40974.59025409708, 41218.0, 41568.0, 41872.0, 42897.35653965255, 40652.39021414622, 41786.0, 42185.789071054445, 42279.577204227564, 42826.0, 41246.58753412427, 41526.0, 41554.0, 42340.576594234895, 42412.575874240865, 34879.302413952086, 35006.47490287597, 35341.0, 35628.82185589056, 35847.64152358443, 27771.583426249028, 28174.2956426091, 28344.14967550977, 28355.57466637961, 28424.715752842207], "value": 20831.87364737437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.77278269734325, 428.17148817039015, 430.75016490435553, 434.2639226511063, 441.69743725548, 18789.0, 19600.50998725031, 20381.49046273842, 20442.2845200418, 20465.079071441785, 18835.058247087658, 18866.339678111235, 19528.121234544444, 19724.901375493104, 19739.0, 5588.944110558903, 5788.623739456922, 5800.390958949313, 5806.390329015456, 5806.767729290823, 5585.385607583163, 5727.34135574408, 5728.971355143219, 5763.135529670562, 5788.6237394569425, 5706.258186435757, 5740.942590574083, 5741.397153298906, 5747.971260143693, 5756.107803290476, 5530.861728456801, 5692.146178073281, 5722.942770572304, 5729.770809167629, 5735.569832262576, 5123.1546794778815, 5155.61332900034, 5163.612729045337, 5188.792448302063, 5192.428832828424, 22523.211687591018, 23032.193873214357, 23549.29352119439, 23656.763432365628, 23781.405464863343, 2216.9224077157382, 2233.039792889057, 2275.6017696902977, 2566.2814411964678, 2801.033643393026, 14900.850991490055, 14905.925470372578, 14956.850431495655, 15190.164540950243, 15323.0, 1863.0870873272, 1904.277899016474, 1904.9142788574547, 1912.1395372082618, 1914.4065339744723, 78110.6094469524, 78117.60941195258, 78228.60885695535, 79317.20682793156, 80344.19655803425, 10907.563697452013, 11175.105991520659, 11233.438328083726, 11262.549498019987, 11508.712282192844, 15696.76454853178, 15750.68498630021, 15787.763183552255, 15797.68404631901, 15805.446809361618, 8859.335549833659, 8884.777880553038, 8957.14907083839, 9019.503927283931, 9131.680391186277, 8849.469031858109, 8857.158569935846, 8886.86669699955, 8939.910600893907, 8994.685186018458, 6967.303269672992, 6972.4073453757, 7074.752383666547, 7109.964450177716, 7117.252688467636, 1980.7127966444784, 2001.8198362147477, 2015.1435639853005, 2025.7062725904661, 2041.428400047989, 1062.3519653011656, 1065.616378103882, 1083.3554035348955, 1136.363636363639, 1213.7269114449177, 18588.535286617673, 18722.344717934808, 19393.806061939482, 19567.510812229524, 19760.60478790416, 1025.7128004158847, 1054.1303424674675, 1058.7088550648634, 1059.9576016959236, 1064.7799338379411, 10217.795644087077, 10474.423906685206, 10543.84184237237, 10548.261621686563, 10649.627263045757, 382806.0, 386884.0, 388827.0, 522642.0, 548587.0, 101195.37448567794, 102532.0, 106301.46849265705, 106815.46592266989, 106872.0, 1095.9616413425492, 1101.730076131353, 1114.3258328711013, 1135.1769966773857, 1135.2961164078158, 17434.73847892308, 17496.91251543785, 17529.56176095608, 17657.82342176613, 17903.0, 40464.59535404726, 41070.0, 42248.5775142257, 42550.0, 43166.352504711824, 56082.0, 56957.43042569687, 59760.10359844693, 60017.39982600118, 61829.690851545456, 8130.674773009014, 8263.256306932404, 8304.335653147855, 8361.0, 8428.0, 11524.654260372203, 12752.171108877894, 12775.23348599087, 12797.872021279669, 12934.288614126313, 8215.712450064219, 11008.669739907815, 11161.0, 11303.773924521627, 11361.715957100809, 11105.555777768799, 11234.55061797519, 11275.605353812578, 11405.828912566483, 11541.538338466704, 11416.31502109876, 11540.192186547198, 11670.0, 12035.45840437165, 12120.696982575506, 8176.877346839921, 8187.79530511742, 8218.671253149807, 8311.542865142475, 8314.293285070837, 10786.352818830896, 10957.287776294515, 11330.60342887995, 11337.773244535229, 11448.084153267886], "value": 9521.065852184236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1552.2859484637067, 1604.4625050608047, 1855.2300795170006, 1929.7008963610645, 1975.8913259770716, 8643.0924752901, 9338.579763910624, 9440.527973601327, 10024.39853608783, 10031.699049028522, 9487.051294870527, 9766.951165244182, 9769.70690879273, 9816.361936474124, 9869.309148359618, 2512.397024714069, 2555.0, 2556.987215063922, 2557.1177943609423, 2557.884895179712, 2450.9754902451014, 2518.848869067862, 2519.0301733832516, 2522.5963845784677, 2527.166035208386, 2493.164789795421, 2525.053105085593, 2556.2586849813624, 2557.6035714464288, 2570.4345044090364, 2474.072222916406, 2482.751724827521, 2488.6267059940974, 2525.393905462694, 2530.367408147963, 2401.2556107606697, 2415.1546958564536, 2415.3961509622595, 2436.1595249638845, 2483.242611003643, 9791.853122203172, 9898.703038908845, 9912.752181195456, 9913.107820296136, 9921.355111917703, 5797.855053623651, 5952.285725712899, 5955.166276721263, 5959.761609535613, 5961.672108034057, 3590.4075827488696, 3598.802065886375, 3634.527511423498, 3701.3707669695946, 3795.3737633290475, 1119.149446420718, 1132.5356603792488, 1168.6669299249759, 1198.4726720243152, 1207.0584943743893, 13723.588292351245, 13744.381502832397, 13753.587392378144, 13768.105073170213, 13772.10481318721, 5097.108006098918, 5120.846374608767, 5137.588992880561, 5248.317718696621, 5270.894582108336, 11571.826422603668, 11606.129540284512, 11615.070794336432, 11647.30116193031, 11655.708607284716, 5858.121281807677, 5933.703314834241, 5934.851628709231, 5937.0, 5938.465538101592, 4760.619150467955, 5118.411382690963, 5341.732913354394, 5354.41101478837, 5417.322834645669, 4375.343698445258, 4426.557344265548, 4486.2597671383855, 4495.977520112444, 4563.06457176278, 1403.6631208509884, 1425.3942074618453, 1438.9352479138463, 1446.1395469695515, 1448.2903377345026, 822.3626689315709, 888.2716172738421, 962.6197651927449, 1003.4781913404988, 1005.5726316315537, 6100.267967843798, 6242.531810114259, 6309.652969086653, 6341.619502829845, 6372.235331760218, 482.57051224410304, 484.9054434385261, 488.81180745413275, 490.0590865538175, 496.53573908395765, 4115.855945041909, 4312.956870431255, 4314.935275970863, 4316.6546676265825, 4317.00708836963, 11935.224210426295, 12241.265524068584, 12257.448414821354, 12275.0, 12327.383630818424, 11206.21556491054, 11638.243514171721, 11653.766924661459, 11825.645230643095, 11910.52357905674, 8950.776230594158, 9222.44665320083, 9239.260859131253, 9263.536823158815, 9264.722058338395, 6477.190351206099, 6681.498887583548, 6740.730370785113, 6784.3554862288, 6906.896396554156, 10755.838662419914, 11028.0, 11069.944650276697, 11078.11375090007, 11182.888171118184, 11001.61494347694, 11004.504797283982, 11290.15323850698, 11314.773704526027, 11316.37759923212, 8450.492970421794, 8667.263282621048, 8685.522296273766, 8694.0, 8757.299416046573, 9530.618775248913, 9570.95214523923, 9591.760205994906, 9641.614335426504, 9655.324127311022, 8378.162183781573, 8601.82796344082, 8646.351523635878, 8731.869021964803, 8774.56127193625, 8356.206160414751, 8398.202170793766, 8431.030431500456, 8432.747017589481, 8683.348748843988, 7863.017122859643, 7876.72431464896, 7914.722984695508, 7972.202779721982, 7977.760667179994, 5367.463253674601, 5490.862728431821, 5557.777688892399, 5593.0771422716425, 5637.408072152365, 5298.7350632469, 5594.9720251398485, 5595.384507704068, 5686.914696279642, 5715.885682286248], "value": 4985.274268618472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9376206044972, 367.35162438296396, 367.6470588235295, 368.17345060339534, 370.82385866713315, 5585.245991791107, 5633.943660563393, 5722.427757224275, 5723.771049158034, 5797.478226959578, 5603.80386686466, 5653.604247702662, 5678.744456499458, 5691.573132015105, 5710.1434784782305, 4448.266036104039, 4453.755043472608, 4485.461744590653, 4500.189965806154, 4535.931961020588, 4414.3378493225955, 4420.359047938063, 4451.332300154971, 4488.685791994561, 4533.750643714594, 4363.410939523155, 4409.603135717784, 4416.425864637608, 4416.984093658461, 4465.307877279027, 4404.977975110136, 4424.84513042042, 4436.800343984496, 4461.24158892989, 4490.371348011281, 3864.555576108727, 4001.979990100031, 4011.438398624195, 4014.6149578395407, 4015.859444919414, 5549.38956714761, 5559.749811258503, 5570.805021824257, 5571.860703482445, 5573.749181286852, 5156.432792392834, 5174.3790745110455, 5185.870353241162, 5218.765155568009, 5263.894722105575, 5951.3219051426595, 6016.308124565643, 6020.96989515054, 6037.54718396122, 6060.515158787331, 4429.75966729313, 4459.754713490756, 4461.754603496806, 4466.821327146943, 4489.416375871116, 6049.153118563405, 6213.875722485525, 6225.260885210493, 6255.717577896566, 6305.653189074599, 4538.931916021263, 4556.88607784808, 4570.223062079454, 4572.9314060289125, 4573.6569757268335, 4627.514111018362, 4635.814567417266, 4637.188492013952, 4639.559241872017, 4640.605548528413, 4931.358923340014, 5196.558292545176, 5204.297419848348, 5206.3752349717515, 5217.808520421357, 5862.267216597926, 6049.1833602463985, 6072.6336574270435, 6089.360617135226, 6111.960966635683, 1596.6806638672313, 1606.7991501062368, 1611.1944027986008, 1619.4170098764434, 1621.3057355063986, 1038.3665963762098, 1039.4906495816995, 1040.2770074798093, 1048.4600430778155, 1060.8886066963012, 5250.0, 5287.391949925731, 5300.284461597635, 5323.893522129536, 5345.705986170798, 5581.5255703265675, 5618.162827771949, 5619.7471113799975, 5622.803201887914, 5667.631603945731, 5351.973240133852, 5406.378266499403, 5489.807856724996, 5932.584719069624, 5933.6736479493175, 3276.410246155667, 3286.9342613147605, 3295.8516866740574, 3295.9011229663147, 3296.587926509186, 6222.191115155001, 6452.612843229421, 6452.935470645328, 6455.677216139175, 6465.870682586322, 6318.08387783778, 6322.3561873912195, 6327.430531252209, 6327.797718433483, 6331.683415829282, 6401.911675015259, 6426.935730642727, 6471.0, 6476.352364763486, 6483.448906842971, 5875.588708790515, 6260.467860231749, 6266.655333956493, 6267.373262673878, 6284.874302514016, 6144.938550614615, 6169.290531588925, 6173.6913154343, 6173.84565385869, 6186.752529898754, 6236.594621349598, 6470.288268290578, 6478.6760661967655, 6503.642299673564, 6540.50946179029, 4422.933655995098, 4456.2647163219, 4482.8879278017, 4490.820367185276, 4503.842365517191, 5872.1778950947755, 6069.150318955438, 6271.209311856363, 6273.435390814849, 6305.8108256752375, 6041.6375017499095, 6043.425874541911, 6055.485283750931, 6056.9091463628965, 6060.484858786876, 5976.372480889444, 5981.162637230704, 6006.33930267679, 6012.218411606463, 6041.305249896318, 5641.238432811682, 5940.61386009908, 5944.970275148597, 5971.940280597139, 5975.16347711312, 6064.666443345658, 6079.513638908788, 6082.749382728419, 6085.391460853879, 6108.267007958895, 5759.769609215585, 5867.618604790846, 5943.64338139713, 5960.701964901824, 6010.287068185547], "value": 4604.502198397488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.7519368221126, 715.2561336210341, 760.6501009535614, 794.249434284601, 838.6729175621507, 14800.259987000647, 14833.0, 14856.55430337089, 15002.924985375057, 15299.84700152998, 14387.856121438783, 14531.055481393701, 14625.853741462583, 14723.631909202275, 14756.335964881579, 872.4939535069644, 881.2861582118488, 893.2630579771682, 906.8866391701038, 908.5275656658566, 906.60109551797, 910.6721580231111, 912.6121398405684, 912.9817403651923, 914.419343716738, 938.9530523473833, 939.5302348825587, 940.5203346293371, 945.5366870233605, 951.7335146159052, 936.4989730494153, 939.6476321379482, 941.0495399646338, 942.0532364973158, 942.29328003997, 692.4322055914153, 692.9826754331132, 693.1093544794915, 693.9757108501178, 694.1080711285973, 15837.92081039599, 15914.0, 15945.681086378323, 15982.360705571764, 16014.279357428944, 14898.851011489854, 15206.771898421532, 15207.0, 15433.845661543353, 15489.612759680986, 11029.944850275697, 11101.0, 11146.275492092987, 11235.887641123565, 11242.887571124347, 3870.8838734838, 3878.8514955413543, 3889.397143442771, 3890.5914878937588, 3928.508936382952, 82714.58642706748, 83648.58175709083, 84143.15856841415, 84379.15620843774, 85859.14140858637, 10251.58993640246, 10626.73433164177, 10628.734281643021, 10658.094062004817, 10690.35857848516, 21707.674384884238, 21865.890670546545, 21877.562448750938, 21949.0, 22415.43961400978, 7766.330238998642, 7801.726939557088, 8019.5990200490905, 8043.517388956681, 8176.3458923286, 4572.359869618256, 4582.0, 4619.9076018479445, 4631.0, 4648.302754586839, 3647.9635203648154, 3779.2063666629765, 3813.828377723009, 3822.2928758179823, 3826.5025546678753, 635.1171871099176, 639.338284875152, 639.8432384065934, 641.0288413054227, 642.5534253693638, 654.2312782480566, 695.7495301691387, 709.2729951799447, 715.3919168706661, 720.0962791696387, 8904.154105359981, 9062.04848490912, 9225.769355766159, 9308.069193080773, 9352.53237338144, 643.5784561112479, 654.3162395296927, 664.5315052887703, 688.404530081486, 699.1610067918518, 4540.500544940054, 4547.567981041796, 4624.791884365211, 4657.650676199299, 4659.5573420525, 74040.62979685175, 113106.43446782713, 118623.0, 119811.0, 120257.39871300763, 73218.63390683013, 76912.0, 94872.52563737275, 103547.4822625897, 107689.0, 88520.5573972126, 92601.0, 92802.0, 93576.0, 94490.52754736182, 8353.83292334162, 8376.916230837858, 8476.660933562589, 8607.784805379915, 8649.8702519461, 40344.0, 46589.53410465988, 49761.50238497713, 52552.0, 54004.459955401515, 58889.0, 74587.62706186435, 77690.22309777056, 77799.61100194464, 78545.0, 12503.499860005499, 12904.0, 12932.224066556037, 13027.934860326017, 13040.54358097462, 14649.707005860037, 14766.261686915397, 15027.323770430576, 15114.829625345164, 15175.848241517444, 13599.184048957095, 13804.447822087004, 13812.240326782123, 14028.438862445388, 14056.226907520184, 12989.28558929268, 13023.739525209254, 13025.934870325587, 13057.869421305666, 13073.346332683517, 13296.135751176143, 13675.0, 13788.379522921292, 13876.791848122488, 13902.096363736326, 11032.84859452399, 11464.484098215433, 11477.483513241757, 11674.649760507198, 11811.82282265784, 11381.47174375946, 11658.88341116578, 11691.240069395462, 11718.941405292919, 11758.412079396167], "value": 7612.362658842145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 109.0, 111.0, 114.0, 113.0, 111.0, 110.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 159.0, 174.0, 133.0, 162.0, 161.0, 129.0, 189.0, 124.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 161.0, 163.0, 171.0, 160.0, 161.0, 162.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 175.0, 78.0, 75.0, 75.0, 74.0, 184.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 150.0, 84.0, 83.0, 85.0, 133.0, 85.0, 84.0, 143.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 153.0, 147.0, 148.0, 149.0, 149.0, 147.0, 148.0, 146.0, 146.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 52.0, 53.0, 55.0, 52.0, 55.0, 52.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 63.0, 59.0, 59.0, 58.0, 61.0, 58.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 77.0, 77.0, 79.0, 77.0, 78.0, 78.0, 108.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 119.0, 135.0, 117.0, 120.0, 117.0, 135.0, 128.0, 119.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 153.0, 160.0, 151.0, 152.0, 153.0, 161.0, 152.0, 163.0, 155.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 63.0, 63.0, 61.0, 61.0, 61.0, 62.0, 59.0], "value": 61.5, "unit": "score"}]}]} 17:20:36 INFO - Return code: 0 17:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:36 ERROR - # TBPL SUCCESS # 17:20:36 INFO - Running post-action listener: _resource_record_post_action 17:20:36 INFO - ##### 17:20:36 INFO - ##### Finished run-tests step (success) 17:20:36 INFO - ##### 17:20:36 INFO - Running post-run listener: _resource_record_post_run 17:20:36 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 36864; Write bytes: 455938048; Read time: 192; Write time: 394136 17:20:36 INFO - TinderboxPrint: CPU usage
13.3% 17:20:36 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 192 17:20:36 INFO - TinderboxPrint: I/O write bytes / time
455,938,048 / 394,136 17:20:36 INFO - TinderboxPrint: CPU idle
8,201.8 (86.7%) 17:20:36 INFO - TinderboxPrint: CPU user
1,207.7 (12.8%) 17:20:36 INFO - TinderboxPrint: Swap in / out
0 / 0 17:20:36 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 8192; Write bytes: 235069440; Read time: 164; Write time: 231692 17:20:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220098560; Read time: 16; Write time: 162416 17:20:37 INFO - Running post-run listener: _upload_blobber_files 17:20:37 INFO - Blob upload gear active. 17:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:37 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 17:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:38 INFO - (blobuploader) - INFO - Done attempting. 17:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:41 INFO - (blobuploader) - INFO - Done attempting. 17:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:42 INFO - (blobuploader) - INFO - Done attempting. 17:20:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:42 INFO - Return code: 0 17:20:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/905a28c3677916ea6e5fc89682a10d4558eb02e11fe47c1545b0f71208b4169678f3b8d52795216ff3ba97165fc1d5408278855df2f4cef086d8e16c036ce3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b5f9866439fd06cadc44904ef093b97297bb29f843f501d4b708e740254dbc7e31a572761a3e03c6c369112060687bc1e5031cb798cf20e5ceeaede58b1c7f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fc856c84f8aba7ddbf6d2a9ace41e391bfaee08f5cc0370cd4da2f9330c76b5888557dea9dd02f3a793d149325ecadd0196a3b6c316cb9d82ec79fb42a2586f"} 17:20:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:42 INFO - Contents: 17:20:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/905a28c3677916ea6e5fc89682a10d4558eb02e11fe47c1545b0f71208b4169678f3b8d52795216ff3ba97165fc1d5408278855df2f4cef086d8e16c036ce3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b5f9866439fd06cadc44904ef093b97297bb29f843f501d4b708e740254dbc7e31a572761a3e03c6c369112060687bc1e5031cb798cf20e5ceeaede58b1c7f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fc856c84f8aba7ddbf6d2a9ace41e391bfaee08f5cc0370cd4da2f9330c76b5888557dea9dd02f3a793d149325ecadd0196a3b6c316cb9d82ec79fb42a2586f"} 17:20:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:42 INFO - Copying logs to upload dir... 17:20:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.301624 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-03 17:20:42.182798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 17:20:42.186923) ========= 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=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/905a28c3677916ea6e5fc89682a10d4558eb02e11fe47c1545b0f71208b4169678f3b8d52795216ff3ba97165fc1d5408278855df2f4cef086d8e16c036ce3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b5f9866439fd06cadc44904ef093b97297bb29f843f501d4b708e740254dbc7e31a572761a3e03c6c369112060687bc1e5031cb798cf20e5ceeaede58b1c7f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fc856c84f8aba7ddbf6d2a9ace41e391bfaee08f5cc0370cd4da2f9330c76b5888557dea9dd02f3a793d149325ecadd0196a3b6c316cb9d82ec79fb42a2586f"} build_url:https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/LChz6s2kRyKFkbbmOma38w/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/905a28c3677916ea6e5fc89682a10d4558eb02e11fe47c1545b0f71208b4169678f3b8d52795216ff3ba97165fc1d5408278855df2f4cef086d8e16c036ce3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b5f9866439fd06cadc44904ef093b97297bb29f843f501d4b708e740254dbc7e31a572761a3e03c6c369112060687bc1e5031cb798cf20e5ceeaede58b1c7f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fc856c84f8aba7ddbf6d2a9ace41e391bfaee08f5cc0370cd4da2f9330c76b5888557dea9dd02f3a793d149325ecadd0196a3b6c316cb9d82ec79fb42a2586f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 17:20:42.212469) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:20:42.212811) ========= 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=836cfdc75598d54cb747368e000001a9-1470268647.113778-121607236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:20:42.295387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 17:20:42.295721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 17:20:42.296090) ========= ========= Total master_lag: 0.18 =========